builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0220 starttime: 1493223518.58 results: success (0) buildid: 20170426080225 builduid: 7bf14681b199442ead82c89c4617f651 revision: a477e80f03b61be9961bc61770a2b55cce139b91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:38.580385) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:38.580846) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:38.581131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:38.608192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:38.608550) ========= 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.iNUMD1ajdr/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.5FveZRr1V9/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-26 09:18:38-- 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% 28.7M=0s 2017-04-26 09:18:38 (28.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.218762 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:38.852553) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:38.852893) ========= 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.iNUMD1ajdr/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.5FveZRr1V9/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.027047 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:38.903670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-26 09:18:38.904031) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a477e80f03b61be9961bc61770a2b55cce139b91 --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 a477e80f03b61be9961bc61770a2b55cce139b91 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iNUMD1ajdr/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.5FveZRr1V9/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-26 09:18:39,010 truncating revision to first 12 chars 2017-04-26 09:18:39,010 Setting DEBUG logging. 2017-04-26 09:18:39,010 attempt 1/10 2017-04-26 09:18:39,010 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a477e80f03b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-26 09:18:39,717 unpacking tar archive at: mozilla-central-a477e80f03b6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.989024 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-26 09:18:39.917801) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:39.918368) ========= script_repo_revision: a477e80f03b61be9961bc61770a2b55cce139b91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:39.919060) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:39.919614) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-26 09:18:39.940933) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-26 09:18:39.941356) ========= /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.iNUMD1ajdr/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.5FveZRr1V9/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:18:40 INFO - MultiFileLogger online at 20170426 09:18:40 in /builds/slave/test 09:18:40 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 09:18:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:18:40 INFO - {'append_to_log': False, 09:18:40 INFO - 'base_work_dir': '/builds/slave/test', 09:18:40 INFO - 'blob_upload_branch': 'Firefox', 09:18:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:18:40 INFO - 'branch': 'Firefox', 09:18:40 INFO - 'buildbot_json_path': 'buildprops.json', 09:18:40 INFO - 'config_files': ('talos/mac_config.py',), 09:18:40 INFO - 'default_actions': ('clobber', 09:18:40 INFO - 'read-buildbot-config', 09:18:40 INFO - 'download-and-extract', 09:18:40 INFO - 'populate-webroot', 09:18:40 INFO - 'create-virtualenv', 09:18:40 INFO - 'install', 09:18:40 INFO - 'run-tests'), 09:18:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:18:40 INFO - 'download_minidump_stackwalk': True, 09:18:40 INFO - 'download_symbols': 'ondemand', 09:18:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:18:40 INFO - 'tooltool.py': '/tools/tooltool.py', 09:18:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:18:40 INFO - '/tools/misc-python/virtualenv.py')}, 09:18:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:18:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:18:40 INFO - 'gecko_profile': False, 09:18:40 INFO - 'gecko_profile_interval': 0, 09:18:40 INFO - 'installer_path': 'installer.exe', 09:18:40 INFO - 'log_level': 'info', 09:18:40 INFO - 'log_name': 'talos', 09:18:40 INFO - 'log_to_console': True, 09:18:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:18:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:18:40 INFO - 'opt_config_files': (), 09:18:40 INFO - 'pip_index': False, 09:18:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:18:40 INFO - 'cmd': ('bash', 09:18:40 INFO - '-c', 09:18:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:18:40 INFO - 'enabled': True, 09:18:40 INFO - 'halt_on_failure': False, 09:18:40 INFO - 'name': 'check_screen_resolution'},), 09:18:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:18:40 INFO - 'cmd': ('bash', 09:18:40 INFO - '-c', 09:18:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:18:40 INFO - 'enabled': True, 09:18:40 INFO - 'halt_on_failure': False, 09:18:40 INFO - 'name': 'check_screen_resolution'},), 09:18:40 INFO - 'run_cmd_checks_enabled': True, 09:18:40 INFO - 'suite': 'dromaeojs-e10s', 09:18:40 INFO - 'system_bits': '32', 09:18:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:18:40 INFO - 'title': 't-yosemite-r7-0220', 09:18:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:18:40 INFO - 'use_talos_json': True, 09:18:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:18:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:18:40 INFO - 'work_dir': 'build'} 09:18:40 INFO - [mozharness: 2017-04-26 16:18:40.156950Z] Running clobber step. 09:18:40 INFO - Running pre-action listener: _resource_record_pre_action 09:18:40 INFO - Running main action method: clobber 09:18:40 INFO - rmtree: /builds/slave/test/build 09:18:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:18:42 INFO - Running post-action listener: _resource_record_post_action 09:18:42 INFO - [mozharness: 2017-04-26 16:18:42.593631Z] Finished clobber step (success) 09:18:42 INFO - [mozharness: 2017-04-26 16:18:42.593764Z] Running read-buildbot-config step. 09:18:42 INFO - Running pre-action listener: _resource_record_pre_action 09:18:42 INFO - Running main action method: read_buildbot_config 09:18:42 INFO - Using buildbot properties: 09:18:42 INFO - { 09:18:42 INFO - "project": "", 09:18:42 INFO - "product": "firefox", 09:18:42 INFO - "script_repo_revision": "production", 09:18:42 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:18:42 INFO - "repository": "", 09:18:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:18:42 INFO - "buildid": "20170426080225", 09:18:42 INFO - "pgo_build": "False", 09:18:42 INFO - "basedir": "/builds/slave/test", 09:18:42 INFO - "buildnumber": 43, 09:18:42 INFO - "slavename": "t-yosemite-r7-0220", 09:18:42 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 09:18:42 INFO - "platform": "yosemite_r7", 09:18:42 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:18:42 INFO - "branch": "mozilla-central", 09:18:42 INFO - "repo_path": "mozilla-central", 09:18:42 INFO - "revision": "a477e80f03b61be9961bc61770a2b55cce139b91", 09:18:42 INFO - "stage_platform": "macosx64", 09:18:42 INFO - "builduid": "7bf14681b199442ead82c89c4617f651", 09:18:42 INFO - "slavebuilddir": "test" 09:18:42 INFO - } 09:18:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:18:42 INFO - Running post-action listener: _resource_record_post_action 09:18:42 INFO - [mozharness: 2017-04-26 16:18:42.597089Z] Finished read-buildbot-config step (success) 09:18:42 INFO - [mozharness: 2017-04-26 16:18:42.597210Z] Running download-and-extract step. 09:18:42 INFO - Running pre-action listener: _resource_record_pre_action 09:18:42 INFO - Running main action method: download_and_extract 09:18:42 INFO - mkdir: /builds/slave/test/build/tests 09:18: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')]} 09:18:42 INFO - trying https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:18:42 INFO - Downloading https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/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 09:18:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/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 09:18:43 INFO - Downloaded 1325 bytes. 09:18:43 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:18:43 INFO - Using the following test package requirements: 09:18:43 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:43 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:18:43 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:18:43 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:43 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:18:43 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:43 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:18:43 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:43 INFO - u'jsshell-mac.zip'], 09:18:43 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:43 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:18:43 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:18:43 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:43 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:18:43 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:43 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:18:43 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:43 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:18:43 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:18:43 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:18:43 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:18:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:18:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:18:43 INFO - Fetch https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:18:45 INFO - Content-Length response header: 52527133 09:18:45 INFO - Bytes received: 52527133 09:19:01 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 09:19:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:19:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:19:01 INFO - Fetch https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:19:03 INFO - Content-Length response header: 52527133 09:19:03 INFO - Bytes received: 52527133 09:19:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:19:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:19:18 INFO - Fetch https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:19:20 INFO - Content-Length response header: 14408809 09:19:20 INFO - Bytes received: 14408809 09:19:21 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')]} 09:19:21 INFO - trying https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:19:21 INFO - Downloading https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:19:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/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 09:19:23 INFO - Downloaded 71207359 bytes. 09:19:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:19:23 INFO - mkdir: /builds/slave/test/properties 09:19:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:19:23 INFO - Writing to file /builds/slave/test/properties/build_url 09:19:23 INFO - Contents: 09:19:23 INFO - build_url:https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:19:23 INFO - Running post-action listener: _resource_record_post_action 09:19:23 INFO - Running post-action listener: set_extra_try_arguments 09:19:23 INFO - [mozharness: 2017-04-26 16:19:23.881834Z] Finished download-and-extract step (success) 09:19:23 INFO - [mozharness: 2017-04-26 16:19:23.881931Z] Running populate-webroot step. 09:19:23 INFO - Running pre-action listener: _resource_record_pre_action 09:19:23 INFO - Running main action method: populate_webroot 09:19:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:19:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:19:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:19:23 INFO - '--tppagecycles', 09:19:23 INFO - '7'], 09:19:23 INFO - 'tests': ['tsvgm']}}, 09:19:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:19:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:19:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:19:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:19:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:19:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:19:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:19:23 INFO - 'talos_options': ['--disable-e10s'], 09:19:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:19:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:19:23 INFO - 'talos_options': ['--disable-e10s'], 09:19:23 INFO - 'tests': ['damp', 'tps']}, 09:19:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:19:23 INFO - 'tests': ['damp', 'tps']}, 09:19:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:19:23 INFO - 'tests': ['dromaeo_dom']}, 09:19:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:19:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:19:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:19:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:19:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:19:23 INFO - 'tests': ['a11yr', 09:19:23 INFO - 'ts_paint', 09:19:23 INFO - 'tpaint', 09:19:23 INFO - 'sessionrestore', 09:19:23 INFO - 'sessionrestore_no_auto_restore', 09:19:23 INFO - 'tabpaint']}, 09:19:23 INFO - 'other-e10s': {'tests': ['a11yr', 09:19:23 INFO - 'ts_paint', 09:19:23 INFO - 'tpaint', 09:19:23 INFO - 'sessionrestore', 09:19:23 INFO - 'sessionrestore_no_auto_restore', 09:19:23 INFO - 'tabpaint']}, 09:19:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:19:23 INFO - 'ts_paint', 09:19:23 INFO - 'tpaint', 09:19:23 INFO - 'sessionrestore', 09:19:23 INFO - 'sessionrestore_no_auto_restore', 09:19:23 INFO - 'tabpaint']}, 09:19:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:19:23 INFO - 'ts_paint', 09:19:23 INFO - 'tpaint', 09:19:23 INFO - 'sessionrestore', 09:19:23 INFO - 'sessionrestore_no_auto_restore', 09:19:23 INFO - 'tabpaint']}, 09:19:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:19:23 INFO - 'tests': ['a11yr', 09:19:23 INFO - 'ts_paint', 09:19:23 INFO - 'tpaint', 09:19:23 INFO - 'sessionrestore', 09:19:23 INFO - 'sessionrestore_no_auto_restore', 09:19:23 INFO - 'tabpaint']}, 09:19:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:19:23 INFO - 'tests': ['a11yr', 09:19:23 INFO - 'ts_paint', 09:19:23 INFO - 'tpaint', 09:19:23 INFO - 'sessionrestore', 09:19:23 INFO - 'sessionrestore_no_auto_restore', 09:19:23 INFO - 'tabpaint']}, 09:19:23 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:19:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:19:23 INFO - 'bloom_basic_ref']}, 09:19:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:19:23 INFO - 'tests': ['tsvgx', 09:19:23 INFO - 'tsvgr_opacity', 09:19:23 INFO - 'tart', 09:19:23 INFO - 'tscrollx', 09:19:23 INFO - 'cart', 09:19:23 INFO - 'tsvg_static']}, 09:19:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:19:23 INFO - 'tsvgr_opacity', 09:19:23 INFO - 'tart', 09:19:23 INFO - 'tscrollx', 09:19:23 INFO - 'cart', 09:19:23 INFO - 'tsvg_static']}, 09:19:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:19:23 INFO - 'talos_options': ['--disable-e10s'], 09:19:23 INFO - 'tests': ['tp5o']}, 09:19:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:19:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:19:23 INFO - 'talos_options': ['--disable-e10s', 09:19:23 INFO - '--xperf_path', 09:19:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:23 INFO - 'tests': ['tp5n']}, 09:19:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:19:23 INFO - 'talos_options': ['--xperf_path', 09:19:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:23 INFO - 'tests': ['tp5n']}}, 09:19:23 INFO - 'talos.zip': {'path': '', 09:19:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:19:23 INFO - Running post-action listener: _resource_record_post_action 09:19:23 INFO - [mozharness: 2017-04-26 16:19:23.900980Z] Finished populate-webroot step (success) 09:19:23 INFO - [mozharness: 2017-04-26 16:19:23.901111Z] Running create-virtualenv step. 09:19:23 INFO - Running pre-action listener: _resource_record_pre_action 09:19:23 INFO - Running main action method: create_virtualenv 09:19:23 INFO - Creating virtualenv /builds/slave/test/build/venv 09:19:23 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 09:19:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:19:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:19:24 INFO - Using real prefix '/tools/python27' 09:19:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:19:24 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:27 INFO - Installing pip.................done. 09:19:27 INFO - Return code: 0 09:19:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:19:27 INFO - Reading from file tmpfile_stdout 09:19:27 INFO - Output received: 09:19:27 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) 09:19:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1006acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8cb69f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048ad30>, '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 0x1003b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10047fbe8>, '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.iNUMD1ajdr/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.5FveZRr1V9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:19:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:19:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iNUMD1ajdr/Render', 09:19:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:27 INFO - 'HOME': '/Users/cltbld', 09:19:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:27 INFO - 'LOGNAME': 'cltbld', 09:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:27 INFO - 'MOZ_NO_REMOTE': '1', 09:19:27 INFO - 'NO_EM_RESTART': '1', 09:19:27 INFO - 'PAGER': '/bin/cat', 09:19:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:27 INFO - 'PWD': '/builds/slave/test', 09:19:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:27 INFO - 'SHELL': '/bin/bash', 09:19:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FveZRr1V9/Listeners', 09:19:27 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:19:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:27 INFO - 'USER': 'cltbld', 09:19:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:27 INFO - 'XPC_FLAGS': '0x0', 09:19:27 INFO - 'XPC_SERVICE_NAME': '0', 09:19:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:28 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 09:19:28 INFO - Cleaning up... 09:19:28 INFO - Return code: 0 09:19:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1006acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8cb69f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048ad30>, '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 0x1003b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10047fbe8>, '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.iNUMD1ajdr/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.5FveZRr1V9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:19:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iNUMD1ajdr/Render', 09:19:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:28 INFO - 'HOME': '/Users/cltbld', 09:19:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:28 INFO - 'LOGNAME': 'cltbld', 09:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:28 INFO - 'MOZ_NO_REMOTE': '1', 09:19:28 INFO - 'NO_EM_RESTART': '1', 09:19:28 INFO - 'PAGER': '/bin/cat', 09:19:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:28 INFO - 'PWD': '/builds/slave/test', 09:19:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:28 INFO - 'SHELL': '/bin/bash', 09:19:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FveZRr1V9/Listeners', 09:19:28 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:19:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:28 INFO - 'USER': 'cltbld', 09:19:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:28 INFO - 'XPC_FLAGS': '0x0', 09:19:28 INFO - 'XPC_SERVICE_NAME': '0', 09:19:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:28 INFO - Downloading/unpacking psutil>=3.1.1 09:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:32 INFO - Installing collected packages: psutil 09:19:32 INFO - Running setup.py install for psutil 09:19:32 INFO - building 'psutil._psutil_osx' extension 09:19:32 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 09:19:32 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 09:19:32 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 09:19:32 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 09:19:32 INFO - building 'psutil._psutil_posix' extension 09:19:32 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 09:19:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:19:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:19:32 INFO - ^ 09:19:33 INFO - 1 warning generated. 09:19:33 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 09:19:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:33 INFO - Successfully installed psutil 09:19:33 INFO - Cleaning up... 09:19:33 INFO - Return code: 0 09:19:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:33 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 0x1006acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8cb69f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048ad30>, '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 0x1003b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10047fbe8>, '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.iNUMD1ajdr/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.5FveZRr1V9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:19:33 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 09:19:33 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 09:19:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iNUMD1ajdr/Render', 09:19:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:33 INFO - 'HOME': '/Users/cltbld', 09:19:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:33 INFO - 'LOGNAME': 'cltbld', 09:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:33 INFO - 'MOZ_NO_REMOTE': '1', 09:19:33 INFO - 'NO_EM_RESTART': '1', 09:19:33 INFO - 'PAGER': '/bin/cat', 09:19:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:33 INFO - 'PWD': '/builds/slave/test', 09:19:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:33 INFO - 'SHELL': '/bin/bash', 09:19:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FveZRr1V9/Listeners', 09:19:33 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:19:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:33 INFO - 'USER': 'cltbld', 09:19:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:33 INFO - 'XPC_FLAGS': '0x0', 09:19:33 INFO - 'XPC_SERVICE_NAME': '0', 09:19:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:19:33 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 09:19:33 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 09:19:33 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 09:19:33 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 09:19:33 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 09:19:33 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 09:19:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:19:36 INFO - Installing collected packages: mozsystemmonitor 09:19:36 INFO - Running setup.py install for mozsystemmonitor 09:19:36 INFO - Successfully installed mozsystemmonitor 09:19:36 INFO - Cleaning up... 09:19:36 INFO - Return code: 0 09:19:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:37 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 0x1006acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8cb69f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048ad30>, '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 0x1003b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10047fbe8>, '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.iNUMD1ajdr/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.5FveZRr1V9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:19:37 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 09:19:37 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 09:19:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iNUMD1ajdr/Render', 09:19:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:37 INFO - 'HOME': '/Users/cltbld', 09:19:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:37 INFO - 'LOGNAME': 'cltbld', 09:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:37 INFO - 'MOZ_NO_REMOTE': '1', 09:19:37 INFO - 'NO_EM_RESTART': '1', 09:19:37 INFO - 'PAGER': '/bin/cat', 09:19:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:37 INFO - 'PWD': '/builds/slave/test', 09:19:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:37 INFO - 'SHELL': '/bin/bash', 09:19:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FveZRr1V9/Listeners', 09:19:37 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:19:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:37 INFO - 'USER': 'cltbld', 09:19:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:37 INFO - 'XPC_FLAGS': '0x0', 09:19:37 INFO - 'XPC_SERVICE_NAME': '0', 09:19:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:37 INFO - Downloading/unpacking jsonschema==2.5.1 09:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:19:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:19:40 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 09:19:40 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 09:19:40 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 09:19:40 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 09:19:40 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 09:19:40 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 09:19:41 INFO - Downloading functools32-3.2.3-2.tar.gz 09:19:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:19:41 INFO - warning: no files found matching '*.txt' 09:19:41 INFO - no previously-included directories found matching 'build' 09:19:41 INFO - no previously-included directories found matching 'dist' 09:19:41 INFO - no previously-included directories found matching '.git*' 09:19:41 INFO - Installing collected packages: jsonschema, functools32 09:19:41 INFO - Running setup.py install for functools32 09:19:41 INFO - warning: no files found matching '*.txt' 09:19:41 INFO - no previously-included directories found matching 'build' 09:19:41 INFO - no previously-included directories found matching 'dist' 09:19:41 INFO - no previously-included directories found matching '.git*' 09:19:41 INFO - Successfully installed jsonschema functools32 09:19:41 INFO - Cleaning up... 09:19:41 INFO - Return code: 0 09:19:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:19:41 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')]} 09:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:41 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')]} 09:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:41 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 0x1006acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8cb69f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048ad30>, '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 0x1003b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10047fbe8>, '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.iNUMD1ajdr/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.5FveZRr1V9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:19:41 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 09:19:41 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 09:19:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iNUMD1ajdr/Render', 09:19:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:41 INFO - 'HOME': '/Users/cltbld', 09:19:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:41 INFO - 'LOGNAME': 'cltbld', 09:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:41 INFO - 'MOZ_NO_REMOTE': '1', 09:19:41 INFO - 'NO_EM_RESTART': '1', 09:19:41 INFO - 'PAGER': '/bin/cat', 09:19:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:41 INFO - 'PWD': '/builds/slave/test', 09:19:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:41 INFO - 'SHELL': '/bin/bash', 09:19:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FveZRr1V9/Listeners', 09:19:41 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:19:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:41 INFO - 'USER': 'cltbld', 09:19:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:41 INFO - 'XPC_FLAGS': '0x0', 09:19:41 INFO - 'XPC_SERVICE_NAME': '0', 09:19:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:19:41 INFO - Cleaning up... 09:19:41 INFO - Return code: 0 09:19:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:19:41 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')]} 09:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:41 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')]} 09:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:41 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 0x1006acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8cb69f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048ad30>, '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 0x1003b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10047fbe8>, '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.iNUMD1ajdr/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.5FveZRr1V9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:19:41 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 09:19:41 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 09:19:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iNUMD1ajdr/Render', 09:19:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:41 INFO - 'HOME': '/Users/cltbld', 09:19:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:41 INFO - 'LOGNAME': 'cltbld', 09:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:41 INFO - 'MOZ_NO_REMOTE': '1', 09:19:41 INFO - 'NO_EM_RESTART': '1', 09:19:41 INFO - 'PAGER': '/bin/cat', 09:19:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:41 INFO - 'PWD': '/builds/slave/test', 09:19:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:41 INFO - 'SHELL': '/bin/bash', 09:19:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FveZRr1V9/Listeners', 09:19:41 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:19:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:41 INFO - 'USER': 'cltbld', 09:19:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:41 INFO - 'XPC_FLAGS': '0x0', 09:19:41 INFO - 'XPC_SERVICE_NAME': '0', 09:19:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:41 INFO - Downloading/unpacking blobuploader==1.2.4 09:19:41 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 09:19:41 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 09:19:41 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 09:19:41 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 09:19:41 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 09:19:41 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 09:19:44 INFO - Downloading blobuploader-1.2.4.tar.gz 09:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:19:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:19:44 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 09:19:44 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 09:19:44 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 09:19:44 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 09:19:44 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 09:19:44 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 09:19:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:19:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:45 INFO - Downloading docopt-0.6.1.tar.gz 09:19:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:19:45 INFO - Installing collected packages: blobuploader, requests, docopt 09:19:45 INFO - Running setup.py install for blobuploader 09:19:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:19:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:19:46 INFO - Running setup.py install for requests 09:19:46 INFO - Running setup.py install for docopt 09:19:46 INFO - Successfully installed blobuploader requests docopt 09:19:46 INFO - Cleaning up... 09:19:46 INFO - Return code: 0 09:19:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:46 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')]} 09:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:46 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')]} 09:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:46 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 0x1006acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8cb69f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048ad30>, '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 0x1003b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10047fbe8>, '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.iNUMD1ajdr/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.5FveZRr1V9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:19:46 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 09:19:46 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 09:19:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iNUMD1ajdr/Render', 09:19:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:46 INFO - 'HOME': '/Users/cltbld', 09:19:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:46 INFO - 'LOGNAME': 'cltbld', 09:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:46 INFO - 'MOZ_NO_REMOTE': '1', 09:19:46 INFO - 'NO_EM_RESTART': '1', 09:19:46 INFO - 'PAGER': '/bin/cat', 09:19:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:46 INFO - 'PWD': '/builds/slave/test', 09:19:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:46 INFO - 'SHELL': '/bin/bash', 09:19:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FveZRr1V9/Listeners', 09:19:46 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:19:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:46 INFO - 'USER': 'cltbld', 09:19:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:46 INFO - 'XPC_FLAGS': '0x0', 09:19:46 INFO - 'XPC_SERVICE_NAME': '0', 09:19:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-BdzpMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-9PC99f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-G4jLBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Rv0MKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-rbdTc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-LCZcDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-S1PJM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-yZhwyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Ji0CpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-dZgTOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-cJHiyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-h0plO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-3IQ_OY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-4PnaPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-EsvnHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-GdAHnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-TYZcx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:19:48 INFO - Running setup.py install for manifestparser 09:19:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:19:49 INFO - Running setup.py install for mozcrash 09:19:49 INFO - Running setup.py install for mozdebug 09:19:49 INFO - Running setup.py install for mozdevice 09:19:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:19:49 INFO - Running setup.py install for mozfile 09:19:49 INFO - Running setup.py install for mozhttpd 09:19:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:19:49 INFO - Running setup.py install for mozinfo 09:19:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:19:49 INFO - Running setup.py install for mozInstall 09:19:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:19:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:19:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:19:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:19:50 INFO - Running setup.py install for mozleak 09:19:50 INFO - Running setup.py install for mozlog 09:19:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:19:50 INFO - Running setup.py install for moznetwork 09:19:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:19:50 INFO - Running setup.py install for mozprocess 09:19:50 INFO - Running setup.py install for mozprofile 09:19:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:19:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:19:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:19:50 INFO - Running setup.py install for mozrunner 09:19:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:19:51 INFO - Running setup.py install for mozscreenshot 09:19:51 INFO - Running setup.py install for moztest 09:19:51 INFO - Running setup.py install for mozversion 09:19:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:19:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:19:51 INFO - Cleaning up... 09:19:51 INFO - Return code: 0 09:19:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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')]} 09:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:51 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 0x1006acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8cb69f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048ad30>, '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 0x1003b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10047fbe8>, '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.iNUMD1ajdr/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.5FveZRr1V9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:19:51 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 09:19:51 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 09:19:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iNUMD1ajdr/Render', 09:19:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:51 INFO - 'HOME': '/Users/cltbld', 09:19:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:51 INFO - 'LOGNAME': 'cltbld', 09:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:51 INFO - 'MOZ_NO_REMOTE': '1', 09:19:51 INFO - 'NO_EM_RESTART': '1', 09:19:51 INFO - 'PAGER': '/bin/cat', 09:19:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:51 INFO - 'PWD': '/builds/slave/test', 09:19:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:51 INFO - 'SHELL': '/bin/bash', 09:19:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FveZRr1V9/Listeners', 09:19:51 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:19:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:51 INFO - 'USER': 'cltbld', 09:19:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:51 INFO - 'XPC_FLAGS': '0x0', 09:19:51 INFO - 'XPC_SERVICE_NAME': '0', 09:19:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:51 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-8hxvGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:51 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)) 09:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:51 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-4suoEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:51 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)) 09:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:51 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-6k7xKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:52 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)) 09:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-zcpBAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:52 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)) 09:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-BBTJeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:52 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)) 09:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-4ga9TC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:52 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)) 09:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-F5jhK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:52 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)) 09:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-pwq21R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:52 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)) 09:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-NYHfN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:52 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)) 09:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-atNdY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:52 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)) 09:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-v9mvv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:52 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)) 09:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-2XM8mA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:53 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)) 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-1Zg5ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:53 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)) 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-QqDFZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:53 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)) 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-HohKm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:53 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)) 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-gWjFW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:53 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)) 09:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-6aWmP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:53 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)) 09:19:53 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)) 09:19:53 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)) 09:19:53 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)) 09:19:53 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)) 09:19:53 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)) 09:19:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:56 INFO - Downloading blessings-1.6.tar.gz 09:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:19:56 INFO - Installing collected packages: blessings 09:19:56 INFO - Running setup.py install for blessings 09:19:56 INFO - Successfully installed blessings 09:19:56 INFO - Cleaning up... 09:19:56 INFO - Return code: 0 09:19:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:19:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:56 INFO - Reading from file tmpfile_stdout 09:19:56 INFO - Current package versions: 09:19:56 INFO - blessings == 1.6 09:19:56 INFO - blobuploader == 1.2.4 09:19:56 INFO - docopt == 0.6.1 09:19:56 INFO - functools32 == 3.2.3-2 09:19:56 INFO - jsonschema == 2.5.1 09:19:56 INFO - manifestparser == 1.1 09:19:56 INFO - mozInstall == 1.12 09:19:56 INFO - mozcrash == 1.0 09:19:56 INFO - mozdebug == 0.1 09:19:56 INFO - mozdevice == 0.50 09:19:56 INFO - mozfile == 1.2 09:19:56 INFO - mozhttpd == 0.7 09:19:56 INFO - mozinfo == 0.9 09:19:56 INFO - mozleak == 0.1 09:19:56 INFO - mozlog == 3.4 09:19:56 INFO - moznetwork == 0.27 09:19:56 INFO - mozprocess == 0.25 09:19:56 INFO - mozprofile == 0.28 09:19:56 INFO - mozrunner == 6.13 09:19:56 INFO - mozscreenshot == 0.1 09:19:56 INFO - mozsystemmonitor == 0.3 09:19:56 INFO - moztest == 0.8 09:19:56 INFO - mozversion == 1.4 09:19:56 INFO - psutil == 3.1.1 09:19:56 INFO - requests == 1.2.3 09:19:56 INFO - wsgiref == 0.1.2 09:19:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:56 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')]} 09:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:56 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')]} 09:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:56 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 0x1006acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8cb69f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048ad30>, '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 0x1003b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10047fbe8>, '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.iNUMD1ajdr/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.5FveZRr1V9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:19:56 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 09:19:56 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 09:19:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iNUMD1ajdr/Render', 09:19:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:56 INFO - 'HOME': '/Users/cltbld', 09:19:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:56 INFO - 'LOGNAME': 'cltbld', 09:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:56 INFO - 'MOZ_NO_REMOTE': '1', 09:19:56 INFO - 'NO_EM_RESTART': '1', 09:19:56 INFO - 'PAGER': '/bin/cat', 09:19:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:56 INFO - 'PWD': '/builds/slave/test', 09:19:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:56 INFO - 'SHELL': '/bin/bash', 09:19:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FveZRr1V9/Listeners', 09:19:56 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:19:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:56 INFO - 'USER': 'cltbld', 09:19:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:56 INFO - 'XPC_FLAGS': '0x0', 09:19:56 INFO - 'XPC_SERVICE_NAME': '0', 09:19:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:57 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)) 09:19:57 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)) 09:19:57 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)) 09:19:57 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)) 09:19:57 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)) 09:19:57 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)) 09:19:57 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)) 09:19:57 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)) 09:19:57 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)) 09:19:57 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)) 09:19:57 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)) 09:19:57 INFO - Cleaning up... 09:19:57 INFO - Return code: 0 09:19:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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')]} 09:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:57 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 0x1006acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8f8cb69f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048ad30>, '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 0x1003b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10047fbe8>, '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.iNUMD1ajdr/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.5FveZRr1V9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:19:57 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 09:19:57 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 09:19:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iNUMD1ajdr/Render', 09:19:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:57 INFO - 'HOME': '/Users/cltbld', 09:19:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:57 INFO - 'LOGNAME': 'cltbld', 09:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:57 INFO - 'MOZ_NO_REMOTE': '1', 09:19:57 INFO - 'NO_EM_RESTART': '1', 09:19:57 INFO - 'PAGER': '/bin/cat', 09:19:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:57 INFO - 'PWD': '/builds/slave/test', 09:19:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:57 INFO - 'SHELL': '/bin/bash', 09:19:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FveZRr1V9/Listeners', 09:19:57 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:19:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:57 INFO - 'USER': 'cltbld', 09:19:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:57 INFO - 'XPC_FLAGS': '0x0', 09:19:57 INFO - 'XPC_SERVICE_NAME': '0', 09:19:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:19:57 INFO - Cleaning up... 09:19:57 INFO - Return code: 0 09:19:57 INFO - Running post-action listener: _resource_record_post_action 09:19:57 INFO - Running post-action listener: _start_resource_monitoring 09:19:57 INFO - Starting resource monitoring. 09:19:57 INFO - [mozharness: 2017-04-26 16:19:57.409365Z] Finished create-virtualenv step (success) 09:19:57 INFO - [mozharness: 2017-04-26 16:19:57.410386Z] Running install step. 09:19:57 INFO - Running pre-action listener: _resource_record_pre_action 09:19:57 INFO - Running main action method: install 09:19:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:57 INFO - Reading from file tmpfile_stdout 09:19:57 INFO - Detecting whether we're running mozinstall >=1.0... 09:19:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:19:57 INFO - Reading from file tmpfile_stdout 09:19:57 INFO - Output received: 09:19:57 INFO - Usage: mozinstall [options] installer 09:19:57 INFO - Options: 09:19:57 INFO - -h, --help show this help message and exit 09:19:57 INFO - -d DEST, --destination=DEST 09:19:57 INFO - Directory to install application into. [default: 09:19:57 INFO - "/builds/slave/test"] 09:19:57 INFO - --app=APP Application being installed. [default: firefox] 09:19:57 INFO - mkdir: /builds/slave/test/build/application 09:19:57 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'] 09:19:57 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 09:20:17 INFO - Reading from file tmpfile_stdout 09:20:17 INFO - Output received: 09:20:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:20:17 INFO - Running post-action listener: _resource_record_post_action 09:20:17 INFO - [mozharness: 2017-04-26 16:20:17.392775Z] Finished install step (success) 09:20:17 INFO - [mozharness: 2017-04-26 16:20:17.392910Z] Running run-tests step. 09:20:17 INFO - Running pre-action listener: _resource_record_pre_action 09:20:17 INFO - Running main action method: run_tests 09:20:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:20:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:20:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:20:17 INFO - 2017-04-26 09:20:17.407 screenresolution[1625:7582] starting screenresolution argv=screenresolution get 09:20:17 INFO - 2017-04-26 09:20:17.410 screenresolution[1625:7582] Display 0: 1600x1200x32@60 09:20:17 INFO - 2017-04-26 09:20:17.415 screenresolution[1626:7585] starting screenresolution argv=screenresolution list 09:20:17 INFO - Available Modes on Display 0 09:20:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:20:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:20:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:20:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:20:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:20:17 INFO - Intel Iris: 09:20:17 INFO - Chipset Model: Intel Iris 09:20:17 INFO - Type: GPU 09:20:17 INFO - Bus: Built-In 09:20:17 INFO - VRAM (Dynamic, Max): 1536 MB 09:20:17 INFO - Vendor: Intel (0x8086) 09:20:17 INFO - Device ID: 0x0a2e 09:20:17 INFO - Revision ID: 0x0009 09:20:17 INFO - Displays: 09:20:17 INFO - Display: 09:20:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:20:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:20:17 INFO - Display Serial Number: 1600x1200 60 09:20:17 INFO - Main Display: Yes 09:20:17 INFO - Mirror: Off 09:20:17 INFO - Online: Yes 09:20:17 INFO - Rotation: Supported 09:20:17 INFO - Return code: 0 09:20:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:20:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:20:17 INFO - Python 2.7.3 09:20:17 INFO - Return code: 0 09:20:17 INFO - grabbing minidump binary from tooltool 09:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:17 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 0x10048ad30>, '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 0x1003b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10047fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:20:17 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 09:20:17 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 09:20:17 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 09:20:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:20:17 INFO - Return code: 0 09:20:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:20:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:20:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:20:17 INFO - ENV: RUST_BACKTRACE is now 1 09:20:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:20:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:20:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--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 09:20:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0220 --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 09:20:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iNUMD1ajdr/Render', 09:20:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:17 INFO - 'HOME': '/Users/cltbld', 09:20:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:17 INFO - 'LOGNAME': 'cltbld', 09:20:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:20:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:17 INFO - 'MOZ_NO_REMOTE': '1', 09:20:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:20:17 INFO - 'NO_EM_RESTART': '1', 09:20:17 INFO - 'PAGER': '/bin/cat', 09:20:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:17 INFO - 'PWD': '/builds/slave/test', 09:20:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:20:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:17 INFO - 'RUST_BACKTRACE': '1', 09:20:17 INFO - 'SHELL': '/bin/bash', 09:20:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FveZRr1V9/Listeners', 09:20:17 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:20:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:17 INFO - 'USER': 'cltbld', 09:20:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:17 INFO - 'XPC_FLAGS': '0x0', 09:20:17 INFO - 'XPC_SERVICE_NAME': '0', 09:20:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--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 09:20:18 INFO - mozversion application_buildid: 20170426080225 09:20:18 INFO - mozversion application_changeset: a477e80f03b61be9961bc61770a2b55cce139b91 09:20:18 INFO - mozversion application_display_name: Nightly 09:20:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:20:18 INFO - mozversion application_name: Firefox 09:20:18 INFO - mozversion application_remotingname: firefox 09:20:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:20:18 INFO - mozversion application_vendor: Mozilla 09:20:18 INFO - mozversion application_version: 55.0a1 09:20:18 INFO - mozversion platform_buildid: 20170426080225 09:20:18 INFO - mozversion platform_changeset: a477e80f03b61be9961bc61770a2b55cce139b91 09:20:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:20:18 INFO - mozversion platform_version: 55.0a1 09:20:18 INFO - using testdate: 1493223618 09:20:18 INFO - actual date: 1493223618 09:20:18 INFO - starting webserver on 'localhost:49244' 09:20:18 INFO - SUITE-START | Running 2 tests 09:20:18 INFO - TEST-START | dromaeo_css 09:20:18 INFO - operating with platform_type : mac_ 09:20:18 INFO - Initialising browser for dromaeo_css test... 09:20:18 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpYfLN5N/profile http://localhost:49244/getInfo.html) 09:20:21 INFO - PID 1636 | 2017-04-26 09:20:21.014 plugin-container[1638:7768] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9743, name = 'com.apple.tsm.portname' 09:20:21 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:20:21 INFO - PID 1636 | 2017-04-26 09:20:21.017 plugin-container[1638:7768] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x990f, name = 'com.apple.CFPasteboardClient' 09:20:21 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:20:21 INFO - PID 1636 | 2017-04-26 09:20:21.017 plugin-container[1638:7768] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:20:21 INFO - PID 1636 | __metrics Screen width/height:1600/1200 09:20:21 INFO - PID 1636 | colorDepth:24 09:20:21 INFO - PID 1636 | Browser inner width/height: 1024/689 09:20:21 INFO - PID 1636 | __metrics 09:20:21 ERROR - PID 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 09:20:21 INFO - TEST-INFO | 1636: exit 0 09:20:21 INFO - Browser initialized. 09:20:21 INFO - Running cycle 1/1 for dromaeo_css test... 09:20:21 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpYfLN5N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:24 INFO - PID 1639 | 2017-04-26 09:20:24.424 plugin-container[1640:7903] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 09:20:24 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:20:24 INFO - PID 1639 | 2017-04-26 09:20:24.425 plugin-container[1640:7903] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 09:20:24 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:20:24 INFO - PID 1639 | 2017-04-26 09:20:24.425 plugin-container[1640:7903] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:20:34 INFO - PID 1639 | RSS: Main: 235810816 09:20:34 INFO - PID 1639 | 09:23:36 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 09:23:38 INFO - PID 1639 | RSS: Main: 251301888 09:23:38 INFO - PID 1639 | 09:25:22 INFO - PID 1639 | ************************* 09:25:22 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 09:25:22 INFO - PID 1639 | 09:25:22 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:25:22 INFO - PID 1639 | Full stack: 09:25:22 INFO - PID 1639 | ************************* 09:25:22 INFO - PID 1639 | ************************* 09:25:22 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 09:25:22 INFO - PID 1639 | 09:25:22 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:25:22 INFO - PID 1639 | Full stack: 09:25:22 INFO - PID 1639 | ************************* 09:25:22 INFO - PID 1639 | ************************* 09:25:22 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 09:25:22 INFO - PID 1639 | 09:25:22 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:25:22 INFO - PID 1639 | Full stack: 09:25:22 INFO - PID 1639 | ************************* 09:25:22 INFO - PID 1639 | ************************* 09:25:22 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 09:25:22 INFO - PID 1639 | 09:25:22 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:25:22 INFO - PID 1639 | Full stack: 09:25:22 INFO - PID 1639 | ************************* 09:26:40 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 09:26:41 INFO - PID 1639 | RSS: Main: 257888256 09:26:41 INFO - PID 1639 | 09:29:42 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 09:29:43 INFO - PID 1639 | RSS: Main: 267472896 09:29:43 INFO - PID 1639 | 09:32:45 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 09:32:45 INFO - PID 1639 | RSS: Main: 260067328 09:32:45 INFO - PID 1639 | 09:35:48 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 09:35:49 INFO - PID 1639 | RSS: Main: 268599296 09:35:49 INFO - PID 1639 | 09:38:50 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 09:38:51 INFO - PID 1639 | RSS: Main: 264056832 09:38:51 INFO - PID 1639 | 09:38:51 INFO - PID 1639 | __start_tp_report 09:38:51 INFO - PID 1639 | _x_x_mozilla_page_load 09:38:51 INFO - PID 1639 | _x_x_mozilla_page_load_details 09:38:51 INFO - PID 1639 | |i|pagename|runs| 09:38:51 INFO - PID 1639 | |0;dojo.html;3535.611082780892;3547.4324108142696;3586.623404542523;3586.892393228204;3604.5674519057716;4848.63635227358;5907.822765317042;5959.433853783884;6141;6156.261248650163;6069.757209711617;6106.053561697933;6121.14813855746;6125.081237814319;6144.508439324854;4516.390287311204;5248.580113590903;5352.598555108363;5384.057789886774;5415.916816636669;5304.469553044684;5378.542823859977;5452.536534394561;5452.59105567082;5491.066518691812;5415.296011518517;5439.456054394568;5463.836084917459;5501.614886957915;5507.201455788908;5222.3472065991755;5310.867228319323;5324.7071411072375;5333.146696528575;5357.491038351351;5313.495217954288;5333.679979201222;5349.331333583302;5374.355077390699;5425.538829199523;5023.949760502384;5814.47669709724;6143.508519318444;6152.6308421494405;6160.229971253593;6531.608103513804;6547.738090476375;6557.639329836857;6561.2782593914635;6565;6362.331955144689;6453.83865403364;6660.100886380374;6703.765368212089;6715.294894036105;4892.486288939645;5409;5789.04480760674;6111.144439778434;6290.779822706229;6788.490863185182;6823.454123670094;6861.965690171517;6870.553414028072;6876.277990810893;5038.79844806211;6297;6360.363963603602;6390.4248617624635;6514.088027676129;5480.835574932758;6629.370209830058;6654.534182607171;6698.531102822755;6700.396964273142;6545.181852268466;6579.80260592183;6586.506012049115;6588.374104460165;6598.43913267368;5597.244372009726;6259.843503912348;6370.394812492806;6531.836704082436;6647.102641143384;5238.71187084714;5263.157894736901;5267.236250743621;5274.472552744694;5277.868053298698;4610.492845786961;4649.767511624405;4661.86014419568;4684.765761711901;4701.083288758659;6071.271447426248;6085.817425477154;6255.624662520263;6263.6241825490615;6273.215848018997;5543.362513311021;5740.856478587985;6467.547271690936;6589.439897608757;6649.667516624149;5507.678157242233;5884.8771530647;6238.719257633417;6277.18396608438;6302.401271879165;5803.5357171426185;5821.446962538552;5826.096954971986;5832.533397328289;5838.5329173666005;6505.251896031922;6777.627230502271;6785.558938668971;6847;6858.177018757781;6637.070810086495;6718.294579069127;6727;6731.216227699566;6772.695228714818;6564.376384243489;6658.866822663616;6722.428593569602;6807.421369183675;6883.105196324646;6542.247641521096;6587.077809106825;6621.768238111643;6626.4367528760595;6635.303293154149;6659.101021362054;6681.398674119353;6709.027191057367;6723.932760672331;6729.865402692017;6211;6264.310925798068;6317.305096439296;6411.198600174978;6421.229452465734;6385.553011289165;6397.488200944006;6420.1974753155855;6433.8713225736155;6456.7740129095255;6222.906656400067;6269.749210031548;6345.873082538231;6353.396427339396;6384.968075159781;6203.7828675996125;6287.748490060347;6367.299597044229;6438.7746428876635;6451.516136289703;5251.264822924717;6231.937680623317;6293.118963345227;6307.96846015767;6312.4634406076 09:38:51 INFO - PID 1639 | |1;ext.html;673.7434684313756;816.4733746733357;837.7026155714722;1276.3044140943184;1285.421560297866;32257.19357016073;38357.23285534291;40132.79601611953;40202.39696404556;40288.798556007176;39463.60536394635;39470.80264598673;39692;39865.20269594606;39982.60017399825;8101.878471822913;8234.958825205895;8765.517896515688;8940.910590894073;8967.641294348217;8767.079456657055;8805.119488051176;8895.154960278764;8896.733098007071;8903.421277616933;8871.645134194625;8901.421407608485;8915.866262006075;8944.10558944107;8947.64209431622;8857.557122143899;8869;8870.2016818486;8893.466392016435;8913.821723565557;8710.041895391501;8761.342899282516;8779.56102194894;8779.604917778715;8788.560571971377;38812.61187388146;38856;39157.41263881044;39167.804160979016;39342;3608.2422691234874;3627.836747346376;3640.9635903640888;3647.434647629622;3652.0322114639644;30983.53524697109;31024.0692779217;31100.68899311023;31150.532742008887;31234;3114.3304189599116;3152;3161.3203161320425;3172.524121381788;3179.1893067267697;282217;284052.57973710203;291790;296555.99999999785;297817;46235.30647040297;48581.757091215026;48676.26985595219;48750.756246218545;48804.26793598099;43169.92075198145;50968.94186348831;51504.74247628813;51516.48483515192;53759.73120134374;14474.782878256834;14532.709345813024;14591.562253132422;14602.707945841024;14631;11886;11930.582429615095;11952.103592230618;11975.58085467022;12020.939895300467;13664.795028074586;13720.519781807789;13732.45070197201;13760.93119534396;13856.861431385558;5942.019566771521;5983.1623572699855;6007.549433792396;6009.879802403927;6019.367966363557;943.3208090175063;981.190517822799;1037.3412882819464;1041.1202533858877;1061.9628313009007;24004.63993040106;24685.87657061739;24777;24844;24854.005839766207;1135.460656188304;1140.960066397672;1170.1341007654275;1172.935488548121;1185.7035741064733;12571.497140114476;12669.556565520163;12699.492020319083;12725.745485090247;13019.544315949086;317426;319081;319850;321057;321441;54779.17831232535;54997;55057;55060;55085;1495.5438591229563;1529.8546638069365;1558.75059990401;1567.2320562924313;1577.5819407856927;18002.189901454203;18804.717929231345;21304.786952130282;22820.201292954665;24461.021559137436;31789.841050795523;37810.62189378071;37815.43276850794;37866.432003520524;38180.42729359117;282331;282461.5876920602;282696;283644.5817770898;289624;26831.731682683705;34822.47766283558;36449.817750911076;36967.81516092402;36986.630133698316;45798.08403831838;46470.37353692605;46491.53508464872;46647.30029049635;46873.06253874835;28217.858910705316;29687.703122968494;31081.533776993816;31246.37507249797;32117.35765284728;31215.219619509695;31356;31368;32116.19709507281;32223.35553288874;35614.64385356217;37944.810275948446;37958.62041379551;38030.239395211385;38060.2387952245;27469.450610988068;27492;29533.114006579835;30169.849150754108;30327.393452131277;22530.887345563166;23704.644430333214;23834.40413989664;25366;25468.344557603697 09:38:51 INFO - PID 1639 | |2;jquery.html;436.92572262715333;446.7341931550726;446.8614729433876;462.96759226854135;468.1362885476296;17323.91338043311;20276.695849562268;22716.204932827353;22812.54374912505;22958.88520557397;22669.54660906781;23054.19310324139;23365.649515257242;23371.415714607145;23594;5231.46274057082;5797.536197104243;6176.567640265194;6337.904931426032;6342.39747224013;6152.415520525566;6193.535484838632;6226.875462490748;6252.06219067139;6262.561620686553;6126.295476020248;6144.5698801083945;6162.137300777895;6181.412765787243;6197.597156184856;6169.568130230886;6172.4444799968;6203.193584833988;6236.8440788980415;6237.220347456568;5411.783528658849;5518.66887986718;5549.77800887964;5555.166724991243;5555.194496797982;26143;26143.346416339555;26655.20120387351;27450.176494705192;27667.308317292027;2009.6181725472113;2216.9556608867892;2270.25081723031;2286.1084177170915;2288.5880541502524;17471.825281747148;17474.737878931825;17685.911570442193;18102.728459073125;18229.997350145735;2175.369142948543;2182.2471247419617;2227.3095340444515;2230.152542034033;2231.419830843976;125848.48303033979;148677.7698334526;149136;150875.24562377227;151622;11974.760504789856;12335.136540442263;12475.688107797378;12492.937535312265;12522.686932826753;15782.289796959165;15996.680066398607;16067.919660401623;16090.839091609168;16111.597210069842;8639.87040194385;8903.955480222558;8933.865992010125;9009.729708108767;9022.86465703015;8400.915990840012;8444.535550544779;8492.830143397221;8637.0499245083;8644.956775216084;7678.462507624525;7794;7808.882866757003;7816.7264145754625;7830.569318687527;1808.6292310076403;1820.8088150744245;2134.807867291951;2152.956940861205;2361.504084142315;968.7965527239218;986.9950650246847;996.5864166371019;999.8300288950895;1023.6775415744016;20000;20109.39671809848;20114.597708045756;20118.19527218924;20323.695144572845;930.2418528898926;1017.516679577195;1047.162270183865;1070.5664205996584;1072.6674730833467;10430;10636.787264254672;10742.194335424874;10796.352218866736;10820.5130769114;528455;534449;534727;552589;554778;110469;129517.35241323733;134198;144356;144858;1210.7275862930946;1246.333211731719;1259.9433025513874;1260.9999999999816;1263.91784534005;17261;21732.826717328142;21799;21864;22077;58918.70540647269;60401;60655.69672151611;63081.68459157675;63339.366606333344;81528;82028;82321.58839206005;82793;82882.17117828745;8584.313254939714;8824.073472285318;8852.247558957302;8901.376903616685;9031.277497800029;11006.229563930448;12425.93787031059;12605.36973151357;13502.392392342565;13814.792778108538;11802.173847830569;11811.995980341768;11880.851574332635;11913.344766037952;12023.158378913393;11011.834822477509;11169.497372618414;11365;11467.827982580435;11597.710057248636;11851.111166662362;12033.578824741093;12171.148019638895;12219.327936963553;12235.877641223475;8438.367122465963;8529.14708529167;8580.442271252348;8653.826923461622;8758.781030474289;11777.646670599896;11825.349605771766;11875.524979000744;12075.75848483043;12085 09:38:51 INFO - PID 1639 | |3;mootools.html;1448.77543980683;1475;1499.985000149998;1520.7262692715315;1535.5009621872887;11531.884681153186;12077.214981026238;12092;12102.394880255995;12462.501499939992;12175.817362739566;12382.938085309583;12397.938010309936;12400.627981160556;12411.441485133168;2105.315772373977;2490.252924122765;2535.1253817432957;2543.529447052292;2544.427503811637;2447.56282077906;2488.22864911877;2496.3509487533192;2510.3975045989014;2513.195777351248;2488.8631125288102;2515.8993640254366;2524.066095544651;2536.480021595578;2536.746325367467;2135.5515341778246;2442.9755702442926;2444.973111293243;2474.938126546833;2494.4138127540014;2465.161844972718;2481.702195736523;2487.99236309295;2494.463690306575;2495.6131799570912;11903.345316007617;11917.880821191764;12152.57465988695;12157.635270941797;12170.695732606668;6422.678866056725;6681.331866813329;6684.030815531769;6685.5320127591085;6688.163979502562;3908.882733517999;3952.7825969571663;4287.892802679927;4293;4297.892552686208;1257.9874201257962;1276.636158694777;1312.7308901675133;1314.599047290576;1335.2656039178412;15432.22838858064;15581.065136091871;16645.750313745302;16892.239849206817;16967.981921084775;5316.548093412026;5373;5544.500994910478;5557.527610153102;5567.331920169606;12062.819057714141;12210.450529726184;12241.816372754416;12266.509339626315;12278.017758579292;6431.389018043278;6500.414962653384;6510.674466276667;6524.119243902107;6531.510136739764;6011.609245399035;6075.5747097703625;6149.661768602769;6186.659733714599;6202.224721909762;3711.2763011213096;4349.3475978603465;4449.710768800018;4505.842295519641;4566.223741963874;1284.916480428769;1300.2848433361803;1303.8696130386886;1317.74304010717;1320.1419077599637;817.0971076959873;825.5872063968015;833.2500749325656;844.2064459408259;868.1665601022962;6179.567430279837;6219.937800622027;6358.268799088071;6402.423781859655;6431.74273029083;546.5217934307481;560.6916196092133;562.3729541561212;568.7867049856304;574.3882764855416;3627.9093022674115;3808.3906574947873;3943.447917291524;3961.623645753649;3964.6035396460125;15003.2498375083;15327.846721532866;15487.303071361815;15498.225088745743;15502.30239639219;12958.67603309906;14915.776263356058;15045.097294162386;15202.46791362297;15360.61598460025;6426.775062872777;7552.39580833521;8616.095309992486;8728.476291422536;8813.118688131135;5377.623566350474;6046.758129674764;6425.485961123006;7018;7130.251323611154;12725.045621578603;12782;12811.295378754257;12813.039022073195;13438.865611343761;13985.650358741113;13994.720105598035;14032.719345612826;14089.365978531196;14374.856251437352;9434.669786557437;9536.141747242782;9666.854997174907;9693.563789629343;9702.320837541587;10826.458677066274;10994.835077473685;10996.065334446661;11011.229213955266;11116.777664446827;9182.908170918205;9339.85990210161;9357.906420935704;9364.719058428258;9413.85879211826;8088.595570221583;8566.614502347535;9066.22937050358;9200.539973001458;9292.16370526656;8283.420160588701;8324.625391857502;8393.37049721261;8403.621837017226;8404.621792019252;5570.470805273492;5663.52748285457;6056.091586262096;6190.969045154746;6261.8747625046335;6093.756249750138;6150.692465376624;6260;6290.402411770874;6420.325865784025 09:38:51 INFO - PID 1639 | |4;prototype.html;288.2376115175361;333.4165210880958;384.8518320446628;385.6394271356282;390.13974186917847;5255.1329030709885;5920.526357891364;6168.352323006087;6210.503159747226;6218.689065546716;5929.377415371388;6016.2479690038745;6033.909491357633;6044.609739759858;6064.723690389356;3340.2088629405557;4161.729487583312;4457.442819647544;4531.886702832439;4568.703034302776;4521;4538;4566.1780879441685;4573.748443835588;4577.702449340799;3889.9805500972457;4376.234159022174;4425.428972714688;4511.91713988642;4540.18276710192;4094.935316817619;4498.814130570466;4502.909941801162;4528.864134075983;4551.067031258584;3949;3961.960380396188;3974.998875848745;3977.1846771411792;3992.680585553178;5764.250647415809;5918.934591773479;5926.822195334147;5974.462298393166;5976.7908123215475;5392.1911713242935;5399.271098401744;5401.648892821954;5403.540699040586;5406.107992181285;6525.445337146348;6539.869202615969;6555.868882622369;6564.310747371553;6566.901496477557;4064.4106604542176;4253.340732186516;4264.445622069142;4285.3786201000685;4300.397944287803;6158.661273629904;6542.607443553402;6898.931010689879;7058.57648541084;7151.356377925959;4101.282275601758;4293;4307.6769242306955;4316.568343165721;4317;3863.7102217333813;4329.935050974238;4371.584699453547;4401.383806267125;4403.471583410012;5224.50367215114;5261.631685781958;5276.472352764769;5308.097623404031;5310.203469479609;5346.91979620306;6426.807195784134;6747.325267473311;6777.559458635173;6794.898076528856;1246.426643743888;1382.9377678004514;1477.3942683499713;1499.8650121489118;1506.9321880515404;849.6516428264382;933.3140141995627;948.5162567090696;955.3742298794301;956.4691596164196;5736.340320863071;6478.805635830932;6484.286728459866;6509.511786615928;6511;6843.863122737517;6992.230854605989;7028.472864535078;7048.330408611174;7055.788326350218;6455.935440645628;6473.255575608771;6488.870222595521;6492.285848556655;6495.849512986198;3537.699295559906;3646.252518233756;3647.6170002149925;3673.640752921436;3683.208110256308;6224.782132625336;6838.897416538656;7190.568565886064;7256.310650488195;7265.309795569518;5513.724313784295;6977.93022069783;7075.681594328267;7113.75101871432;7181.13826340832;6716.899246511306;7213.7375959207975;7215.783526494213;7235.167955685163;7252.673629686677;6793.252742198255;6930.688119034555;6961.234264231032;7011.894821577783;7020.648082892289;6579.934200658124;6854.794356169124;6858.491131950963;6926.896096558455;6957.826054348682;7033.824154396181;7278.563286202845;7285.7814265572115;7299.5255308404785;7309.122905251404;3607.85568577254;4330.848420305274;4335.783210839509;4337.631301339421;4339.696221264481;5835;6465.771503414337;6503.869922601616;7013.473989450709;7037.542559733601;6168.784092556739;6751.797446076625;6773.288804675635;6774.882144446111;6774.966125169342;5877.970610146922;6683.565568238243;6741.528093033637;6744.359285867835;6774.3225677431865;5768.423157684198;6643.741128016498;6663.400293973566;6672.427658756024;6679.2318883329035;5764.847030593814;6608.372204640552;6672.530284252259;6711.765088221889;6808.7658362277525;5440.591955603425;5670.291213598301;6179.69101544912;6626.701798418986;6639.800805975829 09:38:51 INFO - PID 1639 | |5;yui.html;841.5792103948025;851.0553285852699;855.6363545493166;872.0712441250068;886.2422628652502;16953.83046169538;17426;17430.738538921894;19033.143508542114;19581.804181958178;18007.63984720308;18267.269309227617;18434.354797582087;18825.529361765963;18963.05184740761;1014.8173328800794;1029.5572903651428;1041.3075304922218;1047.7275908263869;1047.9371237725722;1047.5757318286107;1048.1771809129834;1053.810314143454;1056.5245639462235;1058.1534772182263;1087.9673609791719;1107.9556817727282;1111.7665290289049;1112.5660992213002;1112.8998390144886;1092.4264761000459;1102.2780079048237;1108.8891110888928;1113.1373185781044;1113.3208742666966;800.0839039300027;810.1291112054565;811.0956283743642;812.1999830167281;813.9145389734052;15632.843671563252;15670.529884103495;15707.607309817231;15729.292181851844;15789.763153552705;12647.620571382873;17419.73870391945;17641.206145723474;17752.20115094824;17797.644047119116;11225.775484490265;11909.821352679717;13685.035517993576;14042.438302467992;14343.928280358532;2775.3894143288444;3432.056184549269;3543.574771027493;3548.822558872046;3554.893353199408;113388;136613;137680.31159844136;138304;140686;13121.934390327988;13396.665083372798;13554.59336219915;13565.050446468653;13630.659233519242;21872.89063554672;24953.750462495507;25948.481030379666;26250.474990500083;26291.948322067285;7715.267049630276;7738.690452381842;7738.922610773933;7790.454668173287;7846.686132554634;3385.1875549868346;4007.1785284016705;4015.8393664253103;4025.6175663311938;4037.9798101009897;3721.423179407196;4480.843170489083;4500.347449619787;4512.954870451319;4533.750643714561;868.2055918834322;878.2271600991087;884.2130503851578;886.9113088691208;887.9955600221957;595.675356930474;656.2223764838682;672.4519516593961;675.4562577125461;701.5615240474704;10865.45672716361;11791.469383877746;11906.98790602791;12014.579489717818;12074;639.0701529274987;642.7975187815823;648.3905129178557;655.8688262347549;679.6194131286495;4499.1451624191295;5129.743512824419;5552.611317207838;5571.164325351148;5581.386047534768;111944.44027779809;114140;114208.28687569693;114937;117902;74822.62588687021;96166.51916740372;100634.95555311204;101942;104974;91568.54215729013;92317;93178;93344;93562.53218733863;8577.95711021441;10680.73019089064;11067.335959842436;11199.60801371948;11290.096792256763;44265.557344426146;44744;44996;45288;45655.543444565126;55200.44799551953;56837;57448;57900.710496447246;58189.5452613688;14316.28418579046;14581.343839527035;14615.196164211071;16598.917005414896;17491.12544372802;18015.729764053813;18743.71884421762;18881;18889.149988250287;18952.620947580694;16872.915635421745;17541.473755787345;17557.912210438866;17749;17766.46700598984;14130.929345353208;14416.639584010483;15501.914865959274;15927.761083583988;17114.97310161394;17057;17196.31214751396;17242.482725518254;17338.73991890148;17506.387276445774;9689.903100969183;10330.431826249629;11965.606878624483;12072;12099.697507562381;12903.93328714366;13098.410571524495;13315.866841331463;13682.589522314347;13748.981621708204 09:38:51 INFO - PID 1639 | __end_tp_report 09:38:51 INFO - PID 1639 | __start_cc_report 09:38:51 INFO - PID 1639 | _x_x_mozilla_cycle_collect,411 09:38:51 INFO - PID 1639 | __end_cc_report 09:38:51 INFO - PID 1639 | __startTimestamp1493224731032__endTimestamp 09:38:51 INFO - PID 1639 | 09:38:51 INFO - PID 1639 | ------- Summary: start ------- 09:38:51 INFO - PID 1639 | Number of tests: 6 09:38:51 INFO - PID 1639 | 09:38:51 INFO - PID 1639 | [#0] dojo.html Cycles:165 Average:6010.32 Median:6264.31 stddev:733.57 (11.7%) stddev-sans-first:709.66 09:38:51 INFO - PID 1639 | Values: 3535.6 3547.4 3586.6 3586.9 3604.6 4848.6 5907.8 5959.4 6141.0 6156.3 6069.8 6106.1 6121.1 6125.1 6144.5 4516.4 5248.6 5352.6 5384.1 5415.9 5304.5 5378.5 5452.5 5452.6 5491.1 5415.3 5439.5 5463.8 5501.6 5507.2 5222.3 5310.9 5324.7 5333.1 5357.5 5313.5 5333.7 5349.3 5374.4 5425.5 5023.9 5814.5 6143.5 6152.6 6160.2 6531.6 6547.7 6557.6 6561.3 6565.0 6362.3 6453.8 6660.1 6703.8 6715.3 4892.5 5409.0 5789.0 6111.1 6290.8 6788.5 6823.5 6862.0 6870.6 6876.3 5038.8 6297.0 6360.4 6390.4 6514.1 5480.8 6629.4 6654.5 6698.5 6700.4 6545.2 6579.8 6586.5 6588.4 6598.4 5597.2 6259.8 6370.4 6531.8 6647.1 5238.7 5263.2 5267.2 5274.5 5277.9 4610.5 4649.8 4661.9 4684.8 4701.1 6071.3 6085.8 6255.6 6263.6 6273.2 5543.4 5740.9 6467.5 6589.4 6649.7 5507.7 5884.9 6238.7 6277.2 6302.4 5803.5 5821.4 5826.1 5832.5 5838.5 6505.3 6777.6 6785.6 6847.0 6858.2 6637.1 6718.3 6727.0 6731.2 6772.7 6564.4 6658.9 6722.4 6807.4 6883.1 6542.2 6587.1 6621.8 6626.4 6635.3 6659.1 6681.4 6709.0 6723.9 6729.9 6211.0 6264.3 6317.3 6411.2 6421.2 6385.6 6397.5 6420.2 6433.9 6456.8 6222.9 6269.7 6345.9 6353.4 6385.0 6203.8 6287.7 6367.3 6438.8 6451.5 5251.3 6231.9 6293.1 6308.0 6312.5 09:38:51 INFO - PID 1639 | 09:38:51 INFO - PID 1639 | [#1] ext.html Cycles:180 Average:45180.75 Median:176832.18 stddev:78223.95 (44.2%) stddev-sans-first:78372.01 09:38:51 INFO - PID 1639 | Values: 673.7 816.5 837.7 1276.3 1285.4 32257.2 38357.2 40132.8 40202.4 40288.8 39463.6 39470.8 39692.0 39865.2 39982.6 8101.9 8235.0 8765.5 8940.9 8967.6 8767.1 8805.1 8895.2 8896.7 8903.4 8871.6 8901.4 8915.9 8944.1 8947.6 8857.6 8869.0 8870.2 8893.5 8913.8 8710.0 8761.3 8779.6 8779.6 8788.6 38812.6 38856.0 39157.4 39167.8 39342.0 3608.2 3627.8 3641.0 3647.4 3652.0 30983.5 31024.1 31100.7 31150.5 31234.0 3114.3 3152.0 3161.3 3172.5 3179.2 282217.0 284052.6 291790.0 296556.0 297817.0 46235.3 48581.8 48676.3 48750.8 48804.3 43169.9 50968.9 51504.7 51516.5 53759.7 14474.8 14532.7 14591.6 14602.7 14631.0 11886.0 11930.6 11952.1 11975.6 12020.9 13664.8 13720.5 13732.5 13760.9 13856.9 5942.0 5983.2 6007.5 6009.9 6019.4 943.3 981.2 1037.3 1041.1 1062.0 24004.6 24685.9 24777.0 24844.0 24854.0 1135.5 1141.0 1170.1 1172.9 1185.7 12571.5 12669.6 12699.5 12725.7 13019.5 317426.0 319081.0 319850.0 321057.0 321441.0 54779.2 54997.0 55057.0 55060.0 55085.0 1495.5 1529.9 1558.8 1567.2 1577.6 18002.2 18804.7 21304.8 22820.2 24461.0 31789.8 37810.6 37815.4 37866.4 38180.4 282331.0 282461.6 282696.0 283644.6 289624.0 26831.7 34822.5 36449.8 36967.8 36986.6 45798.1 46470.4 46491.5 46647.3 46873.1 28217.9 29687.7 31081.5 31246.4 32117.4 31215.2 31356.0 31368.0 32116.2 32223.4 35614.6 37944.8 37958.6 38030.2 38060.2 27469.5 27492.0 29533.1 30169.8 30327.4 22530.9 23704.6 23834.4 25366.0 25468.3 09:38:51 INFO - PID 1639 | 09:38:51 INFO - PID 1639 | [#2] jquery.html Cycles:180 Average:35402.89 Median:22764.37 stddev:91821.91 (403.4%) stddev-sans-first:92041.96 09:38:51 INFO - PID 1639 | Values: 436.9 446.7 446.9 463.0 468.1 17323.9 20276.7 22716.2 22812.5 22958.9 22669.5 23054.2 23365.6 23371.4 23594.0 5231.5 5797.5 6176.6 6337.9 6342.4 6152.4 6193.5 6226.9 6252.1 6262.6 6126.3 6144.6 6162.1 6181.4 6197.6 6169.6 6172.4 6203.2 6236.8 6237.2 5411.8 5518.7 5549.8 5555.2 5555.2 26143.0 26143.3 26655.2 27450.2 27667.3 2009.6 2217.0 2270.3 2286.1 2288.6 17471.8 17474.7 17685.9 18102.7 18230.0 2175.4 2182.2 2227.3 2230.2 2231.4 125848.5 148677.8 149136.0 150875.2 151622.0 11974.8 12335.1 12475.7 12492.9 12522.7 15782.3 15996.7 16067.9 16090.8 16111.6 8639.9 8904.0 8933.9 9009.7 9022.9 8400.9 8444.5 8492.8 8637.0 8645.0 7678.5 7794.0 7808.9 7816.7 7830.6 1808.6 1820.8 2134.8 2153.0 2361.5 968.8 987.0 996.6 999.8 1023.7 20000.0 20109.4 20114.6 20118.2 20323.7 930.2 1017.5 1047.2 1070.6 1072.7 10430.0 10636.8 10742.2 10796.4 10820.5 528455.0 534449.0 534727.0 552589.0 554778.0 110469.0 129517.4 134198.0 144356.0 144858.0 1210.7 1246.3 1259.9 1261.0 1263.9 17261.0 21732.8 21799.0 21864.0 22077.0 58918.7 60401.0 60655.7 63081.7 63339.4 81528.0 82028.0 82321.6 82793.0 82882.2 8584.3 8824.1 8852.2 8901.4 9031.3 11006.2 12425.9 12605.4 13502.4 13814.8 11802.2 11812.0 11880.9 11913.3 12023.2 11011.8 11169.5 11365.0 11467.8 11597.7 11851.1 12033.6 12171.1 12219.3 12235.9 8438.4 8529.1 8580.4 8653.8 8758.8 11777.6 11825.3 11875.5 12075.8 12085.0 09:38:51 INFO - PID 1639 | 09:38:51 INFO - PID 1639 | [#3] mootools.html Cycles:180 Average:7139.36 Median:3669.59 stddev:4588.07 (125.0%) stddev-sans-first:4581.02 09:38:51 INFO - PID 1639 | Values: 1448.8 1475.0 1500.0 1520.7 1535.5 11531.9 12077.2 12092.0 12102.4 12462.5 12175.8 12382.9 12397.9 12400.6 12411.4 2105.3 2490.3 2535.1 2543.5 2544.4 2447.6 2488.2 2496.4 2510.4 2513.2 2488.9 2515.9 2524.1 2536.5 2536.7 2135.6 2443.0 2445.0 2474.9 2494.4 2465.2 2481.7 2488.0 2494.5 2495.6 11903.3 11917.9 12152.6 12157.6 12170.7 6422.7 6681.3 6684.0 6685.5 6688.2 3908.9 3952.8 4287.9 4293.0 4297.9 1258.0 1276.6 1312.7 1314.6 1335.3 15432.2 15581.1 16645.8 16892.2 16968.0 5316.5 5373.0 5544.5 5557.5 5567.3 12062.8 12210.5 12241.8 12266.5 12278.0 6431.4 6500.4 6510.7 6524.1 6531.5 6011.6 6075.6 6149.7 6186.7 6202.2 3711.3 4349.3 4449.7 4505.8 4566.2 1284.9 1300.3 1303.9 1317.7 1320.1 817.1 825.6 833.3 844.2 868.2 6179.6 6219.9 6358.3 6402.4 6431.7 546.5 560.7 562.4 568.8 574.4 3627.9 3808.4 3943.4 3961.6 3964.6 15003.2 15327.8 15487.3 15498.2 15502.3 12958.7 14915.8 15045.1 15202.5 15360.6 6426.8 7552.4 8616.1 8728.5 8813.1 5377.6 6046.8 6425.5 7018.0 7130.3 12725.0 12782.0 12811.3 12813.0 13438.9 13985.7 13994.7 14032.7 14089.4 14374.9 9434.7 9536.1 9666.9 9693.6 9702.3 10826.5 10994.8 10996.1 11011.2 11116.8 9182.9 9339.9 9357.9 9364.7 9413.9 8088.6 8566.6 9066.2 9200.5 9292.2 8283.4 8324.6 8393.4 8403.6 8404.6 5570.5 5663.5 6056.1 6191.0 6261.9 6093.8 6150.7 6260.0 6290.4 6420.3 09:38:51 INFO - PID 1639 | 09:38:51 INFO - PID 1639 | [#4] prototype.html Cycles:180 Average:5380.95 Median:6111.69 stddev:1758.34 (28.8%) stddev-sans-first:1721.23 09:38:51 INFO - PID 1639 | Values: 288.2 333.4 384.9 385.6 390.1 5255.1 5920.5 6168.4 6210.5 6218.7 5929.4 6016.2 6033.9 6044.6 6064.7 3340.2 4161.7 4457.4 4531.9 4568.7 4521.0 4538.0 4566.2 4573.7 4577.7 3890.0 4376.2 4425.4 4511.9 4540.2 4094.9 4498.8 4502.9 4528.9 4551.1 3949.0 3962.0 3975.0 3977.2 3992.7 5764.3 5918.9 5926.8 5974.5 5976.8 5392.2 5399.3 5401.6 5403.5 5406.1 6525.4 6539.9 6555.9 6564.3 6566.9 4064.4 4253.3 4264.4 4285.4 4300.4 6158.7 6542.6 6898.9 7058.6 7151.4 4101.3 4293.0 4307.7 4316.6 4317.0 3863.7 4329.9 4371.6 4401.4 4403.5 5224.5 5261.6 5276.5 5308.1 5310.2 5346.9 6426.8 6747.3 6777.6 6794.9 1246.4 1382.9 1477.4 1499.9 1506.9 849.7 933.3 948.5 955.4 956.5 5736.3 6478.8 6484.3 6509.5 6511.0 6843.9 6992.2 7028.5 7048.3 7055.8 6455.9 6473.3 6488.9 6492.3 6495.8 3537.7 3646.3 3647.6 3673.6 3683.2 6224.8 6838.9 7190.6 7256.3 7265.3 5513.7 6977.9 7075.7 7113.8 7181.1 6716.9 7213.7 7215.8 7235.2 7252.7 6793.3 6930.7 6961.2 7011.9 7020.6 6579.9 6854.8 6858.5 6926.9 6957.8 7033.8 7278.6 7285.8 7299.5 7309.1 3607.9 4330.8 4335.8 4337.6 4339.7 5835.0 6465.8 6503.9 7013.5 7037.5 6168.8 6751.8 6773.3 6774.9 6775.0 5878.0 6683.6 6741.5 6744.4 6774.3 5768.4 6643.7 6663.4 6672.4 6679.2 5764.8 6608.4 6672.5 6711.8 6808.8 5440.6 5670.3 6179.7 6626.7 6639.8 09:38:51 INFO - PID 1639 | 09:38:51 INFO - PID 1639 | [#5] yui.html Cycles:180 Average:22865.56 Median:17750.60 stddev:33297.08 (187.6%) stddev-sans-first:33349.42 09:38:51 INFO - PID 1639 | Values: 841.6 851.1 855.6 872.1 886.2 16953.8 17426.0 17430.7 19033.1 19581.8 18007.6 18267.3 18434.4 18825.5 18963.1 1014.8 1029.6 1041.3 1047.7 1047.9 1047.6 1048.2 1053.8 1056.5 1058.2 1088.0 1108.0 1111.8 1112.6 1112.9 1092.4 1102.3 1108.9 1113.1 1113.3 800.1 810.1 811.1 812.2 813.9 15632.8 15670.5 15707.6 15729.3 15789.8 12647.6 17419.7 17641.2 17752.2 17797.6 11225.8 11909.8 13685.0 14042.4 14343.9 2775.4 3432.1 3543.6 3548.8 3554.9 113388.0 136613.0 137680.3 138304.0 140686.0 13121.9 13396.7 13554.6 13565.1 13630.7 21872.9 24953.8 25948.5 26250.5 26291.9 7715.3 7738.7 7738.9 7790.5 7846.7 3385.2 4007.2 4015.8 4025.6 4038.0 3721.4 4480.8 4500.3 4513.0 4533.8 868.2 878.2 884.2 886.9 888.0 595.7 656.2 672.5 675.5 701.6 10865.5 11791.5 11907.0 12014.6 12074.0 639.1 642.8 648.4 655.9 679.6 4499.1 5129.7 5552.6 5571.2 5581.4 111944.4 114140.0 114208.3 114937.0 117902.0 74822.6 96166.5 100635.0 101942.0 104974.0 91568.5 92317.0 93178.0 93344.0 93562.5 8578.0 10680.7 11067.3 11199.6 11290.1 44265.6 44744.0 44996.0 45288.0 45655.5 55200.4 56837.0 57448.0 57900.7 58189.5 14316.3 14581.3 14615.2 16598.9 17491.1 18015.7 18743.7 18881.0 18889.1 18952.6 16872.9 17541.5 17557.9 17749.0 17766.5 14130.9 14416.6 15501.9 15927.8 17115.0 17057.0 17196.3 17242.5 17338.7 17506.4 9689.9 10330.4 11965.6 12072.0 12099.7 12903.9 13098.4 13315.9 13682.6 13749.0 09:38:51 INFO - PID 1639 | -------- Summary: end -------- 09:38:51 INFO - PID 1639 | 09:38:51 INFO - TEST-INFO | 1639: exit 0 09:38:51 INFO - TEST-OK | dromaeo_css | took 1113686ms 09:38:51 INFO - TEST-START | kraken 09:38:51 INFO - operating with platform_type : mac_ 09:38:51 INFO - Initialising browser for kraken test... 09:38:51 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpLJZT7A/profile http://localhost:49244/getInfo.html) 09:38:54 INFO - PID 1652 | 2017-04-26 09:38:54.537 plugin-container[1653:10383] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 09:38:54 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:38:54 INFO - PID 1652 | 2017-04-26 09:38:54.540 plugin-container[1653:10383] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x971b, name = 'com.apple.CFPasteboardClient' 09:38:54 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:38:54 INFO - PID 1652 | 2017-04-26 09:38:54.540 plugin-container[1653:10383] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:38:54 INFO - PID 1652 | __metrics Screen width/height:1600/1200 09:38:54 INFO - PID 1652 | colorDepth:24 09:38:54 INFO - PID 1652 | Browser inner width/height: 1024/689 09:38:54 INFO - PID 1652 | __metrics 09:38:54 ERROR - PID 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 09:38:55 INFO - TEST-INFO | 1652: exit 0 09:38:55 INFO - Browser initialized. 09:38:55 INFO - Running cycle 1/1 for kraken test... 09:38:55 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpLJZT7A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:58 INFO - PID 1654 | 2017-04-26 09:38:58.066 plugin-container[1655:10505] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 09:38:58 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:38:58 INFO - PID 1654 | 2017-04-26 09:38:58.066 plugin-container[1655:10505] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 09:38:58 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:38:58 INFO - PID 1654 | 2017-04-26 09:38:58.066 plugin-container[1655:10505] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:39:07 INFO - PID 1654 | RSS: Main: 236470272 09:39:07 INFO - PID 1654 | 09:39:10 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 09:39:11 INFO - PID 1654 | RSS: Main: 248524800 09:39:11 INFO - PID 1654 | 09:39:14 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 09:39:15 INFO - PID 1654 | RSS: Main: 257142784 09:39:15 INFO - PID 1654 | 09:39:18 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 09:39:18 INFO - PID 1654 | RSS: Main: 259649536 09:39:18 INFO - PID 1654 | 09:39:20 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 09:39:21 INFO - PID 1654 | RSS: Main: 260534272 09:39:21 INFO - PID 1654 | 09:39:23 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:39:24 INFO - PID 1654 | RSS: Main: 262348800 09:39:24 INFO - PID 1654 | 09:39:27 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 09:39:27 INFO - PID 1654 | RSS: Main: 267980800 09:39:27 INFO - PID 1654 | 09:39:30 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 09:39:31 INFO - PID 1654 | RSS: Main: 268648448 09:39:31 INFO - PID 1654 | 09:39:34 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 09:39:34 INFO - PID 1654 | RSS: Main: 268808192 09:39:34 INFO - PID 1654 | 09:39:36 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:39:37 INFO - PID 1654 | RSS: Main: 268009472 09:39:37 INFO - PID 1654 | 09:39:38 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:39:39 INFO - PID 1654 | RSS: Main: 268210176 09:39:39 INFO - PID 1654 | 09:39:41 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:39:42 INFO - PID 1654 | RSS: Main: 267636736 09:39:42 INFO - PID 1654 | 09:39:45 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:39:45 INFO - PID 1654 | RSS: Main: 268394496 09:39:45 INFO - PID 1654 | 09:39:49 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:39:49 INFO - PID 1654 | RSS: Main: 268517376 09:39:49 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 09:39:51 INFO - PID 1654 | RSS: Main: 270241792 09:39:51 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | __start_tp_report 09:39:51 INFO - PID 1654 | _x_x_mozilla_page_load 09:39:51 INFO - PID 1654 | _x_x_mozilla_page_load_details 09:39:51 INFO - PID 1654 | |i|pagename|runs| 09:39:51 INFO - PID 1654 | |0;ai-astar;102;118;116;112;114;112;114;127;168;159 09:39:51 INFO - PID 1654 | |1;audio-beat-detection;142;129;146;184;95;96;135;141;161;126 09:39:51 INFO - PID 1654 | |2;audio-dft;200;202;213;219;196;196;197;196;198;197 09:39:51 INFO - PID 1654 | |3;audio-fft;80;59;57;86;59;62;61;63;78;58 09:39:51 INFO - PID 1654 | |4;audio-oscillator;78;74;88;89;93;106;106;93;71;89 09:39:51 INFO - PID 1654 | |5;imaging-gaussian-blur;136;136;88;102;88;96;89;95;88;88 09:39:51 INFO - PID 1654 | |6;imaging-darkroom;106;95;97;96;102;96;93;110;96;99 09:39:51 INFO - PID 1654 | |7;imaging-desaturate;92;94;91;105;97;88;88;92;108;90 09:39:51 INFO - PID 1654 | |8;json-parse-financial;53;50;50;62;42;47;59;63;75;77 09:39:51 INFO - PID 1654 | |9;json-stringify-tinderbox;56;64;55;60;64;56;56;55;57;57 09:39:51 INFO - PID 1654 | |10;stanford-crypto-aes;82;84;84;97;105;80;82;84;82;83 09:39:51 INFO - PID 1654 | |11;stanford-crypto-ccm;128;143;125;140;151;149;138;153;204;151 09:39:51 INFO - PID 1654 | |12;stanford-crypto-pbkdf2;223;179;174;163;224;231;240;190;232;197 09:39:51 INFO - PID 1654 | |13;stanford-crypto-sha256-iterative;69;69;72;68;68;68;67;74;61;88 09:39:51 INFO - PID 1654 | __end_tp_report 09:39:51 INFO - PID 1654 | __start_cc_report 09:39:51 INFO - PID 1654 | _x_x_mozilla_cycle_collect,1007 09:39:51 INFO - PID 1654 | __end_cc_report 09:39:51 INFO - PID 1654 | __startTimestamp1493224791790__endTimestamp 09:39:51 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | ------- Summary: start ------- 09:39:51 INFO - PID 1654 | Number of tests: 14 09:39:51 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | [#0] ai-astar Cycles:10 Average:124.20 Median:117.00 stddev:21.71 (18.6%) stddev-sans-first:21.49 09:39:51 INFO - PID 1654 | Values: 102.0 118.0 116.0 112.0 114.0 112.0 114.0 127.0 168.0 159.0 09:39:51 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:153.50 stddev:26.91 (17.5%) stddev-sans-first:28.44 09:39:51 INFO - PID 1654 | Values: 142.0 129.0 146.0 184.0 95.0 96.0 135.0 141.0 161.0 126.0 09:39:51 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | [#2] audio-dft Cycles:10 Average:201.40 Median:199.00 stddev:8.06 (4.0%) stddev-sans-first:8.53 09:39:51 INFO - PID 1654 | Values: 200.0 202.0 213.0 219.0 196.0 196.0 197.0 196.0 198.0 197.0 09:39:51 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | [#3] audio-fft Cycles:10 Average:66.30 Median:62.50 stddev:10.71 (17.1%) stddev-sans-first:10.15 09:39:51 INFO - PID 1654 | Values: 80.0 59.0 57.0 86.0 59.0 62.0 61.0 63.0 78.0 58.0 09:39:51 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:88.50 stddev:11.93 (13.5%) stddev-sans-first:12.00 09:39:51 INFO - PID 1654 | Values: 78.0 74.0 88.0 89.0 93.0 106.0 106.0 93.0 71.0 89.0 09:39:51 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:100.60 Median:88.00 stddev:19.24 (21.9%) stddev-sans-first:15.56 09:39:51 INFO - PID 1654 | Values: 136.0 136.0 88.0 102.0 88.0 96.0 89.0 95.0 88.0 88.0 09:39:51 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | [#6] imaging-darkroom Cycles:10 Average:99.00 Median:96.00 stddev:5.40 (5.6%) stddev-sans-first:5.09 09:39:51 INFO - PID 1654 | Values: 106.0 95.0 97.0 96.0 102.0 96.0 93.0 110.0 96.0 99.0 09:39:51 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:91.50 stddev:6.90 (7.5%) stddev-sans-first:7.26 09:39:51 INFO - PID 1654 | Values: 92.0 94.0 91.0 105.0 97.0 88.0 88.0 92.0 108.0 90.0 09:39:51 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:60.50 stddev:11.65 (19.3%) stddev-sans-first:12.23 09:39:51 INFO - PID 1654 | Values: 53.0 50.0 50.0 62.0 42.0 47.0 59.0 63.0 75.0 77.0 09:39:51 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:57.00 stddev:3.46 (6.1%) stddev-sans-first:3.60 09:39:51 INFO - PID 1654 | Values: 56.0 64.0 55.0 60.0 64.0 56.0 56.0 55.0 57.0 57.0 09:39:51 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:83.50 stddev:8.07 (9.7%) stddev-sans-first:8.41 09:39:51 INFO - PID 1654 | Values: 82.0 84.0 84.0 97.0 105.0 80.0 82.0 84.0 82.0 83.0 09:39:51 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:150.00 stddev:21.85 (14.6%) stddev-sans-first:21.92 09:39:51 INFO - PID 1654 | Values: 128.0 143.0 125.0 140.0 151.0 149.0 138.0 153.0 204.0 151.0 09:39:51 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:205.30 Median:223.50 stddev:27.90 (12.5%) stddev-sans-first:28.84 09:39:51 INFO - PID 1654 | Values: 223.0 179.0 174.0 163.0 224.0 231.0 240.0 190.0 232.0 197.0 09:39:51 INFO - PID 1654 | 09:39:51 INFO - PID 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:69.00 stddev:7.04 (10.2%) stddev-sans-first:7.45 09:39:51 INFO - PID 1654 | Values: 69.0 69.0 72.0 68.0 68.0 68.0 67.0 74.0 61.0 88.0 09:39:51 INFO - PID 1654 | -------- Summary: end -------- 09:39:51 INFO - PID 1654 | 09:39:52 INFO - TEST-INFO | 1654: exit 0 09:39:52 INFO - TEST-OK | kraken | took 61174ms 09:39:52 INFO - SUITE-END | took 1174s 09:39:52 INFO - Completed test suite (00:19:34) 09:39:52 INFO - javascript benchmark 09:39:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7892.613315654016, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3535.611082780892, 3547.4324108142696, 3586.623404542523, 3586.892393228204, 3604.5674519057716, 4848.63635227358, 5907.822765317042, 5959.433853783884, 6141.0, 6156.261248650163, 6069.757209711617, 6106.053561697933, 6121.14813855746, 6125.081237814319, 6144.508439324854, 4516.390287311204, 5248.580113590903, 5352.598555108363, 5384.057789886774, 5415.916816636669, 5304.469553044684, 5378.542823859977, 5452.536534394561, 5452.59105567082, 5491.066518691812, 5415.296011518517, 5439.456054394568, 5463.836084917459, 5501.614886957915, 5507.201455788908, 5222.3472065991755, 5310.867228319323, 5324.7071411072375, 5333.146696528575, 5357.491038351351, 5313.495217954288, 5333.679979201222, 5349.331333583302, 5374.355077390699, 5425.538829199523, 5023.949760502384, 5814.47669709724, 6143.508519318444, 6152.6308421494405, 6160.229971253593, 6531.608103513804, 6547.738090476375, 6557.639329836857, 6561.2782593914635, 6565.0, 6362.331955144689, 6453.83865403364, 6660.100886380374, 6703.765368212089, 6715.294894036105, 4892.486288939645, 5409.0, 5789.04480760674, 6111.144439778434, 6290.779822706229, 6788.490863185182, 6823.454123670094, 6861.965690171517, 6870.553414028072, 6876.277990810893, 5038.79844806211, 6297.0, 6360.363963603602, 6390.4248617624635, 6514.088027676129, 5480.835574932758, 6629.370209830058, 6654.534182607171, 6698.531102822755, 6700.396964273142, 6545.181852268466, 6579.80260592183, 6586.506012049115, 6588.374104460165, 6598.43913267368, 5597.244372009726, 6259.843503912348, 6370.394812492806, 6531.836704082436, 6647.102641143384, 5238.71187084714, 5263.157894736901, 5267.236250743621, 5274.472552744694, 5277.868053298698, 4610.492845786961, 4649.767511624405, 4661.86014419568, 4684.765761711901, 4701.083288758659, 6071.271447426248, 6085.817425477154, 6255.624662520263, 6263.6241825490615, 6273.215848018997, 5543.362513311021, 5740.856478587985, 6467.547271690936, 6589.439897608757, 6649.667516624149, 5507.678157242233, 5884.8771530647, 6238.719257633417, 6277.18396608438, 6302.401271879165, 5803.5357171426185, 5821.446962538552, 5826.096954971986, 5832.533397328289, 5838.5329173666005, 6505.251896031922, 6777.627230502271, 6785.558938668971, 6847.0, 6858.177018757781, 6637.070810086495, 6718.294579069127, 6727.0, 6731.216227699566, 6772.695228714818, 6564.376384243489, 6658.866822663616, 6722.428593569602, 6807.421369183675, 6883.105196324646, 6542.247641521096, 6587.077809106825, 6621.768238111643, 6626.4367528760595, 6635.303293154149, 6659.101021362054, 6681.398674119353, 6709.027191057367, 6723.932760672331, 6729.865402692017, 6211.0, 6264.310925798068, 6317.305096439296, 6411.198600174978, 6421.229452465734, 6385.553011289165, 6397.488200944006, 6420.1974753155855, 6433.8713225736155, 6456.7740129095255, 6222.906656400067, 6269.749210031548, 6345.873082538231, 6353.396427339396, 6384.968075159781, 6203.7828675996125, 6287.748490060347, 6367.299597044229, 6438.7746428876635, 6451.516136289703, 5251.264822924717, 6231.937680623317, 6293.118963345227, 6307.96846015767, 6312.4634406076], "value": 5964.571402617228, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.7434684313756, 816.4733746733357, 837.7026155714722, 1276.3044140943184, 1285.421560297866, 32257.19357016073, 38357.23285534291, 40132.79601611953, 40202.39696404556, 40288.798556007176, 39463.60536394635, 39470.80264598673, 39692.0, 39865.20269594606, 39982.60017399825, 8101.878471822913, 8234.958825205895, 8765.517896515688, 8940.910590894073, 8967.641294348217, 8767.079456657055, 8805.119488051176, 8895.154960278764, 8896.733098007071, 8903.421277616933, 8871.645134194625, 8901.421407608485, 8915.866262006075, 8944.10558944107, 8947.64209431622, 8857.557122143899, 8869.0, 8870.2016818486, 8893.466392016435, 8913.821723565557, 8710.041895391501, 8761.342899282516, 8779.56102194894, 8779.604917778715, 8788.560571971377, 38812.61187388146, 38856.0, 39157.41263881044, 39167.804160979016, 39342.0, 3608.2422691234874, 3627.836747346376, 3640.9635903640888, 3647.434647629622, 3652.0322114639644, 30983.53524697109, 31024.0692779217, 31100.68899311023, 31150.532742008887, 31234.0, 3114.3304189599116, 3152.0, 3161.3203161320425, 3172.524121381788, 3179.1893067267697, 282217.0, 284052.57973710203, 291790.0, 296555.99999999785, 297817.0, 46235.30647040297, 48581.757091215026, 48676.26985595219, 48750.756246218545, 48804.26793598099, 43169.92075198145, 50968.94186348831, 51504.74247628813, 51516.48483515192, 53759.73120134374, 14474.782878256834, 14532.709345813024, 14591.562253132422, 14602.707945841024, 14631.0, 11886.0, 11930.582429615095, 11952.103592230618, 11975.58085467022, 12020.939895300467, 13664.795028074586, 13720.519781807789, 13732.45070197201, 13760.93119534396, 13856.861431385558, 5942.019566771521, 5983.1623572699855, 6007.549433792396, 6009.879802403927, 6019.367966363557, 943.3208090175063, 981.190517822799, 1037.3412882819464, 1041.1202533858877, 1061.9628313009007, 24004.63993040106, 24685.87657061739, 24777.0, 24844.0, 24854.005839766207, 1135.460656188304, 1140.960066397672, 1170.1341007654275, 1172.935488548121, 1185.7035741064733, 12571.497140114476, 12669.556565520163, 12699.492020319083, 12725.745485090247, 13019.544315949086, 317426.0, 319081.0, 319850.0, 321057.0, 321441.0, 54779.17831232535, 54997.0, 55057.0, 55060.0, 55085.0, 1495.5438591229563, 1529.8546638069365, 1558.75059990401, 1567.2320562924313, 1577.5819407856927, 18002.189901454203, 18804.717929231345, 21304.786952130282, 22820.201292954665, 24461.021559137436, 31789.841050795523, 37810.62189378071, 37815.43276850794, 37866.432003520524, 38180.42729359117, 282331.0, 282461.5876920602, 282696.0, 283644.5817770898, 289624.0, 26831.731682683705, 34822.47766283558, 36449.817750911076, 36967.81516092402, 36986.630133698316, 45798.08403831838, 46470.37353692605, 46491.53508464872, 46647.30029049635, 46873.06253874835, 28217.858910705316, 29687.703122968494, 31081.533776993816, 31246.37507249797, 32117.35765284728, 31215.219619509695, 31356.0, 31368.0, 32116.19709507281, 32223.35553288874, 35614.64385356217, 37944.810275948446, 37958.62041379551, 38030.239395211385, 38060.2387952245, 27469.450610988068, 27492.0, 29533.114006579835, 30169.849150754108, 30327.393452131277, 22530.887345563166, 23704.644430333214, 23834.40413989664, 25366.0, 25468.344557603697], "value": 17777.66435428444, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.92572262715333, 446.7341931550726, 446.8614729433876, 462.96759226854135, 468.1362885476296, 17323.91338043311, 20276.695849562268, 22716.204932827353, 22812.54374912505, 22958.88520557397, 22669.54660906781, 23054.19310324139, 23365.649515257242, 23371.415714607145, 23594.0, 5231.46274057082, 5797.536197104243, 6176.567640265194, 6337.904931426032, 6342.39747224013, 6152.415520525566, 6193.535484838632, 6226.875462490748, 6252.06219067139, 6262.561620686553, 6126.295476020248, 6144.5698801083945, 6162.137300777895, 6181.412765787243, 6197.597156184856, 6169.568130230886, 6172.4444799968, 6203.193584833988, 6236.8440788980415, 6237.220347456568, 5411.783528658849, 5518.66887986718, 5549.77800887964, 5555.166724991243, 5555.194496797982, 26143.0, 26143.346416339555, 26655.20120387351, 27450.176494705192, 27667.308317292027, 2009.6181725472113, 2216.9556608867892, 2270.25081723031, 2286.1084177170915, 2288.5880541502524, 17471.825281747148, 17474.737878931825, 17685.911570442193, 18102.728459073125, 18229.997350145735, 2175.369142948543, 2182.2471247419617, 2227.3095340444515, 2230.152542034033, 2231.419830843976, 125848.48303033979, 148677.7698334526, 149136.0, 150875.24562377227, 151622.0, 11974.760504789856, 12335.136540442263, 12475.688107797378, 12492.937535312265, 12522.686932826753, 15782.289796959165, 15996.680066398607, 16067.919660401623, 16090.839091609168, 16111.597210069842, 8639.87040194385, 8903.955480222558, 8933.865992010125, 9009.729708108767, 9022.86465703015, 8400.915990840012, 8444.535550544779, 8492.830143397221, 8637.0499245083, 8644.956775216084, 7678.462507624525, 7794.0, 7808.882866757003, 7816.7264145754625, 7830.569318687527, 1808.6292310076403, 1820.8088150744245, 2134.807867291951, 2152.956940861205, 2361.504084142315, 968.7965527239218, 986.9950650246847, 996.5864166371019, 999.8300288950895, 1023.6775415744016, 20000.0, 20109.39671809848, 20114.597708045756, 20118.19527218924, 20323.695144572845, 930.2418528898926, 1017.516679577195, 1047.162270183865, 1070.5664205996584, 1072.6674730833467, 10430.0, 10636.787264254672, 10742.194335424874, 10796.352218866736, 10820.5130769114, 528455.0, 534449.0, 534727.0, 552589.0, 554778.0, 110469.0, 129517.35241323733, 134198.0, 144356.0, 144858.0, 1210.7275862930946, 1246.333211731719, 1259.9433025513874, 1260.9999999999816, 1263.91784534005, 17261.0, 21732.826717328142, 21799.0, 21864.0, 22077.0, 58918.70540647269, 60401.0, 60655.69672151611, 63081.68459157675, 63339.366606333344, 81528.0, 82028.0, 82321.58839206005, 82793.0, 82882.17117828745, 8584.313254939714, 8824.073472285318, 8852.247558957302, 8901.376903616685, 9031.277497800029, 11006.229563930448, 12425.93787031059, 12605.36973151357, 13502.392392342565, 13814.792778108538, 11802.173847830569, 11811.995980341768, 11880.851574332635, 11913.344766037952, 12023.158378913393, 11011.834822477509, 11169.497372618414, 11365.0, 11467.827982580435, 11597.710057248636, 11851.111166662362, 12033.578824741093, 12171.148019638895, 12219.327936963553, 12235.877641223475, 8438.367122465963, 8529.14708529167, 8580.442271252348, 8653.826923461622, 8758.781030474289, 11777.646670599896, 11825.349605771766, 11875.524979000744, 12075.75848483043, 12085.0], "value": 10488.57874666475, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.77543980683, 1475.0, 1499.985000149998, 1520.7262692715315, 1535.5009621872887, 11531.884681153186, 12077.214981026238, 12092.0, 12102.394880255995, 12462.501499939992, 12175.817362739566, 12382.938085309583, 12397.938010309936, 12400.627981160556, 12411.441485133168, 2105.315772373977, 2490.252924122765, 2535.1253817432957, 2543.529447052292, 2544.427503811637, 2447.56282077906, 2488.22864911877, 2496.3509487533192, 2510.3975045989014, 2513.195777351248, 2488.8631125288102, 2515.8993640254366, 2524.066095544651, 2536.480021595578, 2536.746325367467, 2135.5515341778246, 2442.9755702442926, 2444.973111293243, 2474.938126546833, 2494.4138127540014, 2465.161844972718, 2481.702195736523, 2487.99236309295, 2494.463690306575, 2495.6131799570912, 11903.345316007617, 11917.880821191764, 12152.57465988695, 12157.635270941797, 12170.695732606668, 6422.678866056725, 6681.331866813329, 6684.030815531769, 6685.5320127591085, 6688.163979502562, 3908.882733517999, 3952.7825969571663, 4287.892802679927, 4293.0, 4297.892552686208, 1257.9874201257962, 1276.636158694777, 1312.7308901675133, 1314.599047290576, 1335.2656039178412, 15432.22838858064, 15581.065136091871, 16645.750313745302, 16892.239849206817, 16967.981921084775, 5316.548093412026, 5373.0, 5544.500994910478, 5557.527610153102, 5567.331920169606, 12062.819057714141, 12210.450529726184, 12241.816372754416, 12266.509339626315, 12278.017758579292, 6431.389018043278, 6500.414962653384, 6510.674466276667, 6524.119243902107, 6531.510136739764, 6011.609245399035, 6075.5747097703625, 6149.661768602769, 6186.659733714599, 6202.224721909762, 3711.2763011213096, 4349.3475978603465, 4449.710768800018, 4505.842295519641, 4566.223741963874, 1284.916480428769, 1300.2848433361803, 1303.8696130386886, 1317.74304010717, 1320.1419077599637, 817.0971076959873, 825.5872063968015, 833.2500749325656, 844.2064459408259, 868.1665601022962, 6179.567430279837, 6219.937800622027, 6358.268799088071, 6402.423781859655, 6431.74273029083, 546.5217934307481, 560.6916196092133, 562.3729541561212, 568.7867049856304, 574.3882764855416, 3627.9093022674115, 3808.3906574947873, 3943.447917291524, 3961.623645753649, 3964.6035396460125, 15003.2498375083, 15327.846721532866, 15487.303071361815, 15498.225088745743, 15502.30239639219, 12958.67603309906, 14915.776263356058, 15045.097294162386, 15202.46791362297, 15360.61598460025, 6426.775062872777, 7552.39580833521, 8616.095309992486, 8728.476291422536, 8813.118688131135, 5377.623566350474, 6046.758129674764, 6425.485961123006, 7018.0, 7130.251323611154, 12725.045621578603, 12782.0, 12811.295378754257, 12813.039022073195, 13438.865611343761, 13985.650358741113, 13994.720105598035, 14032.719345612826, 14089.365978531196, 14374.856251437352, 9434.669786557437, 9536.141747242782, 9666.854997174907, 9693.563789629343, 9702.320837541587, 10826.458677066274, 10994.835077473685, 10996.065334446661, 11011.229213955266, 11116.777664446827, 9182.908170918205, 9339.85990210161, 9357.906420935704, 9364.719058428258, 9413.85879211826, 8088.595570221583, 8566.614502347535, 9066.22937050358, 9200.539973001458, 9292.16370526656, 8283.420160588701, 8324.625391857502, 8393.37049721261, 8403.621837017226, 8404.621792019252, 5570.470805273492, 5663.52748285457, 6056.091586262096, 6190.969045154746, 6261.8747625046335, 6093.756249750138, 6150.692465376624, 6260.0, 6290.402411770874, 6420.325865784025], "value": 5326.10426380389, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.2376115175361, 333.4165210880958, 384.8518320446628, 385.6394271356282, 390.13974186917847, 5255.1329030709885, 5920.526357891364, 6168.352323006087, 6210.503159747226, 6218.689065546716, 5929.377415371388, 6016.2479690038745, 6033.909491357633, 6044.609739759858, 6064.723690389356, 3340.2088629405557, 4161.729487583312, 4457.442819647544, 4531.886702832439, 4568.703034302776, 4521.0, 4538.0, 4566.1780879441685, 4573.748443835588, 4577.702449340799, 3889.9805500972457, 4376.234159022174, 4425.428972714688, 4511.91713988642, 4540.18276710192, 4094.935316817619, 4498.814130570466, 4502.909941801162, 4528.864134075983, 4551.067031258584, 3949.0, 3961.960380396188, 3974.998875848745, 3977.1846771411792, 3992.680585553178, 5764.250647415809, 5918.934591773479, 5926.822195334147, 5974.462298393166, 5976.7908123215475, 5392.1911713242935, 5399.271098401744, 5401.648892821954, 5403.540699040586, 5406.107992181285, 6525.445337146348, 6539.869202615969, 6555.868882622369, 6564.310747371553, 6566.901496477557, 4064.4106604542176, 4253.340732186516, 4264.445622069142, 4285.3786201000685, 4300.397944287803, 6158.661273629904, 6542.607443553402, 6898.931010689879, 7058.57648541084, 7151.356377925959, 4101.282275601758, 4293.0, 4307.6769242306955, 4316.568343165721, 4317.0, 3863.7102217333813, 4329.935050974238, 4371.584699453547, 4401.383806267125, 4403.471583410012, 5224.50367215114, 5261.631685781958, 5276.472352764769, 5308.097623404031, 5310.203469479609, 5346.91979620306, 6426.807195784134, 6747.325267473311, 6777.559458635173, 6794.898076528856, 1246.426643743888, 1382.9377678004514, 1477.3942683499713, 1499.8650121489118, 1506.9321880515404, 849.6516428264382, 933.3140141995627, 948.5162567090696, 955.3742298794301, 956.4691596164196, 5736.340320863071, 6478.805635830932, 6484.286728459866, 6509.511786615928, 6511.0, 6843.863122737517, 6992.230854605989, 7028.472864535078, 7048.330408611174, 7055.788326350218, 6455.935440645628, 6473.255575608771, 6488.870222595521, 6492.285848556655, 6495.849512986198, 3537.699295559906, 3646.252518233756, 3647.6170002149925, 3673.640752921436, 3683.208110256308, 6224.782132625336, 6838.897416538656, 7190.568565886064, 7256.310650488195, 7265.309795569518, 5513.724313784295, 6977.93022069783, 7075.681594328267, 7113.75101871432, 7181.13826340832, 6716.899246511306, 7213.7375959207975, 7215.783526494213, 7235.167955685163, 7252.673629686677, 6793.252742198255, 6930.688119034555, 6961.234264231032, 7011.894821577783, 7020.648082892289, 6579.934200658124, 6854.794356169124, 6858.491131950963, 6926.896096558455, 6957.826054348682, 7033.824154396181, 7278.563286202845, 7285.7814265572115, 7299.5255308404785, 7309.122905251404, 3607.85568577254, 4330.848420305274, 4335.783210839509, 4337.631301339421, 4339.696221264481, 5835.0, 6465.771503414337, 6503.869922601616, 7013.473989450709, 7037.542559733601, 6168.784092556739, 6751.797446076625, 6773.288804675635, 6774.882144446111, 6774.966125169342, 5877.970610146922, 6683.565568238243, 6741.528093033637, 6744.359285867835, 6774.3225677431865, 5768.423157684198, 6643.741128016498, 6663.400293973566, 6672.427658756024, 6679.2318883329035, 5764.847030593814, 6608.372204640552, 6672.530284252259, 6711.765088221889, 6808.7658362277525, 5440.591955603425, 5670.291213598301, 6179.69101544912, 6626.701798418986, 6639.800805975829], "value": 4803.838971991077, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [841.5792103948025, 851.0553285852699, 855.6363545493166, 872.0712441250068, 886.2422628652502, 16953.83046169538, 17426.0, 17430.738538921894, 19033.143508542114, 19581.804181958178, 18007.63984720308, 18267.269309227617, 18434.354797582087, 18825.529361765963, 18963.05184740761, 1014.8173328800794, 1029.5572903651428, 1041.3075304922218, 1047.7275908263869, 1047.9371237725722, 1047.5757318286107, 1048.1771809129834, 1053.810314143454, 1056.5245639462235, 1058.1534772182263, 1087.9673609791719, 1107.9556817727282, 1111.7665290289049, 1112.5660992213002, 1112.8998390144886, 1092.4264761000459, 1102.2780079048237, 1108.8891110888928, 1113.1373185781044, 1113.3208742666966, 800.0839039300027, 810.1291112054565, 811.0956283743642, 812.1999830167281, 813.9145389734052, 15632.843671563252, 15670.529884103495, 15707.607309817231, 15729.292181851844, 15789.763153552705, 12647.620571382873, 17419.73870391945, 17641.206145723474, 17752.20115094824, 17797.644047119116, 11225.775484490265, 11909.821352679717, 13685.035517993576, 14042.438302467992, 14343.928280358532, 2775.3894143288444, 3432.056184549269, 3543.574771027493, 3548.822558872046, 3554.893353199408, 113388.0, 136613.0, 137680.31159844136, 138304.0, 140686.0, 13121.934390327988, 13396.665083372798, 13554.59336219915, 13565.050446468653, 13630.659233519242, 21872.89063554672, 24953.750462495507, 25948.481030379666, 26250.474990500083, 26291.948322067285, 7715.267049630276, 7738.690452381842, 7738.922610773933, 7790.454668173287, 7846.686132554634, 3385.1875549868346, 4007.1785284016705, 4015.8393664253103, 4025.6175663311938, 4037.9798101009897, 3721.423179407196, 4480.843170489083, 4500.347449619787, 4512.954870451319, 4533.750643714561, 868.2055918834322, 878.2271600991087, 884.2130503851578, 886.9113088691208, 887.9955600221957, 595.675356930474, 656.2223764838682, 672.4519516593961, 675.4562577125461, 701.5615240474704, 10865.45672716361, 11791.469383877746, 11906.98790602791, 12014.579489717818, 12074.0, 639.0701529274987, 642.7975187815823, 648.3905129178557, 655.8688262347549, 679.6194131286495, 4499.1451624191295, 5129.743512824419, 5552.611317207838, 5571.164325351148, 5581.386047534768, 111944.44027779809, 114140.0, 114208.28687569693, 114937.0, 117902.0, 74822.62588687021, 96166.51916740372, 100634.95555311204, 101942.0, 104974.0, 91568.54215729013, 92317.0, 93178.0, 93344.0, 93562.53218733863, 8577.95711021441, 10680.73019089064, 11067.335959842436, 11199.60801371948, 11290.096792256763, 44265.557344426146, 44744.0, 44996.0, 45288.0, 45655.543444565126, 55200.44799551953, 56837.0, 57448.0, 57900.710496447246, 58189.5452613688, 14316.28418579046, 14581.343839527035, 14615.196164211071, 16598.917005414896, 17491.12544372802, 18015.729764053813, 18743.71884421762, 18881.0, 18889.149988250287, 18952.620947580694, 16872.915635421745, 17541.473755787345, 17557.912210438866, 17749.0, 17766.46700598984, 14130.929345353208, 14416.639584010483, 15501.914865959274, 15927.761083583988, 17114.97310161394, 17057.0, 17196.31214751396, 17242.482725518254, 17338.73991890148, 17506.387276445774, 9689.903100969183, 10330.431826249629, 11965.606878624483, 12072.0, 12099.697507562381, 12903.93328714366, 13098.410571524495, 13315.866841331463, 13682.589522314347, 13748.981621708204], "value": 8494.243383322135, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 118.0, 116.0, 112.0, 114.0, 112.0, 114.0, 127.0, 168.0, 159.0], "value": 124.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 129.0, 146.0, 184.0, 95.0, 96.0, 135.0, 141.0, 161.0, 126.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 202.0, 213.0, 219.0, 196.0, 196.0, 197.0, 196.0, 198.0, 197.0], "value": 201.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 57.0, 86.0, 59.0, 62.0, 61.0, 63.0, 78.0, 58.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 88.0, 89.0, 93.0, 106.0, 106.0, 93.0, 71.0, 89.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 88.0, 102.0, 88.0, 96.0, 89.0, 95.0, 88.0, 88.0], "value": 100.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 95.0, 97.0, 96.0, 102.0, 96.0, 93.0, 110.0, 96.0, 99.0], "value": 99.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 91.0, 105.0, 97.0, 88.0, 88.0, 92.0, 108.0, 90.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 50.0, 62.0, 42.0, 47.0, 59.0, 63.0, 75.0, 77.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 64.0, 55.0, 60.0, 64.0, 56.0, 56.0, 55.0, 57.0, 57.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 84.0, 97.0, 105.0, 80.0, 82.0, 84.0, 82.0, 83.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 143.0, 125.0, 140.0, 151.0, 149.0, 138.0, 153.0, 204.0, 151.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [223.0, 179.0, 174.0, 163.0, 224.0, 231.0, 240.0, 190.0, 232.0, 197.0], "value": 205.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 72.0, 68.0, 68.0, 68.0, 67.0, 74.0, 61.0, 88.0], "value": 70.4, "unit": "score"}]}]} 09:39:53 INFO - Return code: 0 09:39:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:39:53 ERROR - # TBPL SUCCESS # 09:39:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:39:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:39:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:39:53 INFO - 2017-04-26 09:39:53.129 screenresolution[1659:10896] starting screenresolution argv=screenresolution get 09:39:53 INFO - 2017-04-26 09:39:53.132 screenresolution[1659:10896] Display 0: 1600x1200x32@60 09:39:53 INFO - 2017-04-26 09:39:53.138 screenresolution[1660:10899] starting screenresolution argv=screenresolution list 09:39:53 INFO - Available Modes on Display 0 09:39:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:39:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:39:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:39:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:39:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:39:53 INFO - Intel Iris: 09:39:53 INFO - Chipset Model: Intel Iris 09:39:53 INFO - Type: GPU 09:39:53 INFO - Bus: Built-In 09:39:53 INFO - VRAM (Dynamic, Max): 1536 MB 09:39:53 INFO - Vendor: Intel (0x8086) 09:39:53 INFO - Device ID: 0x0a2e 09:39:53 INFO - Revision ID: 0x0009 09:39:53 INFO - Displays: 09:39:53 INFO - Display: 09:39:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:39:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:39:53 INFO - Display Serial Number: 1600x1200 60 09:39:53 INFO - Main Display: Yes 09:39:53 INFO - Mirror: Off 09:39:53 INFO - Online: Yes 09:39:53 INFO - Rotation: Supported 09:39:53 INFO - Return code: 0 09:39:53 INFO - Running post-action listener: _resource_record_post_action 09:39:53 INFO - [mozharness: 2017-04-26 16:39:53.385855Z] Finished run-tests step (success) 09:39:53 INFO - Running post-run listener: _resource_record_post_run 09:39:53 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 39025152; Write bytes: 514396160; Read time: 254; Write time: 1620 09:39:53 INFO - TinderboxPrint: CPU usage
54.0% 09:39:53 INFO - TinderboxPrint: I/O read bytes / time
39,025,152 / 254 09:39:53 INFO - TinderboxPrint: I/O write bytes / time
514,396,160 / 1,620 09:39:53 INFO - TinderboxPrint: CPU idle
2,197.8 (46.0%) 09:39:53 INFO - TinderboxPrint: CPU system
959.9 (20.1%) 09:39:53 INFO - TinderboxPrint: CPU user
1,624.0 (34.0%) 09:39:53 INFO - TinderboxPrint: Swap in / out
247,324,672 / 0 09:39:53 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 194005504; Write bytes: 195160064; Read time: 15093; Write time: 407 09:39:53 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 38062592; Write bytes: 302397440; Read time: 241; Write time: 1161 09:39:53 INFO - Running post-run listener: _upload_blobber_files 09:39:53 INFO - Blob upload gear active. 09:39:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:39:53 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 09:39:53 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'] 09:39:53 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 09:39:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:39:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:39:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:39:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:55 INFO - (blobuploader) - INFO - Done attempting. 09:39:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:39:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:39:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:56 INFO - (blobuploader) - INFO - Done attempting. 09:39:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:39:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:39:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:56 INFO - (blobuploader) - INFO - Done attempting. 09:39:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:39:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:39:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:59 INFO - (blobuploader) - INFO - Done attempting. 09:39:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:39:59 INFO - Return code: 0 09:39:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:39:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:39:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/336543c7e4f040b07db5b5f83f35f9eab2d05ef35ccf504c315b0b6f389b3d5bfeb212ed728c72d69e31707cde03eae743c8e5626478a94047b6a0131d8e8b11", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4eef6aefbf2037c7b2cb29ff523d5c8c2424beb2153beeab9e917eec90b3f54ac4a800991b817cdd38d66fa3691ae72d9f4fe08e2d5d70666ab8bbab2b45d950", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b473afef591bb1f624c1dc81847ae53802fc2f6bcd2282891a50789182caedd9bdf3b2534ee191f03c98ca17df931494989fbd0c3f1b626b8f1a613e1e996f1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3697399fe27422a6e2dbf23069b1467e5676f657f15a85d488305da2914156c6dfa5fc49dcb8da6e782f4866a5c1947ecd4af206eb57d8ee34cb77237926847"} 09:39:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:39:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:39:59 INFO - Contents: 09:39:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/336543c7e4f040b07db5b5f83f35f9eab2d05ef35ccf504c315b0b6f389b3d5bfeb212ed728c72d69e31707cde03eae743c8e5626478a94047b6a0131d8e8b11", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4eef6aefbf2037c7b2cb29ff523d5c8c2424beb2153beeab9e917eec90b3f54ac4a800991b817cdd38d66fa3691ae72d9f4fe08e2d5d70666ab8bbab2b45d950", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b473afef591bb1f624c1dc81847ae53802fc2f6bcd2282891a50789182caedd9bdf3b2534ee191f03c98ca17df931494989fbd0c3f1b626b8f1a613e1e996f1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3697399fe27422a6e2dbf23069b1467e5676f657f15a85d488305da2914156c6dfa5fc49dcb8da6e782f4866a5c1947ecd4af206eb57d8ee34cb77237926847"} 09:39:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:39:59 INFO - Copying logs to upload dir... 09:39:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:39:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.526254 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-26 09:39:59.506926) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-26 09:39:59.510688) ========= 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.iNUMD1ajdr/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.5FveZRr1V9/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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/336543c7e4f040b07db5b5f83f35f9eab2d05ef35ccf504c315b0b6f389b3d5bfeb212ed728c72d69e31707cde03eae743c8e5626478a94047b6a0131d8e8b11", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4eef6aefbf2037c7b2cb29ff523d5c8c2424beb2153beeab9e917eec90b3f54ac4a800991b817cdd38d66fa3691ae72d9f4fe08e2d5d70666ab8bbab2b45d950", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b473afef591bb1f624c1dc81847ae53802fc2f6bcd2282891a50789182caedd9bdf3b2534ee191f03c98ca17df931494989fbd0c3f1b626b8f1a613e1e996f1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3697399fe27422a6e2dbf23069b1467e5676f657f15a85d488305da2914156c6dfa5fc49dcb8da6e782f4866a5c1947ecd4af206eb57d8ee34cb77237926847"} build_url:https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/LTBhNnzlRT-cmsiILoZTQw/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/336543c7e4f040b07db5b5f83f35f9eab2d05ef35ccf504c315b0b6f389b3d5bfeb212ed728c72d69e31707cde03eae743c8e5626478a94047b6a0131d8e8b11", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4eef6aefbf2037c7b2cb29ff523d5c8c2424beb2153beeab9e917eec90b3f54ac4a800991b817cdd38d66fa3691ae72d9f4fe08e2d5d70666ab8bbab2b45d950", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b473afef591bb1f624c1dc81847ae53802fc2f6bcd2282891a50789182caedd9bdf3b2534ee191f03c98ca17df931494989fbd0c3f1b626b8f1a613e1e996f1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3697399fe27422a6e2dbf23069b1467e5676f657f15a85d488305da2914156c6dfa5fc49dcb8da6e782f4866a5c1947ecd4af206eb57d8ee34cb77237926847"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-26 09:39:59.546365) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:39:59.546700) ========= 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.iNUMD1ajdr/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.5FveZRr1V9/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.005245 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:39:59.595351) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-26 09:39:59.595691) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-26 09:39:59.596044) ========= ========= Total master_lag: 0.18 =========