builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0371 starttime: 1491241790.77 results: success (0) buildid: 20170403094522 builduid: c277f3fefb3e434e92a8b54ba059badd revision: 929d6fc313e63aa9775b436659c6207f7de47b6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 10:49:50.772346) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 10:49:50.772849) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 10:49:50.773144) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 10:49:50.799309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 10:49:50.799733) ========= 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.xstz2FJriY/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.tP19qv1lZe/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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-03 10:49:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.22M=0.001s 2017-04-03 10:49:51 (8.22 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.246464 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 10:49:51.214466) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 10:49:51.214807) ========= 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.xstz2FJriY/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.tP19qv1lZe/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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.021519 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 10:49:51.262042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-03 10:49:51.262408) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 929d6fc313e63aa9775b436659c6207f7de47b6a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 929d6fc313e63aa9775b436659c6207f7de47b6a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xstz2FJriY/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.tP19qv1lZe/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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-03 10:49:51,379 truncating revision to first 12 chars 2017-04-03 10:49:51,379 Setting DEBUG logging. 2017-04-03 10:49:51,379 attempt 1/10 2017-04-03 10:49:51,379 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/929d6fc313e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-03 10:49:53,721 unpacking tar archive at: mozilla-aurora-929d6fc313e6/testing/mozharness/ program finished with exit code 0 elapsedTime=2.599348 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-03 10:49:53.888502) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 10:49:53.888910) ========= script_repo_revision: 929d6fc313e63aa9775b436659c6207f7de47b6a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 10:49:53.889345) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 10:49:53.889666) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 10:49:53.908918) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-03 10:49:53.909210) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xstz2FJriY/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.tP19qv1lZe/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 10:49:54 INFO - MultiFileLogger online at 20170403 10:49:54 in /builds/slave/test 10:49:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:49:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:49:54 INFO - {'append_to_log': False, 10:49:54 INFO - 'base_work_dir': '/builds/slave/test', 10:49:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:49:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:49:54 INFO - 'branch': 'Mozilla-Aurora', 10:49:54 INFO - 'buildbot_json_path': 'buildprops.json', 10:49:54 INFO - 'config_files': ('talos/mac_config.py',), 10:49:54 INFO - 'default_actions': ('clobber', 10:49:54 INFO - 'read-buildbot-config', 10:49:54 INFO - 'download-and-extract', 10:49:54 INFO - 'populate-webroot', 10:49:54 INFO - 'create-virtualenv', 10:49:54 INFO - 'install', 10:49:54 INFO - 'run-tests'), 10:49:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:49:54 INFO - 'download_minidump_stackwalk': True, 10:49:54 INFO - 'download_symbols': 'ondemand', 10:49:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:49:54 INFO - 'tooltool.py': '/tools/tooltool.py', 10:49:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:49:54 INFO - '/tools/misc-python/virtualenv.py')}, 10:49:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:49:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:49:54 INFO - 'gecko_profile': False, 10:49:54 INFO - 'gecko_profile_interval': 0, 10:49:54 INFO - 'installer_path': 'installer.exe', 10:49:54 INFO - 'log_level': 'info', 10:49:54 INFO - 'log_name': 'talos', 10:49:54 INFO - 'log_to_console': True, 10:49:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:49:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:49:54 INFO - 'opt_config_files': (), 10:49:54 INFO - 'pip_index': False, 10:49:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:49:54 INFO - 'cmd': ('bash', 10:49:54 INFO - '-c', 10:49:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:49:54 INFO - 'enabled': True, 10:49:54 INFO - 'halt_on_failure': False, 10:49:54 INFO - 'name': 'check_screen_resolution'},), 10:49:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:49:54 INFO - 'cmd': ('bash', 10:49:54 INFO - '-c', 10:49:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:49:54 INFO - 'enabled': True, 10:49:54 INFO - 'halt_on_failure': False, 10:49:54 INFO - 'name': 'check_screen_resolution'},), 10:49:54 INFO - 'run_cmd_checks_enabled': True, 10:49:54 INFO - 'suite': 'dromaeojs-e10s', 10:49:54 INFO - 'system_bits': '32', 10:49:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:49:54 INFO - 'title': 't-yosemite-r7-0371', 10:49:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:49:54 INFO - 'use_talos_json': True, 10:49:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:49:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:49:54 INFO - 'work_dir': 'build'} 10:49:54 INFO - [mozharness: 2017-04-03 17:49:54.139866Z] Running clobber step. 10:49:54 INFO - Running pre-action listener: _resource_record_pre_action 10:49:54 INFO - Running main action method: clobber 10:49:54 INFO - rmtree: /builds/slave/test/build 10:49:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:49:54 INFO - Running post-action listener: _resource_record_post_action 10:49:54 INFO - [mozharness: 2017-04-03 17:49:54.759081Z] Finished clobber step (success) 10:49:54 INFO - [mozharness: 2017-04-03 17:49:54.759213Z] Running read-buildbot-config step. 10:49:54 INFO - Running pre-action listener: _resource_record_pre_action 10:49:54 INFO - Running main action method: read_buildbot_config 10:49:54 INFO - Using buildbot properties: 10:49:54 INFO - { 10:49:54 INFO - "project": "", 10:49:54 INFO - "product": "firefox", 10:49:54 INFO - "script_repo_revision": "production", 10:49:54 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 10:49:54 INFO - "repository": "", 10:49:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 10:49:54 INFO - "buildid": "20170403094522", 10:49:54 INFO - "pgo_build": "False", 10:49:54 INFO - "basedir": "/builds/slave/test", 10:49:54 INFO - "buildnumber": 35, 10:49:54 INFO - "slavename": "t-yosemite-r7-0371", 10:49:54 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:49:54 INFO - "platform": "yosemite_r7", 10:49:54 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:49:54 INFO - "branch": "mozilla-aurora", 10:49:54 INFO - "repo_path": "releases/mozilla-aurora", 10:49:54 INFO - "revision": "929d6fc313e63aa9775b436659c6207f7de47b6a", 10:49:54 INFO - "stage_platform": "macosx64", 10:49:54 INFO - "builduid": "c277f3fefb3e434e92a8b54ba059badd", 10:49:54 INFO - "slavebuilddir": "test" 10:49:54 INFO - } 10:49:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 10:49:54 INFO - Running post-action listener: _resource_record_post_action 10:49:54 INFO - [mozharness: 2017-04-03 17:49:54.762283Z] Finished read-buildbot-config step (success) 10:49:54 INFO - [mozharness: 2017-04-03 17:49:54.762414Z] Running download-and-extract step. 10:49:54 INFO - Running pre-action listener: _resource_record_pre_action 10:49:54 INFO - Running main action method: download_and_extract 10:49:54 INFO - mkdir: /builds/slave/test/build/tests 10:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:49:54 INFO - trying https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 10:49:54 INFO - Downloading https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 10:49:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 10:49:56 INFO - Downloaded 1199 bytes. 10:49:56 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 10:49:56 INFO - Using the following test package requirements: 10:49:56 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 10:49:56 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:49:56 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 10:49:56 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:49:56 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 10:49:56 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:49:56 INFO - u'jsshell-mac.zip'], 10:49:56 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:49:56 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 10:49:56 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 10:49:56 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:49:56 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 10:49:56 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:49:56 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 10:49:56 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:49:56 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 10:49:56 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:49:56 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 10:49:56 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:49:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 10:49:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:49:56 INFO - Fetch https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 10:49:57 INFO - Expected file size: 51789412 10:49:57 INFO - Obtained file size: 51789412 10:50:13 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 10:50:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 10:50:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:50:13 INFO - Fetch https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 10:50:15 INFO - Expected file size: 51789412 10:50:15 INFO - Obtained file size: 51789412 10:50:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 10:50:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:50:30 INFO - Fetch https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 10:50:31 INFO - Expected file size: 14404438 10:50:31 INFO - Obtained file size: 14404438 10:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:31 INFO - trying https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 10:50:31 INFO - Downloading https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 10:50:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 10:50:34 INFO - Downloaded 74662324 bytes. 10:50:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 10:50:34 INFO - mkdir: /builds/slave/test/properties 10:50:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:50:34 INFO - Writing to file /builds/slave/test/properties/build_url 10:50:34 INFO - Contents: 10:50:34 INFO - build_url:https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 10:50:34 INFO - Running post-action listener: _resource_record_post_action 10:50:34 INFO - Running post-action listener: set_extra_try_arguments 10:50:34 INFO - [mozharness: 2017-04-03 17:50:34.865406Z] Finished download-and-extract step (success) 10:50:34 INFO - [mozharness: 2017-04-03 17:50:34.865537Z] Running populate-webroot step. 10:50:34 INFO - Running pre-action listener: _resource_record_pre_action 10:50:34 INFO - Running main action method: populate_webroot 10:50:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:50:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:50:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:50:34 INFO - '--tppagecycles', 10:50:34 INFO - '7'], 10:50:34 INFO - 'tests': ['tsvgm']}}, 10:50:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:50:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:50:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:50:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:50:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:50:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:50:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:50:34 INFO - 'talos_options': ['--disable-e10s'], 10:50:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:50:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:50:34 INFO - 'talos_options': ['--disable-e10s'], 10:50:34 INFO - 'tests': ['damp', 'tps']}, 10:50:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:50:34 INFO - 'tests': ['damp', 'tps']}, 10:50:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:50:34 INFO - 'tests': ['dromaeo_dom']}, 10:50:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:50:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:50:34 INFO - 'tests': ['basic_compositor_video']}, 10:50:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:50:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:50:34 INFO - 'tests': ['a11yr', 10:50:34 INFO - 'ts_paint', 10:50:34 INFO - 'tpaint', 10:50:34 INFO - 'sessionrestore', 10:50:34 INFO - 'sessionrestore_no_auto_restore', 10:50:34 INFO - 'tabpaint']}, 10:50:34 INFO - 'other-e10s': {'tests': ['a11yr', 10:50:34 INFO - 'ts_paint', 10:50:34 INFO - 'tpaint', 10:50:34 INFO - 'sessionrestore', 10:50:34 INFO - 'sessionrestore_no_auto_restore', 10:50:34 INFO - 'tabpaint']}, 10:50:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:50:34 INFO - 'ts_paint', 10:50:34 INFO - 'tpaint', 10:50:34 INFO - 'sessionrestore', 10:50:34 INFO - 'sessionrestore_no_auto_restore', 10:50:34 INFO - 'tabpaint']}, 10:50:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:50:34 INFO - 'ts_paint', 10:50:34 INFO - 'tpaint', 10:50:34 INFO - 'sessionrestore', 10:50:34 INFO - 'sessionrestore_no_auto_restore', 10:50:34 INFO - 'tabpaint']}, 10:50:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:50:34 INFO - 'tests': ['a11yr', 10:50:34 INFO - 'ts_paint', 10:50:34 INFO - 'tpaint', 10:50:34 INFO - 'sessionrestore', 10:50:34 INFO - 'sessionrestore_no_auto_restore', 10:50:34 INFO - 'tabpaint']}, 10:50:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:50:34 INFO - 'tests': ['a11yr', 10:50:34 INFO - 'ts_paint', 10:50:34 INFO - 'tpaint', 10:50:34 INFO - 'sessionrestore', 10:50:34 INFO - 'sessionrestore_no_auto_restore', 10:50:34 INFO - 'tabpaint']}, 10:50:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:50:34 INFO - 'tests': ['tsvgx', 10:50:34 INFO - 'tsvgr_opacity', 10:50:34 INFO - 'tart', 10:50:34 INFO - 'tscrollx', 10:50:34 INFO - 'cart', 10:50:34 INFO - 'tsvg_static']}, 10:50:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:50:34 INFO - 'tsvgr_opacity', 10:50:34 INFO - 'tart', 10:50:34 INFO - 'tscrollx', 10:50:34 INFO - 'cart', 10:50:34 INFO - 'tsvg_static']}, 10:50:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:50:34 INFO - 'talos_options': ['--disable-e10s'], 10:50:34 INFO - 'tests': ['tp5o']}, 10:50:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:50:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:50:34 INFO - 'talos_options': ['--disable-e10s', 10:50:34 INFO - '--xperf_path', 10:50:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:34 INFO - 'tests': ['tp5n']}, 10:50:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:50:34 INFO - 'talos_options': ['--xperf_path', 10:50:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:34 INFO - 'tests': ['tp5n']}}, 10:50:34 INFO - 'talos.zip': {'path': '', 10:50:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:50:34 INFO - Running post-action listener: _resource_record_post_action 10:50:34 INFO - [mozharness: 2017-04-03 17:50:34.884325Z] Finished populate-webroot step (success) 10:50:34 INFO - [mozharness: 2017-04-03 17:50:34.884439Z] Running create-virtualenv step. 10:50:34 INFO - Running pre-action listener: _resource_record_pre_action 10:50:34 INFO - Running main action method: create_virtualenv 10:50:34 INFO - Creating virtualenv /builds/slave/test/build/venv 10:50:34 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 10:50:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:50:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:50:35 INFO - Using real prefix '/tools/python27' 10:50:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:50:35 INFO - Installing distribute.............................................................................................................................................................................................done. 10:50:38 INFO - Installing pip.................done. 10:50:38 INFO - Return code: 0 10:50:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:50:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:50:38 INFO - Reading from file tmpfile_stdout 10:50:38 INFO - Output received: 10:50:38 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) 10:50:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:50:38 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')]} 10:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:38 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')]} 10:50:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:38 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 0x10597db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105980768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febb24aecb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10575bd30>, '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 0x105682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105750be8>, '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.xstz2FJriY/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.tP19qv1lZe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 10:50:38 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 10:50:38 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 10:50:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xstz2FJriY/Render', 10:50:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:38 INFO - 'HOME': '/Users/cltbld', 10:50:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:38 INFO - 'LOGNAME': 'cltbld', 10:50:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:38 INFO - 'MOZ_NO_REMOTE': '1', 10:50:38 INFO - 'NO_EM_RESTART': '1', 10:50:38 INFO - 'PAGER': '/bin/cat', 10:50:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:38 INFO - 'PWD': '/builds/slave/test', 10:50:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:38 INFO - 'SHELL': '/bin/bash', 10:50:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tP19qv1lZe/Listeners', 10:50:38 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 10:50:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:38 INFO - 'USER': 'cltbld', 10:50:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:38 INFO - 'XPC_FLAGS': '0x0', 10:50:38 INFO - 'XPC_SERVICE_NAME': '0', 10:50:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:39 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 10:50:39 INFO - Cleaning up... 10:50:39 INFO - Return code: 0 10:50:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:50:39 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')]} 10:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:39 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')]} 10:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:39 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 0x10597db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105980768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febb24aecb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10575bd30>, '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 0x105682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105750be8>, '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.xstz2FJriY/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.tP19qv1lZe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 10:50:39 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 10:50:39 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 10:50:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xstz2FJriY/Render', 10:50:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:39 INFO - 'HOME': '/Users/cltbld', 10:50:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:39 INFO - 'LOGNAME': 'cltbld', 10:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:39 INFO - 'MOZ_NO_REMOTE': '1', 10:50:39 INFO - 'NO_EM_RESTART': '1', 10:50:39 INFO - 'PAGER': '/bin/cat', 10:50:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:39 INFO - 'PWD': '/builds/slave/test', 10:50:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:39 INFO - 'SHELL': '/bin/bash', 10:50:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tP19qv1lZe/Listeners', 10:50:39 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 10:50:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:39 INFO - 'USER': 'cltbld', 10:50:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:39 INFO - 'XPC_FLAGS': '0x0', 10:50:39 INFO - 'XPC_SERVICE_NAME': '0', 10:50:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:39 INFO - Downloading/unpacking psutil>=3.1.1 10:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:50:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:42 INFO - Installing collected packages: psutil 10:50:42 INFO - Running setup.py install for psutil 10:50:43 INFO - building 'psutil._psutil_osx' extension 10:50:43 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 10:50:43 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 10:50:43 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 10:50:43 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 10:50:43 INFO - building 'psutil._psutil_posix' extension 10:50:43 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 10:50:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:50:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:50:43 INFO - ^ 10:50:43 INFO - 1 warning generated. 10:50:43 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 10:50:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:43 INFO - Successfully installed psutil 10:50:43 INFO - Cleaning up... 10:50:43 INFO - Return code: 0 10:50:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:44 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')]} 10:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:44 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 0x10597db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105980768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febb24aecb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10575bd30>, '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 0x105682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105750be8>, '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.xstz2FJriY/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.tP19qv1lZe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 10:50:44 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 10:50:44 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 10:50:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xstz2FJriY/Render', 10:50:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:44 INFO - 'HOME': '/Users/cltbld', 10:50:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:44 INFO - 'LOGNAME': 'cltbld', 10:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:44 INFO - 'MOZ_NO_REMOTE': '1', 10:50:44 INFO - 'NO_EM_RESTART': '1', 10:50:44 INFO - 'PAGER': '/bin/cat', 10:50:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:44 INFO - 'PWD': '/builds/slave/test', 10:50:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:44 INFO - 'SHELL': '/bin/bash', 10:50:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tP19qv1lZe/Listeners', 10:50:44 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 10:50:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:44 INFO - 'USER': 'cltbld', 10:50:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:44 INFO - 'XPC_FLAGS': '0x0', 10:50:44 INFO - 'XPC_SERVICE_NAME': '0', 10:50:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:50: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 10:50: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 10:50: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 10:50: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 10:50: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 10:50: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 10:50:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:50:48 INFO - Installing collected packages: mozsystemmonitor 10:50:48 INFO - Running setup.py install for mozsystemmonitor 10:50:48 INFO - Successfully installed mozsystemmonitor 10:50:48 INFO - Cleaning up... 10:50:48 INFO - Return code: 0 10:50:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10597db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105980768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febb24aecb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10575bd30>, '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 0x105682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105750be8>, '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.xstz2FJriY/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.tP19qv1lZe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 10:50:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:50:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xstz2FJriY/Render', 10:50:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:48 INFO - 'HOME': '/Users/cltbld', 10:50:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:48 INFO - 'LOGNAME': 'cltbld', 10:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:48 INFO - 'MOZ_NO_REMOTE': '1', 10:50:48 INFO - 'NO_EM_RESTART': '1', 10:50:48 INFO - 'PAGER': '/bin/cat', 10:50:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:48 INFO - 'PWD': '/builds/slave/test', 10:50:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:48 INFO - 'SHELL': '/bin/bash', 10:50:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tP19qv1lZe/Listeners', 10:50:48 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 10:50:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:48 INFO - 'USER': 'cltbld', 10:50:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:48 INFO - 'XPC_FLAGS': '0x0', 10:50:48 INFO - 'XPC_SERVICE_NAME': '0', 10:50:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:48 INFO - Downloading/unpacking jsonschema==2.5.1 10:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:50:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:50:51 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 10:50:51 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 10:50:51 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 10:50:51 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 10:50:51 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 10:50:51 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 10:50:51 INFO - Downloading functools32-3.2.3-2.tar.gz 10:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:50:51 INFO - warning: no files found matching '*.txt' 10:50:51 INFO - no previously-included directories found matching 'build' 10:50:51 INFO - no previously-included directories found matching 'dist' 10:50:51 INFO - no previously-included directories found matching '.git*' 10:50:51 INFO - Installing collected packages: jsonschema, functools32 10:50:51 INFO - Running setup.py install for functools32 10:50:51 INFO - warning: no files found matching '*.txt' 10:50:51 INFO - no previously-included directories found matching 'build' 10:50:51 INFO - no previously-included directories found matching 'dist' 10:50:51 INFO - no previously-included directories found matching '.git*' 10:50:51 INFO - Successfully installed jsonschema functools32 10:50:51 INFO - Cleaning up... 10:50:52 INFO - Return code: 0 10:50:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:50:52 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')]} 10:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:52 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')]} 10:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:52 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 0x10597db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105980768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febb24aecb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10575bd30>, '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 0x105682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105750be8>, '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.xstz2FJriY/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.tP19qv1lZe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 10:50:52 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 10:50:52 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 10:50:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xstz2FJriY/Render', 10:50:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:52 INFO - 'HOME': '/Users/cltbld', 10:50:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:52 INFO - 'LOGNAME': 'cltbld', 10:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:52 INFO - 'MOZ_NO_REMOTE': '1', 10:50:52 INFO - 'NO_EM_RESTART': '1', 10:50:52 INFO - 'PAGER': '/bin/cat', 10:50:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:52 INFO - 'PWD': '/builds/slave/test', 10:50:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:52 INFO - 'SHELL': '/bin/bash', 10:50:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tP19qv1lZe/Listeners', 10:50:52 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 10:50:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:52 INFO - 'USER': 'cltbld', 10:50:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:52 INFO - 'XPC_FLAGS': '0x0', 10:50:52 INFO - 'XPC_SERVICE_NAME': '0', 10:50:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:50:52 INFO - Cleaning up... 10:50:52 INFO - Return code: 0 10:50:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:50:52 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')]} 10:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:52 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')]} 10:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:52 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 0x10597db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105980768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febb24aecb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10575bd30>, '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 0x105682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105750be8>, '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.xstz2FJriY/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.tP19qv1lZe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 10:50:52 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 10:50:52 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 10:50:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xstz2FJriY/Render', 10:50:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:52 INFO - 'HOME': '/Users/cltbld', 10:50:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:52 INFO - 'LOGNAME': 'cltbld', 10:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:52 INFO - 'MOZ_NO_REMOTE': '1', 10:50:52 INFO - 'NO_EM_RESTART': '1', 10:50:52 INFO - 'PAGER': '/bin/cat', 10:50:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:52 INFO - 'PWD': '/builds/slave/test', 10:50:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:52 INFO - 'SHELL': '/bin/bash', 10:50:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tP19qv1lZe/Listeners', 10:50:52 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 10:50:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:52 INFO - 'USER': 'cltbld', 10:50:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:52 INFO - 'XPC_FLAGS': '0x0', 10:50:52 INFO - 'XPC_SERVICE_NAME': '0', 10:50:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:52 INFO - Downloading/unpacking blobuploader==1.2.4 10:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:55 INFO - Downloading blobuploader-1.2.4.tar.gz 10:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:50:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:50:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:50:56 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 10:50:56 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 10:50:56 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 10:50:56 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 10:50:56 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 10:50:56 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 10:50:56 INFO - Downloading docopt-0.6.1.tar.gz 10:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:50:56 INFO - Installing collected packages: blobuploader, requests, docopt 10:50:56 INFO - Running setup.py install for blobuploader 10:50:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:50:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:50:56 INFO - Running setup.py install for requests 10:50:57 INFO - Running setup.py install for docopt 10:50:57 INFO - Successfully installed blobuploader requests docopt 10:50:57 INFO - Cleaning up... 10:50:57 INFO - Return code: 0 10:50:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50: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')]} 10:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50: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')]} 10:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:57 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 0x10597db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105980768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febb24aecb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10575bd30>, '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 0x105682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105750be8>, '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.xstz2FJriY/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.tP19qv1lZe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 10:50:57 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 10:50:57 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 10:50:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xstz2FJriY/Render', 10:50:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:57 INFO - 'HOME': '/Users/cltbld', 10:50:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:57 INFO - 'LOGNAME': 'cltbld', 10:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:57 INFO - 'MOZ_NO_REMOTE': '1', 10:50:57 INFO - 'NO_EM_RESTART': '1', 10:50:57 INFO - 'PAGER': '/bin/cat', 10:50:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:57 INFO - 'PWD': '/builds/slave/test', 10:50:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:57 INFO - 'SHELL': '/bin/bash', 10:50:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tP19qv1lZe/Listeners', 10:50:57 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 10:50:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:57 INFO - 'USER': 'cltbld', 10:50:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:57 INFO - 'XPC_FLAGS': '0x0', 10:50:57 INFO - 'XPC_SERVICE_NAME': '0', 10:50:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:50:57 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-xsFAkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:50:57 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-7qdDR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:50:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-DqG5WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:50:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-yYiroI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:50:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-OyUSZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:50:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-bcROtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:50:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-h9YM4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:50:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Bj6Jlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:50:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-gKpwpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:50:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-e4Nfpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:50:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Rav3e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:50:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-0_0hvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:50:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-3GFUun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:50:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-BJgfEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-LFkm6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:50:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-GLP018-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:50:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-HWZDql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:50:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:50:59 INFO - Running setup.py install for manifestparser 10:50:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:50:59 INFO - Running setup.py install for mozcrash 10:50:59 INFO - Running setup.py install for mozdebug 10:51:00 INFO - Running setup.py install for mozdevice 10:51:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:51:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:51:00 INFO - Running setup.py install for mozfile 10:51:00 INFO - Running setup.py install for mozhttpd 10:51:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:51:00 INFO - Running setup.py install for mozinfo 10:51:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:51:00 INFO - Running setup.py install for mozInstall 10:51:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:51:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:51:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:51:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:51:00 INFO - Running setup.py install for mozleak 10:51:00 INFO - Running setup.py install for mozlog 10:51:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:51:01 INFO - Running setup.py install for moznetwork 10:51:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:51:01 INFO - Running setup.py install for mozprocess 10:51:01 INFO - Running setup.py install for mozprofile 10:51:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:51:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:51:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:51:01 INFO - Running setup.py install for mozrunner 10:51:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:51:01 INFO - Running setup.py install for mozscreenshot 10:51:01 INFO - Running setup.py install for moztest 10:51:02 INFO - Running setup.py install for mozversion 10:51:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:51:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:51:02 INFO - Cleaning up... 10:51:02 INFO - Return code: 0 10:51:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:02 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')]} 10:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:02 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')]} 10:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:02 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 0x10597db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105980768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febb24aecb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10575bd30>, '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 0x105682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105750be8>, '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.xstz2FJriY/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.tP19qv1lZe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 10:51:02 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 10:51:02 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 10:51:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xstz2FJriY/Render', 10:51:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:02 INFO - 'HOME': '/Users/cltbld', 10:51:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:02 INFO - 'LOGNAME': 'cltbld', 10:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:02 INFO - 'MOZ_NO_REMOTE': '1', 10:51:02 INFO - 'NO_EM_RESTART': '1', 10:51:02 INFO - 'PAGER': '/bin/cat', 10:51:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:02 INFO - 'PWD': '/builds/slave/test', 10:51:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:02 INFO - 'SHELL': '/bin/bash', 10:51:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tP19qv1lZe/Listeners', 10:51:02 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 10:51:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:02 INFO - 'USER': 'cltbld', 10:51:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:02 INFO - 'XPC_FLAGS': '0x0', 10:51:02 INFO - 'XPC_SERVICE_NAME': '0', 10:51:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:02 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-LpnbjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:02 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)) 10:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:02 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-4adOGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:02 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)) 10:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:02 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Rxl2Yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:02 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)) 10:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:02 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-GrNeap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 10:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:02 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-1RJ3x5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:02 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)) 10:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:02 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-q0mJwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:03 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)) 10:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-OvGEwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:03 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)) 10:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-iWEbXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:03 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)) 10:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-c1F3cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:03 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)) 10:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Za4DbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:03 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)) 10:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-LoY1ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:03 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)) 10:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Y7yJYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:03 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)) 10:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-YkcU9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:03 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)) 10:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-doBvW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:03 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)) 10:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-pF7pWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:04 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)) 10:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:04 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-LLx6fF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:04 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)) 10:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:04 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-m4mwTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:04 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)) 10:51:04 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)) 10:51:04 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)) 10:51:04 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)) 10:51:04 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:04 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:04 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 10:51:04 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 10:51:04 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 10:51:04 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 10:51:04 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 10:51:04 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 10:51:07 INFO - Downloading blessings-1.6.tar.gz 10:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:51:07 INFO - Installing collected packages: blessings 10:51:07 INFO - Running setup.py install for blessings 10:51:07 INFO - Successfully installed blessings 10:51:07 INFO - Cleaning up... 10:51:07 INFO - Return code: 0 10:51:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:51:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:07 INFO - Reading from file tmpfile_stdout 10:51:07 INFO - Current package versions: 10:51:07 INFO - blessings == 1.6 10:51:07 INFO - blobuploader == 1.2.4 10:51:07 INFO - docopt == 0.6.1 10:51:07 INFO - functools32 == 3.2.3-2 10:51:07 INFO - jsonschema == 2.5.1 10:51:07 INFO - manifestparser == 1.1 10:51:07 INFO - mozInstall == 1.12 10:51:07 INFO - mozcrash == 1.0 10:51:07 INFO - mozdebug == 0.1 10:51:07 INFO - mozdevice == 0.49 10:51:07 INFO - mozfile == 1.2 10:51:07 INFO - mozhttpd == 0.7 10:51:07 INFO - mozinfo == 0.9 10:51:07 INFO - mozleak == 0.1 10:51:07 INFO - mozlog == 3.4 10:51:07 INFO - moznetwork == 0.27 10:51:07 INFO - mozprocess == 0.25 10:51:07 INFO - mozprofile == 0.28 10:51:07 INFO - mozrunner == 6.13 10:51:07 INFO - mozscreenshot == 0.1 10:51:07 INFO - mozsystemmonitor == 0.3 10:51:07 INFO - moztest == 0.8 10:51:07 INFO - mozversion == 1.4 10:51:07 INFO - psutil == 3.1.1 10:51:07 INFO - requests == 1.2.3 10:51:07 INFO - wsgiref == 0.1.2 10:51:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:07 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 0x10597db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105980768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febb24aecb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10575bd30>, '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 0x105682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105750be8>, '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.xstz2FJriY/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.tP19qv1lZe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 10:51:07 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 10:51:07 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 10:51:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xstz2FJriY/Render', 10:51:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:07 INFO - 'HOME': '/Users/cltbld', 10:51:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:07 INFO - 'LOGNAME': 'cltbld', 10:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:07 INFO - 'MOZ_NO_REMOTE': '1', 10:51:07 INFO - 'NO_EM_RESTART': '1', 10:51:07 INFO - 'PAGER': '/bin/cat', 10:51:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:07 INFO - 'PWD': '/builds/slave/test', 10:51:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:07 INFO - 'SHELL': '/bin/bash', 10:51:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tP19qv1lZe/Listeners', 10:51:07 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 10:51:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:07 INFO - 'USER': 'cltbld', 10:51:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:07 INFO - 'XPC_FLAGS': '0x0', 10:51:07 INFO - 'XPC_SERVICE_NAME': '0', 10:51:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:07 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)) 10:51:07 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)) 10:51:07 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)) 10:51:07 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)) 10:51:07 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)) 10:51:07 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)) 10:51:07 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)) 10:51:07 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)) 10:51:07 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)) 10:51:07 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)) 10:51:07 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)) 10:51:07 INFO - Cleaning up... 10:51:07 INFO - Return code: 0 10:51:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10597db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105980768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febb24aecb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10575bd30>, '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 0x105682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105750be8>, '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.xstz2FJriY/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.tP19qv1lZe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 10:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:51:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xstz2FJriY/Render', 10:51:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:07 INFO - 'HOME': '/Users/cltbld', 10:51:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:07 INFO - 'LOGNAME': 'cltbld', 10:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:07 INFO - 'MOZ_NO_REMOTE': '1', 10:51:07 INFO - 'NO_EM_RESTART': '1', 10:51:07 INFO - 'PAGER': '/bin/cat', 10:51:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:07 INFO - 'PWD': '/builds/slave/test', 10:51:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:07 INFO - 'SHELL': '/bin/bash', 10:51:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tP19qv1lZe/Listeners', 10:51:07 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 10:51:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:07 INFO - 'USER': 'cltbld', 10:51:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:07 INFO - 'XPC_FLAGS': '0x0', 10:51:07 INFO - 'XPC_SERVICE_NAME': '0', 10:51:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:51:08 INFO - Cleaning up... 10:51:08 INFO - Return code: 0 10:51:08 INFO - Running post-action listener: _resource_record_post_action 10:51:08 INFO - Running post-action listener: _start_resource_monitoring 10:51:08 INFO - Starting resource monitoring. 10:51:08 INFO - [mozharness: 2017-04-03 17:51:08.248530Z] Finished create-virtualenv step (success) 10:51:08 INFO - [mozharness: 2017-04-03 17:51:08.249460Z] Running install step. 10:51:08 INFO - Running pre-action listener: _resource_record_pre_action 10:51:08 INFO - Running main action method: install 10:51:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:08 INFO - Reading from file tmpfile_stdout 10:51:08 INFO - Detecting whether we're running mozinstall >=1.0... 10:51:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:51:08 INFO - Reading from file tmpfile_stdout 10:51:08 INFO - Output received: 10:51:08 INFO - Usage: mozinstall [options] installer 10:51:08 INFO - Options: 10:51:08 INFO - -h, --help show this help message and exit 10:51:08 INFO - -d DEST, --destination=DEST 10:51:08 INFO - Directory to install application into. [default: 10:51:08 INFO - "/builds/slave/test"] 10:51:08 INFO - --app=APP Application being installed. [default: firefox] 10:51:08 INFO - mkdir: /builds/slave/test/build/application 10:51:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 10:51:28 INFO - Reading from file tmpfile_stdout 10:51:28 INFO - Output received: 10:51:28 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:51:28 INFO - Running post-action listener: _resource_record_post_action 10:51:28 INFO - [mozharness: 2017-04-03 17:51:28.602583Z] Finished install step (success) 10:51:28 INFO - [mozharness: 2017-04-03 17:51:28.602792Z] Running run-tests step. 10:51:28 INFO - Running pre-action listener: _resource_record_pre_action 10:51:28 INFO - Running main action method: run_tests 10:51:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:51:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:51:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:51:28 INFO - 2017-04-03 10:51:28.617 screenresolution[30038:275170] starting screenresolution argv=screenresolution get 10:51:28 INFO - 2017-04-03 10:51:28.620 screenresolution[30038:275170] Display 0: 1600x1200x32@60 10:51:28 INFO - 2017-04-03 10:51:28.626 screenresolution[30039:275172] starting screenresolution argv=screenresolution list 10:51:28 INFO - Available Modes on Display 0 10:51:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:51:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:51:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:51:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:51:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:51:28 INFO - Intel Iris: 10:51:28 INFO - Chipset Model: Intel Iris 10:51:28 INFO - Type: GPU 10:51:28 INFO - Bus: Built-In 10:51:28 INFO - VRAM (Dynamic, Max): 1536 MB 10:51:28 INFO - Vendor: Intel (0x8086) 10:51:28 INFO - Device ID: 0x0a2e 10:51:28 INFO - Revision ID: 0x0009 10:51:28 INFO - Displays: 10:51:28 INFO - Display: 10:51:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:51:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:51:28 INFO - Display Serial Number: 1600x1200 60 10:51:28 INFO - Main Display: Yes 10:51:28 INFO - Mirror: Off 10:51:28 INFO - Online: Yes 10:51:28 INFO - Rotation: Supported 10:51:28 INFO - Return code: 0 10:51:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:51:28 INFO - Python 2.7.3 10:51:28 INFO - Return code: 0 10:51:28 INFO - grabbing minidump binary from tooltool 10:51: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')]} 10:51:28 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 0x10575bd30>, '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 0x105682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105750be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:51:28 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 10:51:28 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 10:51:28 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 10:51:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:51:28 INFO - Return code: 0 10:51:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:51:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:51:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:51:28 INFO - ENV: RUST_BACKTRACE is now 1 10:51:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:51:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:51:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0371', '--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 10:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0371 --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 10:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xstz2FJriY/Render', 10:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:28 INFO - 'HOME': '/Users/cltbld', 10:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:28 INFO - 'LOGNAME': 'cltbld', 10:51:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:51:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:28 INFO - 'MOZ_NO_REMOTE': '1', 10:51:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:51:28 INFO - 'NO_EM_RESTART': '1', 10:51:28 INFO - 'PAGER': '/bin/cat', 10:51:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:28 INFO - 'PWD': '/builds/slave/test', 10:51:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:28 INFO - 'RUST_BACKTRACE': '1', 10:51:28 INFO - 'SHELL': '/bin/bash', 10:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tP19qv1lZe/Listeners', 10:51:28 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 10:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:28 INFO - 'USER': 'cltbld', 10:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:28 INFO - 'XPC_FLAGS': '0x0', 10:51:28 INFO - 'XPC_SERVICE_NAME': '0', 10:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0371', '--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 10:51:29 INFO - mozversion application_buildid: 20170403094522 10:51:29 INFO - mozversion application_changeset: 929d6fc313e63aa9775b436659c6207f7de47b6a 10:51:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:51:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:51:29 INFO - mozversion application_name: Firefox 10:51:29 INFO - mozversion application_remotingname: firefox-dev 10:51:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:51:29 INFO - mozversion application_vendor: Mozilla 10:51:29 INFO - mozversion application_version: 54.0a2 10:51:29 INFO - mozversion platform_buildid: 20170403094522 10:51:29 INFO - mozversion platform_changeset: 929d6fc313e63aa9775b436659c6207f7de47b6a 10:51:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:51:29 INFO - mozversion platform_version: 54.0a2 10:51:29 INFO - using testdate: 1491241889 10:51:29 INFO - actual date: 1491241889 10:51:29 INFO - starting webserver on 'localhost:49296' 10:51:29 INFO - SUITE-START | Running 2 tests 10:51:29 INFO - TEST-START | dromaeo_css 10:51:29 INFO - operating with platform_type : mac_ 10:51:29 INFO - Initialising browser for dromaeo_css test... 10:51:29 INFO - TEST-INFO | started process 30049 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpkiQgNm/profile http://localhost:49296/getInfo.html) 10:51:32 INFO - PROCESS | 30049 | 2017-04-03 10:51:32.267 plugin-container[30051:275359] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4853, name = 'com.apple.tsm.portname' 10:51:32 INFO - PROCESS | 30049 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:51:32 INFO - PROCESS | 30049 | 2017-04-03 10:51:32.270 plugin-container[30051:275359] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950f, name = 'com.apple.CFPasteboardClient' 10:51:32 INFO - PROCESS | 30049 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:51:32 INFO - PROCESS | 30049 | 2017-04-03 10:51:32.270 plugin-container[30051:275359] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:51:32 INFO - PROCESS | 30049 | __metrics Screen width/height:1600/1200 10:51:32 INFO - PROCESS | 30049 | colorDepth:24 10:51:32 INFO - PROCESS | 30049 | Browser inner width/height: 1024/689 10:51:32 INFO - PROCESS | 30049 | __metrics 10:51:32 ERROR - PROCESS | 30049 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 10:51:33 INFO - TEST-INFO | 30049: exit 0 10:51:33 INFO - Browser initialized. 10:51:33 INFO - Running cycle 1/1 for dromaeo_css test... 10:51:33 INFO - TEST-INFO | started process 30053 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpkiQgNm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:51:35 INFO - PROCESS | 30053 | 2017-04-03 10:51:35.807 plugin-container[30054:275490] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873b, name = 'com.apple.tsm.portname' 10:51:35 INFO - PROCESS | 30053 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:51:35 INFO - PROCESS | 30053 | 2017-04-03 10:51:35.807 plugin-container[30054:275490] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 10:51:35 INFO - PROCESS | 30053 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:51:35 INFO - PROCESS | 30053 | 2017-04-03 10:51:35.807 plugin-container[30054:275490] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:51:45 INFO - PROCESS | 30053 | RSS: Main: 220782592 10:51:45 INFO - PROCESS | 30053 | 10:54:48 INFO - PROCESS | 30053 | Cycle 1(1): loaded http://localhost:49296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49296/tests/dromaeo/cssquery-ext.html) 10:54:50 INFO - PROCESS | 30053 | RSS: Main: 243093504 10:54:50 INFO - PROCESS | 30053 | 10:56:33 INFO - PROCESS | 30053 | ************************* 10:56:33 INFO - PROCESS | 30053 | A coding exception was thrown and uncaught in a Task. 10:56:33 INFO - PROCESS | 30053 | 10:56:33 ERROR - PROCESS | 30053 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:56:33 INFO - PROCESS | 30053 | Full stack: 10:56:33 INFO - PROCESS | 30053 | ************************* 10:57:52 INFO - PROCESS | 30053 | Cycle 1(1): loaded http://localhost:49296/tests/dromaeo/cssquery-ext.html (next: http://localhost:49296/tests/dromaeo/cssquery-jquery.html) 10:57:53 INFO - PROCESS | 30053 | RSS: Main: 251494400 10:57:53 INFO - PROCESS | 30053 | 11:00:55 INFO - PROCESS | 30053 | Cycle 1(1): loaded http://localhost:49296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49296/tests/dromaeo/cssquery-mootools.html) 11:00:55 INFO - PROCESS | 30053 | RSS: Main: 257957888 11:00:55 INFO - PROCESS | 30053 | 11:03:57 INFO - PROCESS | 30053 | Cycle 1(1): loaded http://localhost:49296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49296/tests/dromaeo/cssquery-prototype.html) 11:03:58 INFO - PROCESS | 30053 | RSS: Main: 254119936 11:03:58 INFO - PROCESS | 30053 | 11:07:01 INFO - PROCESS | 30053 | Cycle 1(1): loaded http://localhost:49296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49296/tests/dromaeo/cssquery-yui.html) 11:07:02 INFO - PROCESS | 30053 | RSS: Main: 259805184 11:07:02 INFO - PROCESS | 30053 | 11:10:05 INFO - PROCESS | 30053 | Cycle 1(1): loaded http://localhost:49296/tests/dromaeo/cssquery-yui.html (next: http://localhost:49296/tests/dromaeo/cssquery-dojo.html) 11:10:05 INFO - PROCESS | 30053 | RSS: Main: 255893504 11:10:05 INFO - PROCESS | 30053 | 11:10:05 INFO - PROCESS | 30053 | __start_tp_report 11:10:05 INFO - PROCESS | 30053 | _x_x_mozilla_page_load 11:10:05 INFO - PROCESS | 30053 | _x_x_mozilla_page_load_details 11:10:05 INFO - PROCESS | 30053 | |i|pagename|runs| 11:10:05 INFO - PROCESS | 30053 | |0;dojo.html;3397.6602339766027;3420.17915700232;3428.0915557377284;3430.5540279763636;3439.63883792202;5850.21022162008;5905.527557795377;5993.40065993401;6023.8494037649025;6067.484263837579;5894.528437724983;6008.639481631105;6027.75888964442;6061.818145455643;6065.878682426349;5393.325834270707;5448.264484294629;5451.64564303319;5456.0836028862905;5585.972070139644;4759.7144171349655;5512.228288039658;5519.199716041172;5535.391106978229;5547.611667183299;5265.65773224741;5278.524932756051;5324.307839980797;5419.295491586088;5545.805896793613;5398.595105367093;5425.186222066663;5477.274658482565;5529.364123125812;5551.444855514456;5352.705601191933;5443.455654434564;5455.672659640434;5461.863453413656;5484.588655850827;5652.943470565283;5974.522038236974;6008;6047.395260473962;6094.421030002142;6235.127082208494;6244;6272.717727702218;6283.748650053993;6314.7474101035905;5379.704116273603;5858.8242352729485;6080.145555605539;6440.742370305182;6469.967650161766;6130.29501607312;6137.9079313810325;6165.876682466371;6178.135061091451;6183.412575805291;6230.968845155745;6311.905321420182;6326.114343991845;6520.5435619507125;6542.738290468423;6198.380161983856;6229.1590635264565;6250.718717657716;6260;6264.467520260829;5322.866928326823;6379.840503987438;6384.840378990562;6413;6425.903611445832;6163.907541386883;6200.937990620036;6337.493000559944;6343.746250150035;6352.301246862841;6192.566520343623;6212.689365531705;6243.094751261042;6267.6866156692895;6298.181236439325;4348.782560871944;5118.155504341742;5145.588352931756;5170.276161337416;5213.191955246943;4576.199165146086;4592.3800286961505;4612.60792832613;4616.6537509686905;4625.236835922103;5806.970965145148;5884.0585506318785;5970.432808883149;6151.72317245725;6179.196704428486;6223.471004964629;6281.152044473937;6303.180586523723;6307.810765677037;6334.651594162366;6118.192813661917;6150.04674275488;6150.50795936324;6162.414570615784;6163.599366041193;5731.828045158652;5738.770449181986;5744.253247077853;5745.368009518949;5752.309722833287;6306.432421082033;6353.428191462791;6496.090547323284;6537.346265373615;6702.061711360413;5413.8105166320565;6375.171227740364;6455.225372955276;6491.837704057248;6493.188351456068;6639.601623902581;6711.295313991961;6718.93281067183;6733.932660673527;6742;6148.016317389196;6198.597091189058;6249.8750024998335;6354.078658594571;6360.363963603602;6343.080253363329;6415.037744338387;6417.197850268716;6445.677716114269;6445.967770161119;5077.847664570068;6273.341299163522;6298.401651843067;6299.748010079728;6301.338359472189;6116.785912493041;6153.938460615336;6254.6247225166635;6287.842803929939;6317.084022816758;6002.279726432856;6066.666333351708;6235.968820156052;6244.500439964882;6269.028300613412;6330;6340.651264180515;6343.714532845941;6368.4586810121655;6376.93623063782;6008.24896887889;6097.695115244309;6174.691265436621;6236.875262494634;6258.874822503615 11:10:05 INFO - PROCESS | 30053 | |1;ext.html;743.9956059319919;801.1307731111743;823.1727114250176;950.3680052764912;965.826151292767;38839.25223364948;39643.60356396435;41134.17731645365;41158.17683646325;41243.38134927975;39635.60364396355;39800.80099599498;39856.40215396771;39971;40069;7861.80345491363;8026.879596806052;10591.046805787477;10845.67462976108;10993.560257589726;10690.037896589305;10791.676249712522;10803.729906752316;10809.027187553118;10833.566657333697;9012.8648070279;10812.783744325108;10834.837477437844;10860;10869.891301087007;10760.677179684622;10783.191260655482;10787.460626968621;10795.460226988698;10804.67585972422;10488;10549.41978191199;10550;10564.947175264075;10584.417857017861;34600.65399345999;34809.12977175566;35007.29985400278;35028.82485587581;35055.82472087649;3692.298463291966;3779.1496913194587;3779.225258821935;3784.526934133233;3787.9242415151543;24110.397240068964;24257.636135457982;25275.494490110093;25983.480330393286;26825.92696292146;2968.1401017961366;3024.9546256806166;3099.9070027899197;3127.5465057566753;3129.9530507042414;348592;353454;353736.2313188443;358365;443560.7821960902;44259.893502662046;44382;44565.55434445614;44579.10841783211;44833.77583112129;36067.81966090153;44747;45169.54830451719;45215.869603259525;45420.772896135306;11361;13692.589222323346;13768.967327450482;13816;13836.23900685452;11902.345371004505;11983.28100313984;12023.579174729017;12039.939800301117;12070.698232544257;11857.940710296394;11866.288022718665;11909.344986025679;11984.28094314344;12012.519499219934;4646.6747327686735;5558.86102847424;5582.972085139549;5593.552515798727;5629.943700563023;1039.7868436970402;1060.9787804244027;1102.448775612194;1133.4049623947328;1171.9628129105802;26570.335741606614;26789.330266743098;27127.728722712916;27354.179374618794;27529.174124776287;1220.8412906322121;1238.1613304243192;1246.9875301247052;1263.6651287408845;1268.099649249025;12896.80654790179;13018.828305452365;14030.508932187324;14134.434622615187;14259.500917467838;371758;434243;435043;436553;438488;56392.71803641038;56862.7156864213;56919.43080569224;57016.85966280651;57041.42958570444;1390.65928847431;1443.5524987253775;1447.7973083768281;1456.803331550227;1458.9854101459061;25930.611040834025;26383;26529.867350663124;26787.464250715268;26907.596386054618;47092;47441.52558474509;47538.04923901433;47569.52430475651;47615.28577071278;390902;392309;392903;393808;394040;26322.473550529267;26944.865275673495;27837.304067398476;31698.68301316957;32003.519947200344;44111.11777764491;44765.32852007288;45418.77290613526;45668.55412626578;47129.82175445504;27041;28922.710772892842;30091.247718807204;30894.845525772227;31349.8432507836;29585.556216657198;31388.058358249287;31628.525572116898;31891.65137660512;32039;30985.380292394475;36112.27775444529;36975.81512092422;37468.25063498769;37818.43272350862;31169.68830311668;31190.688093118777;31261.8436907814;31630.525542116426;32401.837990809894;20156.9226496323;24030;25199.49601007933;25269.115580954578;25565.105221317164 11:10:05 INFO - PROCESS | 30053 | |2;jquery.html;400.9719319647625;420.94317267168924;421.13877121286987;429.77436845656035;459.7976890168326;18835.52911177221;20164.19343226271;21363.359099227047;21411.464713382135;21429.892850535743;20189.091490882907;20696.482587935272;20696.896515517437;21050.947452627384;21098.894505527453;6557.344265573441;6832.590044597315;6875.69059392326;6888.862222755542;6892.138482689664;5587.720613969305;6459.709313080923;6709.463242940553;6765.898511522307;6771.356721111511;6490.902636460457;6744.393004629583;6750.324967503235;6773.796786096425;6785.355391237825;6583.5062370322175;6712.194536655584;6717.429018533406;6719.529632925697;6742.966285168567;6294.150289710922;6515.804525864231;6539.47684185264;6620.6358650274215;6625.039369291474;24777;25061.997520099176;25525.85133668971;25694.229173124837;25866.96532138731;2869.9426011479654;2926.1514160893316;2936.324645331564;2940.0738767288235;2953.3059730963205;11995.880041199563;15939.760903586455;16351.509454716377;16551.2551935162;16914.069726165057;2044.6830741235133;2080.583883223361;2082.1983536338466;2130.4141361125658;2131.2540610786255;142152;146781;155597;160899;165122.9999999988;17133.828661713473;19497.805021949884;20628.381148565568;20776.58446831085;21109.26117585908;32165.195870102965;32239.871604493732;32828.86612370188;32859.67140328614;32890.848820291176;8303.750887473385;10081.69754907354;10478.633247836442;10584.88858669844;10774.299670521392;7702.576358300347;8223.21879421454;8719.433236839584;8758.474491530402;8881.511516866634;8221;9684.95157524222;9780.902190978142;9837.065478779505;10042.548085336177;3563.6970857477404;3563.8388091271217;3587.031501494634;4226.450561426995;4406.933895991563;891.0866361979023;896.4576431258995;902.891653001644;935.854942483916;943.3302355327656;17409.390671326444;22058.669119963215;22077.668834967488;22279.331620051424;22333.55332893333;866.9046404895456;937.4890684576922;940.0881145289059;960.5293406231036;966.1015255812022;9874.703758887244;10303.793924121475;10504.632337868137;11229.775404491864;11674.533018679158;735893;754083;756602;765943;774112;131834;147335.26332368483;153603;156665;163522;1188.7860185166753;1189.3161432176532;1228.8709685483075;1239.1264158768047;1243.6082633970088;20000.89999549993;20417.08123134492;20713;20788;20810.791892080884;64249.357506426204;66970.64690795082;67056.66471667611;67325;68593.3140668607;95805;96700.51649741706;97156;97409;98244.50877745566;11399.658010259705;11573.305601663591;11606.709832253924;11668.416579171177;11948.283103013848;12898;12908.96728261718;13186.340682965621;13211.867881321064;13330.333483325989;8236.176382361717;8476.830463390574;9237.290248585143;9395.765105872135;10397.700287464068;9228.492432915986;10861.891381086089;10908.563657453613;11155.05182059534;11188.66434006981;11548.538058477567;11586.942065289957;11809.291442513477;11851.407429628312;11968.037349613782;10738.946305268424;12199.695007624525;12986;13188.142770720257;13296.933515332361;11724.648260552198;11987.280763154238;12034.879651203726;12067.939660301994;12107.51569937228 11:10:05 INFO - PROCESS | 30053 | |3;mootools.html;1222.7248869004482;1404.8173737414136;1525.2450037231565;1564.7731078993547;1570.9842901570985;9496.572654230558;9725.22198224142;10822.24244302899;11506.194566380356;11521.193516453852;10795.892041079587;11127.499262533205;11172.776544469105;11174.720631984204;11480.71298217545;2409.795167410772;2450.791682706972;2458.963115553268;2463.6550882876413;2471.542764588548;1989.7214389985413;2390.1395497620842;2434.5009273099063;2442.3161514775893;2442.804575633954;2411.7347091819884;2416.347586151738;2421.055788242587;2429.259075981825;2437.9756202438016;2364.2670772060546;2377.6552399902002;2378.47673511828;2388.188016074543;2390.9282721518293;2358.8230882683697;2366.0535785685865;2379.262428647125;2379.8691071991034;2391.7249516305674;11356.60251891188;11390.60132895353;11453.656390308304;11545.480453379534;11567.768644627144;4777.474477807438;6019.488343490809;6020;6028.125921741367;6034.306054803666;3418.6923176913947;3441.2601290722614;3481.477778333245;3620.348337299285;3695.8521659133603;1194.1581185264367;1194.569954816274;1200.345811532708;1245.1284101129245;1252.154795513025;15521.146336951464;15689.686206275925;15705.371785128582;15737.685246295125;15750.527484175493;4248.808803603845;4677.585362685259;4944.950550494521;4965.851024469272;5049.343585333957;13208.27354495512;13286.734265314639;13306.600801975956;13313.534026309033;13409.396577154052;5093.159628661304;5823.970880145657;6030.306514750772;6043.48630366415;6048.304444988883;4515.07440974606;5036.496350365008;5293.258943747878;5348.438413966555;5381.919271210857;4089.857525054212;4125.958740412558;4230.830766769356;4242.809073591696;4251.128518653669;1143.188336281233;1145.4215621111287;1149.7183190118474;1150.068444559909;1159.0843233845337;831.5966756123275;919.2855324819164;927.7355953553205;944.5088553951906;952.2334520710895;6450.935490645127;6520.445762110179;6675.499337549606;6724.831879203059;6770.458363330922;858.6822875535967;900.7838118851429;965.1844191658038;1008.5360734062267;1040.469360626071;4254.680898932593;4256.4679415073115;4260.488741351058;4286.39990401344;4384.145091707151;13583.52457663977;14021.369038393297;14045.508407205698;14049.297535123203;14080.436782528584;13581.447298220428;13967.441302347792;13987.650308742363;14007.229602371763;14171.291435428187;10195.796084078425;10488.528016239288;10489.475526223658;10489.685309440729;10525.89474105249;6479.1901012373455;6585.604863708193;6648.90026649591;6673.766418175341;6731.259561448334;12238.877611223774;12512.937435312766;12514.374281285716;12588.118831681695;12650.746985060432;12602.936985315015;12869.549565765154;12873.35633218354;12877.162984405984;12919.031072669399;7636.579988100708;7840.725574604861;8419.452735572168;8504;8825.426347287406;10444.164466842481;10622.044016038593;10668.306560073881;10725.946370268099;10757.13942884583;8886.644534218558;8931.285497160341;8971.192592666692;8995.955020224857;9138.862917056382;8783.736487905373;8802.91197088021;8820.38257322007;8851.46891186531;8872.73381798547;7997.200279971957;8068.878966815385;8124.390670699603;8140.470869393471;8169.142240064708;5892.823215303548;5944.762209511571;5955.880882382415;5989.790357337472;6160.476359509492;5848.64908105515;6013.188219590299;6108.541859360655;6131.294901086254;6158.100162711885 11:10:05 INFO - PROCESS | 30053 | |4;prototype.html;370.54052974311844;382.08871840660015;389.70187806328164;391.94316824060513;398.8085718854949;4568.90862182757;4823.263625094967;5036.98520591763;5260.842174734764;5420.620556561037;4109.609572103012;4587.99064205875;4718.8584342469785;5082.186850103984;5177.534021938025;3667.9092917037165;3756.229972855558;4063.634272915437;4215.777424546878;4271.9572804271875;3982.4026396040535;4125.64838042316;4300.65594752419;4369.453818272716;4369.584889435499;3967.444557761916;4107.055377263231;4126.484189476316;4261.722988005785;4317.395564620955;3827.6937844972335;4302.408108999659;4315.30955047194;4320.805563749623;4332.740035597859;3605.5853576838476;3676.5588129424373;4010.438538604598;4055.918881622351;4062.1672557125717;4162.085440697283;4863.927041094386;5085.364329458817;5119.90084065535;5142.4600416956055;4463.352813842007;4519.367288579601;4758.857234282977;4796.25658023007;4874.463808981045;4806.327114204014;4949.307097006422;5304.946950530484;5365.678059316453;5609.27079479665;3867.6325749053794;3875.7286989910717;3901.752143367167;4424.951169679739;4473.881529617595;4968.726720030397;5236.502532259467;5554;5702;5706.686132262724;3961.950083227947;4231.7672528010635;4445.799939002753;4448.154850578379;4495.303227999665;3761.5486141663177;3956.5449973252867;4124.484439445069;4235.4917409910395;4546.613028160243;4093.467849179647;4694.718316900997;4705.788239529229;4810.5670489656095;5031.647784655112;4852.223644216909;5453.536449401845;5543.77824887;5555.111182210908;5571;1389.9861001390059;1560.9541607123256;1579.9289031993587;1582.6834633073431;1603.9759403608955;1045.4877110216091;1049.5801679328176;1084.6745976207264;1178.4932479034098;1200.3698058519346;5200.193969934666;5203.531682148549;5204.297419848348;5209.609279304067;5237.266782650432;5592.720363981784;5828.843327968679;5833.679147646835;5897.292324921037;5946.286445626552;4733.810647574127;4852.733099679481;4931.728754918442;5072.898542029138;5165.509276618715;2589.52093862636;2665.480231354867;2973.8810447582287;2977.5087110626937;2987.8804847806277;5362.597805164628;5379.67721936685;5627.943720562824;5692.516136128475;5735.684537350402;5543.584231182677;5859.941400586024;5895.616784908967;5911.940880591225;5968.22413086296;5977.372375900555;6002.279726432856;6037.154798328237;6059.1820104286235;6099.662795054327;5182.170852663556;5455.509004189642;5456.017916775018;5502.394736578893;5892.764289428546;4438.2011237976185;5709.8287051388525;5724.4275572444085;5739.7417116229035;5785.884282314246;5177.4822517747925;5763.4812866842185;5798.797042103506;5981.700914954322;6045.848853778691;3702.408314180031;4056.229316429869;4420.270655341833;4459.331100334975;4594.254183410417;5177.637565370388;5353.357597088374;5634.971825140848;5663.904355388532;5896.963064021947;4705.694129881546;5054.418741844588;5404.486573775485;5486.91769623448;5549.916751248816;4863.95136048635;4997.450280469073;5000.624953128603;5594.797118619516;5608.578766952238;4477.798499067485;4815.446223684181;5245.7114858683135;5482.725863706878;5536.695481748542;4494.651604518566;4567.406237189144;4949.604031677385;5568.916466252928;5573.888522229614;5116.74416279192;5456;5484.698341591251;5531.059719847555;5541.778328866801 11:10:05 INFO - PROCESS | 30053 | |5;yui.html;701.8105111619866;738.3207449146785;761.2364144575446;814.8451794159109;860.5611138319457;14534.34595443205;15022.92488537557;15144.318505667245;16104.919475402621;16383.18084095795;14907.92546037271;15057.77413338798;15066.3220155093;15078.3214755336;15092.47176348828;905.4657751926362;915.1900567997337;946.8911075226334;955.0306438964457;956.4978386347154;950.7813202963323;951.5527701980059;952.5903861339622;955.9378640388387;957.5978089202517;1003.5132960514145;1006.7583779892847;1007.0634310091611;1008.7831116309992;1009.9394036357805;985.23644175764;998.7952469743758;1003;1003.2024540490291;1004.2116938203549;732.6556518436327;743.5873090434807;744.0959234530018;745.5861996591889;746.6005686957506;14050.508232211925;16393.83606163935;16405;16816.495505134866;16840.74738878918;13743.862561374459;13785.241811700353;13855.515056973058;13993.30033498321;14047.08693934891;10055.045142973398;11588.947061665867;11776.293422394683;11894.52421903123;11970.102242331859;3561.51919490868;3611.043073585502;3646.781193128421;3664.175560498893;3767.2653832502674;88401.78995525099;112017;113668;113740;114416;10489.947550262352;10767.946160269148;10770.030697237285;10862.293950893167;10929.508172132273;22062.779372206074;22446.214382496535;22959.770402296097;23031.07875684954;23062.423439413815;6559.44244739193;7705.922940770521;7710.074077769209;7730.922690773133;7827.686892524235;4272.401863739079;4322.589354011364;4328.372386004012;4360.280553708666;4445.310976798602;3506.8246587670515;3542.71658267338;3553.129483276614;3575.982120089383;3591.425371940529;644.7711062572813;646.2697152218058;652.8694261147789;660.2440205964144;660.9900851487232;603.5081408651935;671.5601281160848;696.4950410952121;697.6197972105215;700.6146619359332;8911.574148136267;10201.438920859424;10246.59013639461;10460.476976151314;10538.387132158507;651.3942033908415;688.174190970837;705.4004096517918;716.1907789195577;718.1632551421905;4037.40138888198;4611.5619016193405;4835.984443266883;4997.30037794709;5008.29883816266;107343;108663;109253;109282;109787;36771.632283677354;63212;78350;88885;89725.55137224273;67160.32839671736;68476;68779.62440751257;68962;69202;8305.961754780652;9111.635534578807;9674;9862.2603304751;9896.950515247378;29191;43817;43879.34180987351;45365.54634453613;48214.517854821;65759;67184.6640766793;68156;70624.64687676528;70767.64616176886;11280.32318060919;11457.942710286396;12423.937880310541;12619.305938173122;12772.48910043625;14562.781558276847;14827.629309267355;14841.703165936406;15266.465673701367;15777.842221578096;13436;13769.724605508034;13853.861461385257;14255;15002.324895379516;13442.327883605976;13514.459421623025;13964.092333998258;14244.501442449464;14721;13167.144135631153;13460.05779595419;13510.324483775576;13630.591082267549;13772.449102035805;9553;9836.21310295189;9966;10059.49702514886;10060.245481588763;9973.850392243978;11045.558177672803;11327.943360283145;11375.658730238107;11406.657800266004 11:10:05 INFO - PROCESS | 30053 | __end_tp_report 11:10:05 INFO - PROCESS | 30053 | __start_cc_report 11:10:05 INFO - PROCESS | 30053 | _x_x_mozilla_cycle_collect,407 11:10:05 INFO - PROCESS | 30053 | __end_cc_report 11:10:05 INFO - PROCESS | 30053 | __startTimestamp1491243005481__endTimestamp 11:10:05 INFO - PROCESS | 30053 | 11:10:05 INFO - PROCESS | 30053 | ------- Summary: start ------- 11:10:05 INFO - PROCESS | 30053 | Number of tests: 6 11:10:05 INFO - PROCESS | 30053 | 11:10:05 INFO - PROCESS | 30053 | [#0] dojo.html Cycles:165 Average:5913.14 Median:6162.41 stddev:654.28 (10.6%) stddev-sans-first:625.83 11:10:05 INFO - PROCESS | 30053 | Values: 3397.7 3420.2 3428.1 3430.6 3439.6 5850.2 5905.5 5993.4 6023.8 6067.5 5894.5 6008.6 6027.8 6061.8 6065.9 5393.3 5448.3 5451.6 5456.1 5586.0 4759.7 5512.2 5519.2 5535.4 5547.6 5265.7 5278.5 5324.3 5419.3 5545.8 5398.6 5425.2 5477.3 5529.4 5551.4 5352.7 5443.5 5455.7 5461.9 5484.6 5652.9 5974.5 6008.0 6047.4 6094.4 6235.1 6244.0 6272.7 6283.7 6314.7 5379.7 5858.8 6080.1 6440.7 6470.0 6130.3 6137.9 6165.9 6178.1 6183.4 6231.0 6311.9 6326.1 6520.5 6542.7 6198.4 6229.2 6250.7 6260.0 6264.5 5322.9 6379.8 6384.8 6413.0 6425.9 6163.9 6200.9 6337.5 6343.7 6352.3 6192.6 6212.7 6243.1 6267.7 6298.2 4348.8 5118.2 5145.6 5170.3 5213.2 4576.2 4592.4 4612.6 4616.7 4625.2 5807.0 5884.1 5970.4 6151.7 6179.2 6223.5 6281.2 6303.2 6307.8 6334.7 6118.2 6150.0 6150.5 6162.4 6163.6 5731.8 5738.8 5744.3 5745.4 5752.3 6306.4 6353.4 6496.1 6537.3 6702.1 5413.8 6375.2 6455.2 6491.8 6493.2 6639.6 6711.3 6718.9 6733.9 6742.0 6148.0 6198.6 6249.9 6354.1 6360.4 6343.1 6415.0 6417.2 6445.7 6446.0 5077.8 6273.3 6298.4 6299.7 6301.3 6116.8 6153.9 6254.6 6287.8 6317.1 6002.3 6066.7 6236.0 6244.5 6269.0 6330.0 6340.7 6343.7 6368.5 6376.9 6008.2 6097.7 6174.7 6236.9 6258.9 11:10:05 INFO - PROCESS | 30053 | 11:10:05 INFO - PROCESS | 30053 | [#1] ext.html Cycles:180 Average:53349.19 Median:31226.27 stddev:105137.07 (336.7%) stddev-sans-first:105357.82 11:10:05 INFO - PROCESS | 30053 | Values: 744.0 801.1 823.2 950.4 965.8 38839.3 39643.6 41134.2 41158.2 41243.4 39635.6 39800.8 39856.4 39971.0 40069.0 7861.8 8026.9 10591.0 10845.7 10993.6 10690.0 10791.7 10803.7 10809.0 10833.6 9012.9 10812.8 10834.8 10860.0 10869.9 10760.7 10783.2 10787.5 10795.5 10804.7 10488.0 10549.4 10550.0 10564.9 10584.4 34600.7 34809.1 35007.3 35028.8 35055.8 3692.3 3779.1 3779.2 3784.5 3787.9 24110.4 24257.6 25275.5 25983.5 26825.9 2968.1 3025.0 3099.9 3127.5 3130.0 348592.0 353454.0 353736.2 358365.0 443560.8 44259.9 44382.0 44565.6 44579.1 44833.8 36067.8 44747.0 45169.5 45215.9 45420.8 11361.0 13692.6 13769.0 13816.0 13836.2 11902.3 11983.3 12023.6 12039.9 12070.7 11857.9 11866.3 11909.3 11984.3 12012.5 4646.7 5558.9 5583.0 5593.6 5629.9 1039.8 1061.0 1102.4 1133.4 1172.0 26570.3 26789.3 27127.7 27354.2 27529.2 1220.8 1238.2 1247.0 1263.7 1268.1 12896.8 13018.8 14030.5 14134.4 14259.5 371758.0 434243.0 435043.0 436553.0 438488.0 56392.7 56862.7 56919.4 57016.9 57041.4 1390.7 1443.6 1447.8 1456.8 1459.0 25930.6 26383.0 26529.9 26787.5 26907.6 47092.0 47441.5 47538.0 47569.5 47615.3 390902.0 392309.0 392903.0 393808.0 394040.0 26322.5 26944.9 27837.3 31698.7 32003.5 44111.1 44765.3 45418.8 45668.6 47129.8 27041.0 28922.7 30091.2 30894.8 31349.8 29585.6 31388.1 31628.5 31891.7 32039.0 30985.4 36112.3 36975.8 37468.3 37818.4 31169.7 31190.7 31261.8 31630.5 32401.8 20156.9 24030.0 25199.5 25269.1 25565.1 11:10:05 INFO - PROCESS | 30053 | 11:10:05 INFO - PROCESS | 30053 | [#2] jquery.html Cycles:180 Average:43542.93 Median:25293.92 stddev:126360.65 (499.6%) stddev-sans-first:126673.60 11:10:05 INFO - PROCESS | 30053 | Values: 401.0 420.9 421.1 429.8 459.8 18835.5 20164.2 21363.4 21411.5 21429.9 20189.1 20696.5 20696.9 21050.9 21098.9 6557.3 6832.6 6875.7 6888.9 6892.1 5587.7 6459.7 6709.5 6765.9 6771.4 6490.9 6744.4 6750.3 6773.8 6785.4 6583.5 6712.2 6717.4 6719.5 6743.0 6294.2 6515.8 6539.5 6620.6 6625.0 24777.0 25062.0 25525.9 25694.2 25867.0 2869.9 2926.2 2936.3 2940.1 2953.3 11995.9 15939.8 16351.5 16551.3 16914.1 2044.7 2080.6 2082.2 2130.4 2131.3 142152.0 146781.0 155597.0 160899.0 165123.0 17133.8 19497.8 20628.4 20776.6 21109.3 32165.2 32239.9 32828.9 32859.7 32890.8 8303.8 10081.7 10478.6 10584.9 10774.3 7702.6 8223.2 8719.4 8758.5 8881.5 8221.0 9685.0 9780.9 9837.1 10042.5 3563.7 3563.8 3587.0 4226.5 4406.9 891.1 896.5 902.9 935.9 943.3 17409.4 22058.7 22077.7 22279.3 22333.6 866.9 937.5 940.1 960.5 966.1 9874.7 10303.8 10504.6 11229.8 11674.5 735893.0 754083.0 756602.0 765943.0 774112.0 131834.0 147335.3 153603.0 156665.0 163522.0 1188.8 1189.3 1228.9 1239.1 1243.6 20000.9 20417.1 20713.0 20788.0 20810.8 64249.4 66970.6 67056.7 67325.0 68593.3 95805.0 96700.5 97156.0 97409.0 98244.5 11399.7 11573.3 11606.7 11668.4 11948.3 12898.0 12909.0 13186.3 13211.9 13330.3 8236.2 8476.8 9237.3 9395.8 10397.7 9228.5 10861.9 10908.6 11155.1 11188.7 11548.5 11586.9 11809.3 11851.4 11968.0 10738.9 12199.7 12986.0 13188.1 13296.9 11724.6 11987.3 12034.9 12067.9 12107.5 11:10:05 INFO - PROCESS | 30053 | 11:10:05 INFO - PROCESS | 30053 | [#3] mootools.html Cycles:180 Average:6864.44 Median:2446.80 stddev:4362.72 (178.3%) stddev-sans-first:4354.36 11:10:05 INFO - PROCESS | 30053 | Values: 1222.7 1404.8 1525.2 1564.8 1571.0 9496.6 9725.2 10822.2 11506.2 11521.2 10795.9 11127.5 11172.8 11174.7 11480.7 2409.8 2450.8 2459.0 2463.7 2471.5 1989.7 2390.1 2434.5 2442.3 2442.8 2411.7 2416.3 2421.1 2429.3 2438.0 2364.3 2377.7 2378.5 2388.2 2390.9 2358.8 2366.1 2379.3 2379.9 2391.7 11356.6 11390.6 11453.7 11545.5 11567.8 4777.5 6019.5 6020.0 6028.1 6034.3 3418.7 3441.3 3481.5 3620.3 3695.9 1194.2 1194.6 1200.3 1245.1 1252.2 15521.1 15689.7 15705.4 15737.7 15750.5 4248.8 4677.6 4945.0 4965.9 5049.3 13208.3 13286.7 13306.6 13313.5 13409.4 5093.2 5824.0 6030.3 6043.5 6048.3 4515.1 5036.5 5293.3 5348.4 5381.9 4089.9 4126.0 4230.8 4242.8 4251.1 1143.2 1145.4 1149.7 1150.1 1159.1 831.6 919.3 927.7 944.5 952.2 6450.9 6520.4 6675.5 6724.8 6770.5 858.7 900.8 965.2 1008.5 1040.5 4254.7 4256.5 4260.5 4286.4 4384.1 13583.5 14021.4 14045.5 14049.3 14080.4 13581.4 13967.4 13987.7 14007.2 14171.3 10195.8 10488.5 10489.5 10489.7 10525.9 6479.2 6585.6 6648.9 6673.8 6731.3 12238.9 12512.9 12514.4 12588.1 12650.7 12602.9 12869.5 12873.4 12877.2 12919.0 7636.6 7840.7 8419.5 8504.0 8825.4 10444.2 10622.0 10668.3 10725.9 10757.1 8886.6 8931.3 8971.2 8996.0 9138.9 8783.7 8802.9 8820.4 8851.5 8872.7 7997.2 8068.9 8124.4 8140.5 8169.1 5892.8 5944.8 5955.9 5989.8 6160.5 5848.6 6013.2 6108.5 6131.3 6158.1 11:10:05 INFO - PROCESS | 30053 | 11:10:05 INFO - PROCESS | 30053 | [#4] prototype.html Cycles:180 Average:4580.24 Median:4869.21 stddev:1305.41 (26.8%) stddev-sans-first:1270.26 11:10:05 INFO - PROCESS | 30053 | Values: 370.5 382.1 389.7 391.9 398.8 4568.9 4823.3 5037.0 5260.8 5420.6 4109.6 4588.0 4718.9 5082.2 5177.5 3667.9 3756.2 4063.6 4215.8 4272.0 3982.4 4125.6 4300.7 4369.5 4369.6 3967.4 4107.1 4126.5 4261.7 4317.4 3827.7 4302.4 4315.3 4320.8 4332.7 3605.6 3676.6 4010.4 4055.9 4062.2 4162.1 4863.9 5085.4 5119.9 5142.5 4463.4 4519.4 4758.9 4796.3 4874.5 4806.3 4949.3 5304.9 5365.7 5609.3 3867.6 3875.7 3901.8 4425.0 4473.9 4968.7 5236.5 5554.0 5702.0 5706.7 3962.0 4231.8 4445.8 4448.2 4495.3 3761.5 3956.5 4124.5 4235.5 4546.6 4093.5 4694.7 4705.8 4810.6 5031.6 4852.2 5453.5 5543.8 5555.1 5571.0 1390.0 1561.0 1579.9 1582.7 1604.0 1045.5 1049.6 1084.7 1178.5 1200.4 5200.2 5203.5 5204.3 5209.6 5237.3 5592.7 5828.8 5833.7 5897.3 5946.3 4733.8 4852.7 4931.7 5072.9 5165.5 2589.5 2665.5 2973.9 2977.5 2987.9 5362.6 5379.7 5627.9 5692.5 5735.7 5543.6 5859.9 5895.6 5911.9 5968.2 5977.4 6002.3 6037.2 6059.2 6099.7 5182.2 5455.5 5456.0 5502.4 5892.8 4438.2 5709.8 5724.4 5739.7 5785.9 5177.5 5763.5 5798.8 5981.7 6045.8 3702.4 4056.2 4420.3 4459.3 4594.3 5177.6 5353.4 5635.0 5663.9 5897.0 4705.7 5054.4 5404.5 5486.9 5549.9 4864.0 4997.5 5000.6 5594.8 5608.6 4477.8 4815.4 5245.7 5482.7 5536.7 4494.7 4567.4 4949.6 5568.9 5573.9 5116.7 5456.0 5484.7 5531.1 5541.8 11:10:05 INFO - PROCESS | 30053 | 11:10:05 INFO - PROCESS | 30053 | [#5] yui.html Cycles:180 Average:19818.83 Median:3557.32 stddev:28676.74 (806.1%) stddev-sans-first:28721.26 11:10:05 INFO - PROCESS | 30053 | Values: 701.8 738.3 761.2 814.8 860.6 14534.3 15022.9 15144.3 16104.9 16383.2 14907.9 15057.8 15066.3 15078.3 15092.5 905.5 915.2 946.9 955.0 956.5 950.8 951.6 952.6 955.9 957.6 1003.5 1006.8 1007.1 1008.8 1009.9 985.2 998.8 1003.0 1003.2 1004.2 732.7 743.6 744.1 745.6 746.6 14050.5 16393.8 16405.0 16816.5 16840.7 13743.9 13785.2 13855.5 13993.3 14047.1 10055.0 11588.9 11776.3 11894.5 11970.1 3561.5 3611.0 3646.8 3664.2 3767.3 88401.8 112017.0 113668.0 113740.0 114416.0 10489.9 10767.9 10770.0 10862.3 10929.5 22062.8 22446.2 22959.8 23031.1 23062.4 6559.4 7705.9 7710.1 7730.9 7827.7 4272.4 4322.6 4328.4 4360.3 4445.3 3506.8 3542.7 3553.1 3576.0 3591.4 644.8 646.3 652.9 660.2 661.0 603.5 671.6 696.5 697.6 700.6 8911.6 10201.4 10246.6 10460.5 10538.4 651.4 688.2 705.4 716.2 718.2 4037.4 4611.6 4836.0 4997.3 5008.3 107343.0 108663.0 109253.0 109282.0 109787.0 36771.6 63212.0 78350.0 88885.0 89725.6 67160.3 68476.0 68779.6 68962.0 69202.0 8306.0 9111.6 9674.0 9862.3 9897.0 29191.0 43817.0 43879.3 45365.5 48214.5 65759.0 67184.7 68156.0 70624.6 70767.6 11280.3 11457.9 12423.9 12619.3 12772.5 14562.8 14827.6 14841.7 15266.5 15777.8 13436.0 13769.7 13853.9 14255.0 15002.3 13442.3 13514.5 13964.1 14244.5 14721.0 13167.1 13460.1 13510.3 13630.6 13772.4 9553.0 9836.2 9966.0 10059.5 10060.2 9973.9 11045.6 11327.9 11375.7 11406.7 11:10:05 INFO - PROCESS | 30053 | -------- Summary: end -------- 11:10:05 INFO - PROCESS | 30053 | 11:10:06 INFO - TEST-INFO | 30053: exit 0 11:10:06 INFO - TEST-OK | dromaeo_css | took 1116968ms 11:10:06 INFO - TEST-START | kraken 11:10:06 INFO - operating with platform_type : mac_ 11:10:06 INFO - Initialising browser for kraken test... 11:10:06 INFO - TEST-INFO | started process 30062 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpLM538a/profile http://localhost:49296/getInfo.html) 11:10:09 INFO - PROCESS | 30062 | 2017-04-03 11:10:09.113 plugin-container[30063:277683] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 11:10:09 INFO - PROCESS | 30062 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:10:09 INFO - PROCESS | 30062 | 2017-04-03 11:10:09.118 plugin-container[30063:277683] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c1b, name = 'com.apple.CFPasteboardClient' 11:10:09 INFO - PROCESS | 30062 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:10:09 INFO - PROCESS | 30062 | 2017-04-03 11:10:09.118 plugin-container[30063:277683] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:10:09 INFO - PROCESS | 30062 | __metrics Screen width/height:1600/1200 11:10:09 INFO - PROCESS | 30062 | colorDepth:24 11:10:09 INFO - PROCESS | 30062 | Browser inner width/height: 1024/689 11:10:09 INFO - PROCESS | 30062 | __metrics 11:10:09 ERROR - PROCESS | 30062 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 11:10:09 INFO - TEST-INFO | 30062: exit 0 11:10:09 INFO - Browser initialized. 11:10:09 INFO - Running cycle 1/1 for kraken test... 11:10:09 INFO - TEST-INFO | started process 30064 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpLM538a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:12 INFO - PROCESS | 30064 | 2017-04-03 11:10:12.467 plugin-container[30065:277810] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x453f, name = 'com.apple.tsm.portname' 11:10:12 INFO - PROCESS | 30064 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:10:12 INFO - PROCESS | 30064 | 2017-04-03 11:10:12.468 plugin-container[30065:277810] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 11:10:12 INFO - PROCESS | 30064 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:10:12 INFO - PROCESS | 30064 | 2017-04-03 11:10:12.468 plugin-container[30065:277810] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:10:22 INFO - PROCESS | 30064 | RSS: Main: 220778496 11:10:22 INFO - PROCESS | 30064 | 11:10:25 INFO - PROCESS | 30064 | Cycle 1(1): loaded http://localhost:49296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49296/tests/kraken/driver.html?testName=audio-beat-detection) 11:10:26 INFO - PROCESS | 30064 | RSS: Main: 235331584 11:10:26 INFO - PROCESS | 30064 | 11:10:29 INFO - PROCESS | 30064 | Cycle 1(1): loaded http://localhost:49296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49296/tests/kraken/driver.html?testName=audio-dft) 11:10:29 INFO - PROCESS | 30064 | RSS: Main: 243204096 11:10:29 INFO - PROCESS | 30064 | 11:10:33 INFO - PROCESS | 30064 | Cycle 1(1): loaded http://localhost:49296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49296/tests/kraken/driver.html?testName=audio-fft) 11:10:33 INFO - PROCESS | 30064 | RSS: Main: 246697984 11:10:33 INFO - PROCESS | 30064 | 11:10:35 INFO - PROCESS | 30064 | Cycle 1(1): loaded http://localhost:49296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49296/tests/kraken/driver.html?testName=audio-oscillator) 11:10:36 INFO - PROCESS | 30064 | RSS: Main: 248274944 11:10:36 INFO - PROCESS | 30064 | 11:10:38 INFO - PROCESS | 30064 | Cycle 1(1): loaded http://localhost:49296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:10:39 INFO - PROCESS | 30064 | RSS: Main: 248274944 11:10:39 INFO - PROCESS | 30064 | 11:10:42 INFO - PROCESS | 30064 | Cycle 1(1): loaded http://localhost:49296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49296/tests/kraken/driver.html?testName=imaging-darkroom) 11:10:43 INFO - PROCESS | 30064 | RSS: Main: 252440576 11:10:43 INFO - PROCESS | 30064 | 11:10:46 INFO - PROCESS | 30064 | Cycle 1(1): loaded http://localhost:49296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49296/tests/kraken/driver.html?testName=imaging-desaturate) 11:10:46 INFO - PROCESS | 30064 | RSS: Main: 252006400 11:10:46 INFO - PROCESS | 30064 | 11:10:50 INFO - PROCESS | 30064 | Cycle 1(1): loaded http://localhost:49296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49296/tests/kraken/driver.html?testName=json-parse-financial) 11:10:50 INFO - PROCESS | 30064 | RSS: Main: 251994112 11:10:50 INFO - PROCESS | 30064 | 11:10:52 INFO - PROCESS | 30064 | Cycle 1(1): loaded http://localhost:49296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:10:53 INFO - PROCESS | 30064 | RSS: Main: 252014592 11:10:53 INFO - PROCESS | 30064 | 11:10:55 INFO - PROCESS | 30064 | Cycle 1(1): loaded http://localhost:49296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49296/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:10:55 INFO - PROCESS | 30064 | RSS: Main: 251977728 11:10:55 INFO - PROCESS | 30064 | 11:10:57 INFO - PROCESS | 30064 | Cycle 1(1): loaded http://localhost:49296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:10:58 INFO - PROCESS | 30064 | RSS: Main: 252022784 11:10:58 INFO - PROCESS | 30064 | 11:11:01 INFO - PROCESS | 30064 | Cycle 1(1): loaded http://localhost:49296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:11:02 INFO - PROCESS | 30064 | RSS: Main: 252440576 11:11:02 INFO - PROCESS | 30064 | 11:11:05 INFO - PROCESS | 30064 | Cycle 1(1): loaded http://localhost:49296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:11:05 INFO - PROCESS | 30064 | RSS: Main: 252162048 11:11:05 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | Cycle 1(1): loaded http://localhost:49296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49296/tests/kraken/driver.html?testName=ai-astar) 11:11:07 INFO - PROCESS | 30064 | RSS: Main: 255803392 11:11:07 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | __start_tp_report 11:11:07 INFO - PROCESS | 30064 | _x_x_mozilla_page_load 11:11:07 INFO - PROCESS | 30064 | _x_x_mozilla_page_load_details 11:11:07 INFO - PROCESS | 30064 | |i|pagename|runs| 11:11:07 INFO - PROCESS | 30064 | |0;ai-astar;132;176;176;147;176;147;117;115;121;175 11:11:07 INFO - PROCESS | 30064 | |1;audio-beat-detection;184;143;142;141;112;101;144;97;165;147 11:11:07 INFO - PROCESS | 30064 | |2;audio-dft;202;196;206;199;196;201;194;194;195;194 11:11:07 INFO - PROCESS | 30064 | |3;audio-fft;75;55;53;83;62;90;142;72;66;77 11:11:07 INFO - PROCESS | 30064 | |4;audio-oscillator;91;71;87;71;72;69;82;75;104;116 11:11:07 INFO - PROCESS | 30064 | |5;imaging-gaussian-blur;137;123;91;138;78;138;139;89;88;81 11:11:07 INFO - PROCESS | 30064 | |6;imaging-darkroom;95;97;95;96;98;114;151;108;140;153 11:11:07 INFO - PROCESS | 30064 | |7;imaging-desaturate;148;151;91;91;91;93;95;116;148;107 11:11:07 INFO - PROCESS | 30064 | |8;json-parse-financial;67;67;69;73;104;69;70;107;110;110 11:11:07 INFO - PROCESS | 30064 | |9;json-stringify-tinderbox;58;63;54;63;62;58;57;59;59;59 11:11:07 INFO - PROCESS | 30064 | |10;stanford-crypto-aes;92;93;87;87;86;87;84;84;84;88 11:11:07 INFO - PROCESS | 30064 | |11;stanford-crypto-ccm;145;163;150;148;147;136;173;165;208;159 11:11:07 INFO - PROCESS | 30064 | |12;stanford-crypto-pbkdf2;168;168;173;167;171;175;168;166;172;168 11:11:07 INFO - PROCESS | 30064 | |13;stanford-crypto-sha256-iterative;58;64;81;69;66;68;64;64;71;64 11:11:07 INFO - PROCESS | 30064 | __end_tp_report 11:11:07 INFO - PROCESS | 30064 | __start_cc_report 11:11:07 INFO - PROCESS | 30064 | _x_x_mozilla_cycle_collect,1029 11:11:07 INFO - PROCESS | 30064 | __end_cc_report 11:11:07 INFO - PROCESS | 30064 | __startTimestamp1491243067809__endTimestamp 11:11:07 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | ------- Summary: start ------- 11:11:07 INFO - PROCESS | 30064 | Number of tests: 14 11:11:07 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | [#0] ai-astar Cycles:10 Average:148.20 Median:161.00 stddev:26.07 (16.2%) stddev-sans-first:26.99 11:11:07 INFO - PROCESS | 30064 | Values: 132.0 176.0 176.0 147.0 176.0 147.0 117.0 115.0 121.0 175.0 11:11:07 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:145.50 stddev:27.36 (18.8%) stddev-sans-first:23.30 11:11:07 INFO - PROCESS | 30064 | Values: 184.0 143.0 142.0 141.0 112.0 101.0 144.0 97.0 165.0 147.0 11:11:07 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | [#2] audio-dft Cycles:10 Average:197.70 Median:197.50 stddev:4.14 (2.1%) stddev-sans-first:4.09 11:11:07 INFO - PROCESS | 30064 | Values: 202.0 196.0 206.0 199.0 196.0 201.0 194.0 194.0 195.0 194.0 11:11:07 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | [#3] audio-fft Cycles:10 Average:77.50 Median:73.50 stddev:25.52 (34.7%) stddev-sans-first:27.05 11:11:07 INFO - PROCESS | 30064 | Values: 75.0 55.0 53.0 83.0 62.0 90.0 142.0 72.0 66.0 77.0 11:11:07 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | [#4] audio-oscillator Cycles:10 Average:83.80 Median:73.50 stddev:15.89 (21.6%) stddev-sans-first:16.64 11:11:07 INFO - PROCESS | 30064 | Values: 91.0 71.0 87.0 71.0 72.0 69.0 82.0 75.0 104.0 116.0 11:11:07 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:79.50 stddev:26.79 (33.7%) stddev-sans-first:26.60 11:11:07 INFO - PROCESS | 30064 | Values: 137.0 123.0 91.0 138.0 78.0 138.0 139.0 89.0 88.0 81.0 11:11:07 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | [#6] imaging-darkroom Cycles:10 Average:114.70 Median:95.00 stddev:24.01 (25.3%) stddev-sans-first:24.38 11:11:07 INFO - PROCESS | 30064 | Values: 95.0 97.0 95.0 96.0 98.0 114.0 151.0 108.0 140.0 153.0 11:11:07 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | [#7] imaging-desaturate Cycles:10 Average:113.10 Median:91.00 stddev:26.07 (28.6%) stddev-sans-first:24.40 11:11:07 INFO - PROCESS | 30064 | Values: 148.0 151.0 91.0 91.0 91.0 93.0 95.0 116.0 148.0 107.0 11:11:07 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | [#8] json-parse-financial Cycles:10 Average:84.60 Median:68.00 stddev:20.06 (29.5%) stddev-sans-first:20.24 11:11:07 INFO - PROCESS | 30064 | Values: 67.0 67.0 69.0 73.0 104.0 69.0 70.0 107.0 110.0 110.0 11:11:07 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:2.82 (4.8%) stddev-sans-first:2.96 11:11:07 INFO - PROCESS | 30064 | Values: 58.0 63.0 54.0 63.0 62.0 58.0 57.0 59.0 59.0 59.0 11:11:07 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.00 stddev:3.16 (3.6%) stddev-sans-first:2.83 11:11:07 INFO - PROCESS | 30064 | Values: 92.0 93.0 87.0 87.0 86.0 87.0 84.0 84.0 84.0 88.0 11:11:07 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | [#11] stanford-crypto-ccm Cycles:10 Average:159.40 Median:161.00 stddev:20.33 (12.6%) stddev-sans-first:20.88 11:11:07 INFO - PROCESS | 30064 | Values: 145.0 163.0 150.0 148.0 147.0 136.0 173.0 165.0 208.0 159.0 11:11:07 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:169.50 stddev:2.95 (1.7%) stddev-sans-first:3.07 11:11:07 INFO - PROCESS | 30064 | Values: 168.0 168.0 173.0 167.0 171.0 175.0 168.0 166.0 172.0 168.0 11:11:07 INFO - PROCESS | 30064 | 11:11:07 INFO - PROCESS | 30064 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:6.10 (9.1%) stddev-sans-first:5.56 11:11:07 INFO - PROCESS | 30064 | Values: 58.0 64.0 81.0 69.0 66.0 68.0 64.0 64.0 71.0 64.0 11:11:07 INFO - PROCESS | 30064 | -------- Summary: end -------- 11:11:07 INFO - PROCESS | 30064 | 11:11:08 INFO - TEST-INFO | 30064: exit 0 11:11:08 INFO - TEST-OK | kraken | took 62716ms 11:11:08 INFO - SUITE-END | took 1179s 11:11:08 INFO - Completed test suite (00:19:39) 11:11:08 INFO - javascript benchmark 11:11:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7684.311645989212, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3397.6602339766027, 3420.17915700232, 3428.0915557377284, 3430.5540279763636, 3439.63883792202, 5850.21022162008, 5905.527557795377, 5993.40065993401, 6023.8494037649025, 6067.484263837579, 5894.528437724983, 6008.639481631105, 6027.75888964442, 6061.818145455643, 6065.878682426349, 5393.325834270707, 5448.264484294629, 5451.64564303319, 5456.0836028862905, 5585.972070139644, 4759.7144171349655, 5512.228288039658, 5519.199716041172, 5535.391106978229, 5547.611667183299, 5265.65773224741, 5278.524932756051, 5324.307839980797, 5419.295491586088, 5545.805896793613, 5398.595105367093, 5425.186222066663, 5477.274658482565, 5529.364123125812, 5551.444855514456, 5352.705601191933, 5443.455654434564, 5455.672659640434, 5461.863453413656, 5484.588655850827, 5652.943470565283, 5974.522038236974, 6008.0, 6047.395260473962, 6094.421030002142, 6235.127082208494, 6244.0, 6272.717727702218, 6283.748650053993, 6314.7474101035905, 5379.704116273603, 5858.8242352729485, 6080.145555605539, 6440.742370305182, 6469.967650161766, 6130.29501607312, 6137.9079313810325, 6165.876682466371, 6178.135061091451, 6183.412575805291, 6230.968845155745, 6311.905321420182, 6326.114343991845, 6520.5435619507125, 6542.738290468423, 6198.380161983856, 6229.1590635264565, 6250.718717657716, 6260.0, 6264.467520260829, 5322.866928326823, 6379.840503987438, 6384.840378990562, 6413.0, 6425.903611445832, 6163.907541386883, 6200.937990620036, 6337.493000559944, 6343.746250150035, 6352.301246862841, 6192.566520343623, 6212.689365531705, 6243.094751261042, 6267.6866156692895, 6298.181236439325, 4348.782560871944, 5118.155504341742, 5145.588352931756, 5170.276161337416, 5213.191955246943, 4576.199165146086, 4592.3800286961505, 4612.60792832613, 4616.6537509686905, 4625.236835922103, 5806.970965145148, 5884.0585506318785, 5970.432808883149, 6151.72317245725, 6179.196704428486, 6223.471004964629, 6281.152044473937, 6303.180586523723, 6307.810765677037, 6334.651594162366, 6118.192813661917, 6150.04674275488, 6150.50795936324, 6162.414570615784, 6163.599366041193, 5731.828045158652, 5738.770449181986, 5744.253247077853, 5745.368009518949, 5752.309722833287, 6306.432421082033, 6353.428191462791, 6496.090547323284, 6537.346265373615, 6702.061711360413, 5413.8105166320565, 6375.171227740364, 6455.225372955276, 6491.837704057248, 6493.188351456068, 6639.601623902581, 6711.295313991961, 6718.93281067183, 6733.932660673527, 6742.0, 6148.016317389196, 6198.597091189058, 6249.8750024998335, 6354.078658594571, 6360.363963603602, 6343.080253363329, 6415.037744338387, 6417.197850268716, 6445.677716114269, 6445.967770161119, 5077.847664570068, 6273.341299163522, 6298.401651843067, 6299.748010079728, 6301.338359472189, 6116.785912493041, 6153.938460615336, 6254.6247225166635, 6287.842803929939, 6317.084022816758, 6002.279726432856, 6066.666333351708, 6235.968820156052, 6244.500439964882, 6269.028300613412, 6330.0, 6340.651264180515, 6343.714532845941, 6368.4586810121655, 6376.93623063782, 6008.24896887889, 6097.695115244309, 6174.691265436621, 6236.875262494634, 6258.874822503615], "value": 5872.7465683784585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.9956059319919, 801.1307731111743, 823.1727114250176, 950.3680052764912, 965.826151292767, 38839.25223364948, 39643.60356396435, 41134.17731645365, 41158.17683646325, 41243.38134927975, 39635.60364396355, 39800.80099599498, 39856.40215396771, 39971.0, 40069.0, 7861.80345491363, 8026.879596806052, 10591.046805787477, 10845.67462976108, 10993.560257589726, 10690.037896589305, 10791.676249712522, 10803.729906752316, 10809.027187553118, 10833.566657333697, 9012.8648070279, 10812.783744325108, 10834.837477437844, 10860.0, 10869.891301087007, 10760.677179684622, 10783.191260655482, 10787.460626968621, 10795.460226988698, 10804.67585972422, 10488.0, 10549.41978191199, 10550.0, 10564.947175264075, 10584.417857017861, 34600.65399345999, 34809.12977175566, 35007.29985400278, 35028.82485587581, 35055.82472087649, 3692.298463291966, 3779.1496913194587, 3779.225258821935, 3784.526934133233, 3787.9242415151543, 24110.397240068964, 24257.636135457982, 25275.494490110093, 25983.480330393286, 26825.92696292146, 2968.1401017961366, 3024.9546256806166, 3099.9070027899197, 3127.5465057566753, 3129.9530507042414, 348592.0, 353454.0, 353736.2313188443, 358365.0, 443560.7821960902, 44259.893502662046, 44382.0, 44565.55434445614, 44579.10841783211, 44833.77583112129, 36067.81966090153, 44747.0, 45169.54830451719, 45215.869603259525, 45420.772896135306, 11361.0, 13692.589222323346, 13768.967327450482, 13816.0, 13836.23900685452, 11902.345371004505, 11983.28100313984, 12023.579174729017, 12039.939800301117, 12070.698232544257, 11857.940710296394, 11866.288022718665, 11909.344986025679, 11984.28094314344, 12012.519499219934, 4646.6747327686735, 5558.86102847424, 5582.972085139549, 5593.552515798727, 5629.943700563023, 1039.7868436970402, 1060.9787804244027, 1102.448775612194, 1133.4049623947328, 1171.9628129105802, 26570.335741606614, 26789.330266743098, 27127.728722712916, 27354.179374618794, 27529.174124776287, 1220.8412906322121, 1238.1613304243192, 1246.9875301247052, 1263.6651287408845, 1268.099649249025, 12896.80654790179, 13018.828305452365, 14030.508932187324, 14134.434622615187, 14259.500917467838, 371758.0, 434243.0, 435043.0, 436553.0, 438488.0, 56392.71803641038, 56862.7156864213, 56919.43080569224, 57016.85966280651, 57041.42958570444, 1390.65928847431, 1443.5524987253775, 1447.7973083768281, 1456.803331550227, 1458.9854101459061, 25930.611040834025, 26383.0, 26529.867350663124, 26787.464250715268, 26907.596386054618, 47092.0, 47441.52558474509, 47538.04923901433, 47569.52430475651, 47615.28577071278, 390902.0, 392309.0, 392903.0, 393808.0, 394040.0, 26322.473550529267, 26944.865275673495, 27837.304067398476, 31698.68301316957, 32003.519947200344, 44111.11777764491, 44765.32852007288, 45418.77290613526, 45668.55412626578, 47129.82175445504, 27041.0, 28922.710772892842, 30091.247718807204, 30894.845525772227, 31349.8432507836, 29585.556216657198, 31388.058358249287, 31628.525572116898, 31891.65137660512, 32039.0, 30985.380292394475, 36112.27775444529, 36975.81512092422, 37468.25063498769, 37818.43272350862, 31169.68830311668, 31190.688093118777, 31261.8436907814, 31630.525542116426, 32401.837990809894, 20156.9226496323, 24030.0, 25199.49601007933, 25269.115580954578, 25565.105221317164], "value": 18446.58669339213, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.9719319647625, 420.94317267168924, 421.13877121286987, 429.77436845656035, 459.7976890168326, 18835.52911177221, 20164.19343226271, 21363.359099227047, 21411.464713382135, 21429.892850535743, 20189.091490882907, 20696.482587935272, 20696.896515517437, 21050.947452627384, 21098.894505527453, 6557.344265573441, 6832.590044597315, 6875.69059392326, 6888.862222755542, 6892.138482689664, 5587.720613969305, 6459.709313080923, 6709.463242940553, 6765.898511522307, 6771.356721111511, 6490.902636460457, 6744.393004629583, 6750.324967503235, 6773.796786096425, 6785.355391237825, 6583.5062370322175, 6712.194536655584, 6717.429018533406, 6719.529632925697, 6742.966285168567, 6294.150289710922, 6515.804525864231, 6539.47684185264, 6620.6358650274215, 6625.039369291474, 24777.0, 25061.997520099176, 25525.85133668971, 25694.229173124837, 25866.96532138731, 2869.9426011479654, 2926.1514160893316, 2936.324645331564, 2940.0738767288235, 2953.3059730963205, 11995.880041199563, 15939.760903586455, 16351.509454716377, 16551.2551935162, 16914.069726165057, 2044.6830741235133, 2080.583883223361, 2082.1983536338466, 2130.4141361125658, 2131.2540610786255, 142152.0, 146781.0, 155597.0, 160899.0, 165122.9999999988, 17133.828661713473, 19497.805021949884, 20628.381148565568, 20776.58446831085, 21109.26117585908, 32165.195870102965, 32239.871604493732, 32828.86612370188, 32859.67140328614, 32890.848820291176, 8303.750887473385, 10081.69754907354, 10478.633247836442, 10584.88858669844, 10774.299670521392, 7702.576358300347, 8223.21879421454, 8719.433236839584, 8758.474491530402, 8881.511516866634, 8221.0, 9684.95157524222, 9780.902190978142, 9837.065478779505, 10042.548085336177, 3563.6970857477404, 3563.8388091271217, 3587.031501494634, 4226.450561426995, 4406.933895991563, 891.0866361979023, 896.4576431258995, 902.891653001644, 935.854942483916, 943.3302355327656, 17409.390671326444, 22058.669119963215, 22077.668834967488, 22279.331620051424, 22333.55332893333, 866.9046404895456, 937.4890684576922, 940.0881145289059, 960.5293406231036, 966.1015255812022, 9874.703758887244, 10303.793924121475, 10504.632337868137, 11229.775404491864, 11674.533018679158, 735893.0, 754083.0, 756602.0, 765943.0, 774112.0, 131834.0, 147335.26332368483, 153603.0, 156665.0, 163522.0, 1188.7860185166753, 1189.3161432176532, 1228.8709685483075, 1239.1264158768047, 1243.6082633970088, 20000.89999549993, 20417.08123134492, 20713.0, 20788.0, 20810.791892080884, 64249.357506426204, 66970.64690795082, 67056.66471667611, 67325.0, 68593.3140668607, 95805.0, 96700.51649741706, 97156.0, 97409.0, 98244.50877745566, 11399.658010259705, 11573.305601663591, 11606.709832253924, 11668.416579171177, 11948.283103013848, 12898.0, 12908.96728261718, 13186.340682965621, 13211.867881321064, 13330.333483325989, 8236.176382361717, 8476.830463390574, 9237.290248585143, 9395.765105872135, 10397.700287464068, 9228.492432915986, 10861.891381086089, 10908.563657453613, 11155.05182059534, 11188.66434006981, 11548.538058477567, 11586.942065289957, 11809.291442513477, 11851.407429628312, 11968.037349613782, 10738.946305268424, 12199.695007624525, 12986.0, 13188.142770720257, 13296.933515332361, 11724.648260552198, 11987.280763154238, 12034.879651203726, 12067.939660301994, 12107.51569937228], "value": 11529.097623427391, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1222.7248869004482, 1404.8173737414136, 1525.2450037231565, 1564.7731078993547, 1570.9842901570985, 9496.572654230558, 9725.22198224142, 10822.24244302899, 11506.194566380356, 11521.193516453852, 10795.892041079587, 11127.499262533205, 11172.776544469105, 11174.720631984204, 11480.71298217545, 2409.795167410772, 2450.791682706972, 2458.963115553268, 2463.6550882876413, 2471.542764588548, 1989.7214389985413, 2390.1395497620842, 2434.5009273099063, 2442.3161514775893, 2442.804575633954, 2411.7347091819884, 2416.347586151738, 2421.055788242587, 2429.259075981825, 2437.9756202438016, 2364.2670772060546, 2377.6552399902002, 2378.47673511828, 2388.188016074543, 2390.9282721518293, 2358.8230882683697, 2366.0535785685865, 2379.262428647125, 2379.8691071991034, 2391.7249516305674, 11356.60251891188, 11390.60132895353, 11453.656390308304, 11545.480453379534, 11567.768644627144, 4777.474477807438, 6019.488343490809, 6020.0, 6028.125921741367, 6034.306054803666, 3418.6923176913947, 3441.2601290722614, 3481.477778333245, 3620.348337299285, 3695.8521659133603, 1194.1581185264367, 1194.569954816274, 1200.345811532708, 1245.1284101129245, 1252.154795513025, 15521.146336951464, 15689.686206275925, 15705.371785128582, 15737.685246295125, 15750.527484175493, 4248.808803603845, 4677.585362685259, 4944.950550494521, 4965.851024469272, 5049.343585333957, 13208.27354495512, 13286.734265314639, 13306.600801975956, 13313.534026309033, 13409.396577154052, 5093.159628661304, 5823.970880145657, 6030.306514750772, 6043.48630366415, 6048.304444988883, 4515.07440974606, 5036.496350365008, 5293.258943747878, 5348.438413966555, 5381.919271210857, 4089.857525054212, 4125.958740412558, 4230.830766769356, 4242.809073591696, 4251.128518653669, 1143.188336281233, 1145.4215621111287, 1149.7183190118474, 1150.068444559909, 1159.0843233845337, 831.5966756123275, 919.2855324819164, 927.7355953553205, 944.5088553951906, 952.2334520710895, 6450.935490645127, 6520.445762110179, 6675.499337549606, 6724.831879203059, 6770.458363330922, 858.6822875535967, 900.7838118851429, 965.1844191658038, 1008.5360734062267, 1040.469360626071, 4254.680898932593, 4256.4679415073115, 4260.488741351058, 4286.39990401344, 4384.145091707151, 13583.52457663977, 14021.369038393297, 14045.508407205698, 14049.297535123203, 14080.436782528584, 13581.447298220428, 13967.441302347792, 13987.650308742363, 14007.229602371763, 14171.291435428187, 10195.796084078425, 10488.528016239288, 10489.475526223658, 10489.685309440729, 10525.89474105249, 6479.1901012373455, 6585.604863708193, 6648.90026649591, 6673.766418175341, 6731.259561448334, 12238.877611223774, 12512.937435312766, 12514.374281285716, 12588.118831681695, 12650.746985060432, 12602.936985315015, 12869.549565765154, 12873.35633218354, 12877.162984405984, 12919.031072669399, 7636.579988100708, 7840.725574604861, 8419.452735572168, 8504.0, 8825.426347287406, 10444.164466842481, 10622.044016038593, 10668.306560073881, 10725.946370268099, 10757.13942884583, 8886.644534218558, 8931.285497160341, 8971.192592666692, 8995.955020224857, 9138.862917056382, 8783.736487905373, 8802.91197088021, 8820.38257322007, 8851.46891186531, 8872.73381798547, 7997.200279971957, 8068.878966815385, 8124.390670699603, 8140.470869393471, 8169.142240064708, 5892.823215303548, 5944.762209511571, 5955.880882382415, 5989.790357337472, 6160.476359509492, 5848.64908105515, 6013.188219590299, 6108.541859360655, 6131.294901086254, 6158.100162711885], "value": 5201.597479336702, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.54052974311844, 382.08871840660015, 389.70187806328164, 391.94316824060513, 398.8085718854949, 4568.90862182757, 4823.263625094967, 5036.98520591763, 5260.842174734764, 5420.620556561037, 4109.609572103012, 4587.99064205875, 4718.8584342469785, 5082.186850103984, 5177.534021938025, 3667.9092917037165, 3756.229972855558, 4063.634272915437, 4215.777424546878, 4271.9572804271875, 3982.4026396040535, 4125.64838042316, 4300.65594752419, 4369.453818272716, 4369.584889435499, 3967.444557761916, 4107.055377263231, 4126.484189476316, 4261.722988005785, 4317.395564620955, 3827.6937844972335, 4302.408108999659, 4315.30955047194, 4320.805563749623, 4332.740035597859, 3605.5853576838476, 3676.5588129424373, 4010.438538604598, 4055.918881622351, 4062.1672557125717, 4162.085440697283, 4863.927041094386, 5085.364329458817, 5119.90084065535, 5142.4600416956055, 4463.352813842007, 4519.367288579601, 4758.857234282977, 4796.25658023007, 4874.463808981045, 4806.327114204014, 4949.307097006422, 5304.946950530484, 5365.678059316453, 5609.27079479665, 3867.6325749053794, 3875.7286989910717, 3901.752143367167, 4424.951169679739, 4473.881529617595, 4968.726720030397, 5236.502532259467, 5554.0, 5702.0, 5706.686132262724, 3961.950083227947, 4231.7672528010635, 4445.799939002753, 4448.154850578379, 4495.303227999665, 3761.5486141663177, 3956.5449973252867, 4124.484439445069, 4235.4917409910395, 4546.613028160243, 4093.467849179647, 4694.718316900997, 4705.788239529229, 4810.5670489656095, 5031.647784655112, 4852.223644216909, 5453.536449401845, 5543.77824887, 5555.111182210908, 5571.0, 1389.9861001390059, 1560.9541607123256, 1579.9289031993587, 1582.6834633073431, 1603.9759403608955, 1045.4877110216091, 1049.5801679328176, 1084.6745976207264, 1178.4932479034098, 1200.3698058519346, 5200.193969934666, 5203.531682148549, 5204.297419848348, 5209.609279304067, 5237.266782650432, 5592.720363981784, 5828.843327968679, 5833.679147646835, 5897.292324921037, 5946.286445626552, 4733.810647574127, 4852.733099679481, 4931.728754918442, 5072.898542029138, 5165.509276618715, 2589.52093862636, 2665.480231354867, 2973.8810447582287, 2977.5087110626937, 2987.8804847806277, 5362.597805164628, 5379.67721936685, 5627.943720562824, 5692.516136128475, 5735.684537350402, 5543.584231182677, 5859.941400586024, 5895.616784908967, 5911.940880591225, 5968.22413086296, 5977.372375900555, 6002.279726432856, 6037.154798328237, 6059.1820104286235, 6099.662795054327, 5182.170852663556, 5455.509004189642, 5456.017916775018, 5502.394736578893, 5892.764289428546, 4438.2011237976185, 5709.8287051388525, 5724.4275572444085, 5739.7417116229035, 5785.884282314246, 5177.4822517747925, 5763.4812866842185, 5798.797042103506, 5981.700914954322, 6045.848853778691, 3702.408314180031, 4056.229316429869, 4420.270655341833, 4459.331100334975, 4594.254183410417, 5177.637565370388, 5353.357597088374, 5634.971825140848, 5663.904355388532, 5896.963064021947, 4705.694129881546, 5054.418741844588, 5404.486573775485, 5486.91769623448, 5549.916751248816, 4863.95136048635, 4997.450280469073, 5000.624953128603, 5594.797118619516, 5608.578766952238, 4477.798499067485, 4815.446223684181, 5245.7114858683135, 5482.725863706878, 5536.695481748542, 4494.651604518566, 4567.406237189144, 4949.604031677385, 5568.916466252928, 5573.888522229614, 5116.74416279192, 5456.0, 5484.698341591251, 5531.059719847555, 5541.778328866801], "value": 4203.201522673593, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.8105111619866, 738.3207449146785, 761.2364144575446, 814.8451794159109, 860.5611138319457, 14534.34595443205, 15022.92488537557, 15144.318505667245, 16104.919475402621, 16383.18084095795, 14907.92546037271, 15057.77413338798, 15066.3220155093, 15078.3214755336, 15092.47176348828, 905.4657751926362, 915.1900567997337, 946.8911075226334, 955.0306438964457, 956.4978386347154, 950.7813202963323, 951.5527701980059, 952.5903861339622, 955.9378640388387, 957.5978089202517, 1003.5132960514145, 1006.7583779892847, 1007.0634310091611, 1008.7831116309992, 1009.9394036357805, 985.23644175764, 998.7952469743758, 1003.0, 1003.2024540490291, 1004.2116938203549, 732.6556518436327, 743.5873090434807, 744.0959234530018, 745.5861996591889, 746.6005686957506, 14050.508232211925, 16393.83606163935, 16405.0, 16816.495505134866, 16840.74738878918, 13743.862561374459, 13785.241811700353, 13855.515056973058, 13993.30033498321, 14047.08693934891, 10055.045142973398, 11588.947061665867, 11776.293422394683, 11894.52421903123, 11970.102242331859, 3561.51919490868, 3611.043073585502, 3646.781193128421, 3664.175560498893, 3767.2653832502674, 88401.78995525099, 112017.0, 113668.0, 113740.0, 114416.0, 10489.947550262352, 10767.946160269148, 10770.030697237285, 10862.293950893167, 10929.508172132273, 22062.779372206074, 22446.214382496535, 22959.770402296097, 23031.07875684954, 23062.423439413815, 6559.44244739193, 7705.922940770521, 7710.074077769209, 7730.922690773133, 7827.686892524235, 4272.401863739079, 4322.589354011364, 4328.372386004012, 4360.280553708666, 4445.310976798602, 3506.8246587670515, 3542.71658267338, 3553.129483276614, 3575.982120089383, 3591.425371940529, 644.7711062572813, 646.2697152218058, 652.8694261147789, 660.2440205964144, 660.9900851487232, 603.5081408651935, 671.5601281160848, 696.4950410952121, 697.6197972105215, 700.6146619359332, 8911.574148136267, 10201.438920859424, 10246.59013639461, 10460.476976151314, 10538.387132158507, 651.3942033908415, 688.174190970837, 705.4004096517918, 716.1907789195577, 718.1632551421905, 4037.40138888198, 4611.5619016193405, 4835.984443266883, 4997.30037794709, 5008.29883816266, 107343.0, 108663.0, 109253.0, 109282.0, 109787.0, 36771.632283677354, 63212.0, 78350.0, 88885.0, 89725.55137224273, 67160.32839671736, 68476.0, 68779.62440751257, 68962.0, 69202.0, 8305.961754780652, 9111.635534578807, 9674.0, 9862.2603304751, 9896.950515247378, 29191.0, 43817.0, 43879.34180987351, 45365.54634453613, 48214.517854821, 65759.0, 67184.6640766793, 68156.0, 70624.64687676528, 70767.64616176886, 11280.32318060919, 11457.942710286396, 12423.937880310541, 12619.305938173122, 12772.48910043625, 14562.781558276847, 14827.629309267355, 14841.703165936406, 15266.465673701367, 15777.842221578096, 13436.0, 13769.724605508034, 13853.861461385257, 14255.0, 15002.324895379516, 13442.327883605976, 13514.459421623025, 13964.092333998258, 14244.501442449464, 14721.0, 13167.144135631153, 13460.05779595419, 13510.324483775576, 13630.591082267549, 13772.449102035805, 9553.0, 9836.21310295189, 9966.0, 10059.49702514886, 10060.245481588763, 9973.850392243978, 11045.558177672803, 11327.943360283145, 11375.658730238107, 11406.657800266004], "value": 7539.105095668454, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1609.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 176.0, 176.0, 147.0, 176.0, 147.0, 117.0, 115.0, 121.0, 175.0], "value": 148.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 143.0, 142.0, 141.0, 112.0, 101.0, 144.0, 97.0, 165.0, 147.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 196.0, 206.0, 199.0, 196.0, 201.0, 194.0, 194.0, 195.0, 194.0], "value": 197.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 55.0, 53.0, 83.0, 62.0, 90.0, 142.0, 72.0, 66.0, 77.0], "value": 77.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 87.0, 71.0, 72.0, 69.0, 82.0, 75.0, 104.0, 116.0], "value": 83.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 123.0, 91.0, 138.0, 78.0, 138.0, 139.0, 89.0, 88.0, 81.0], "value": 110.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 96.0, 98.0, 114.0, 151.0, 108.0, 140.0, 153.0], "value": 114.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 91.0, 91.0, 91.0, 93.0, 95.0, 116.0, 148.0, 107.0], "value": 113.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 73.0, 104.0, 69.0, 70.0, 107.0, 110.0, 110.0], "value": 84.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 63.0, 54.0, 63.0, 62.0, 58.0, 57.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 87.0, 87.0, 86.0, 87.0, 84.0, 84.0, 84.0, 88.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 163.0, 150.0, 148.0, 147.0, 136.0, 173.0, 165.0, 208.0, 159.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 173.0, 167.0, 171.0, 175.0, 168.0, 166.0, 172.0, 168.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 64.0, 81.0, 69.0, 66.0, 68.0, 64.0, 64.0, 71.0, 64.0], "value": 66.9, "unit": "score"}]}]} 11:11:09 INFO - Return code: 0 11:11:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:11:09 ERROR - # TBPL SUCCESS # 11:11:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:11:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:11:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:11:09 INFO - 2017-04-03 11:11:09.143 screenresolution[30069:278198] starting screenresolution argv=screenresolution get 11:11:09 INFO - 2017-04-03 11:11:09.145 screenresolution[30069:278198] Display 0: 1600x1200x32@60 11:11:09 INFO - 2017-04-03 11:11:09.152 screenresolution[30070:278201] starting screenresolution argv=screenresolution list 11:11:09 INFO - Available Modes on Display 0 11:11:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:11:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:11:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:11:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:11:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:11:09 INFO - Intel Iris: 11:11:09 INFO - Chipset Model: Intel Iris 11:11:09 INFO - Type: GPU 11:11:09 INFO - Bus: Built-In 11:11:09 INFO - VRAM (Dynamic, Max): 1536 MB 11:11:09 INFO - Vendor: Intel (0x8086) 11:11:09 INFO - Device ID: 0x0a2e 11:11:09 INFO - Revision ID: 0x0009 11:11:09 INFO - Displays: 11:11:09 INFO - Display: 11:11:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:11:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:11:09 INFO - Display Serial Number: 1600x1200 60 11:11:09 INFO - Main Display: Yes 11:11:09 INFO - Mirror: Off 11:11:09 INFO - Online: Yes 11:11:09 INFO - Rotation: Supported 11:11:09 INFO - Return code: 0 11:11:09 INFO - Running post-action listener: _resource_record_post_action 11:11:09 INFO - [mozharness: 2017-04-03 18:11:09.399966Z] Finished run-tests step (success) 11:11:09 INFO - Running post-run listener: _resource_record_post_run 11:11:09 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 29897216; Write bytes: 511490048; Read time: 188; Write time: 1626 11:11:09 INFO - TinderboxPrint: CPU usage
54.4% 11:11:09 INFO - TinderboxPrint: I/O read bytes / time
29,897,216 / 188 11:11:09 INFO - TinderboxPrint: I/O write bytes / time
511,490,048 / 1,626 11:11:09 INFO - TinderboxPrint: CPU idle
2,189.4 (45.6%) 11:11:09 INFO - TinderboxPrint: CPU system
964.1 (20.1%) 11:11:09 INFO - TinderboxPrint: CPU user
1,648.3 (34.3%) 11:11:09 INFO - TinderboxPrint: Swap in / out
232,894,464 / 0 11:11:09 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205703680; Write bytes: 201134080; Read time: 15812; Write time: 442 11:11:09 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 29622784; Write bytes: 299251712; Read time: 183; Write time: 1145 11:11:09 INFO - Running post-run listener: _upload_blobber_files 11:11:09 INFO - Blob upload gear active. 11:11:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:11:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:11:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:11:10 INFO - (blobuploader) - INFO - Open directory for files ... 11:11:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:11:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:11:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:11 INFO - (blobuploader) - INFO - Done attempting. 11:11:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:11:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:11:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:12 INFO - (blobuploader) - INFO - Done attempting. 11:11:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:11:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:11:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:13 INFO - (blobuploader) - INFO - Done attempting. 11:11:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:11:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:11:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:15 INFO - (blobuploader) - INFO - Done attempting. 11:11:15 INFO - (blobuploader) - INFO - Iteration through files over. 11:11:15 INFO - Return code: 0 11:11:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:11:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:11:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/548ed42118ae0fad4b9f3cedefeb6069fbccfc1869ab2ca64ced87333f040097d665176425f6a68b6f28da9f38093a2c3193193838f9770e68d62b2fa5c58d3d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32cb206892ee0d134de87253a2496e3ffe96cd09d7e74179541fe621f23cd15b5565c9733977aa74fa5698b2e970d75add84499deced95e2062cf57da883dc8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f26e23c91d9ff4d9658c2a2fb0db4426bca6b1045da2a366473b37e8b2d50babf43aba93c86b8ad65a4066db00fa85c45d6aa5a388d5a8e7b1de2a92e9a7deb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8964df4da92f2dff02434b868f22b9df2387d1ddcd42aa7b5801809df3038744a34e4ba97ecc9840a07262ae1c7c52c08c09b1c7c3a0c04cfeb149f8ca6ca14d"} 11:11:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:11:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:11:15 INFO - Contents: 11:11:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/548ed42118ae0fad4b9f3cedefeb6069fbccfc1869ab2ca64ced87333f040097d665176425f6a68b6f28da9f38093a2c3193193838f9770e68d62b2fa5c58d3d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32cb206892ee0d134de87253a2496e3ffe96cd09d7e74179541fe621f23cd15b5565c9733977aa74fa5698b2e970d75add84499deced95e2062cf57da883dc8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f26e23c91d9ff4d9658c2a2fb0db4426bca6b1045da2a366473b37e8b2d50babf43aba93c86b8ad65a4066db00fa85c45d6aa5a388d5a8e7b1de2a92e9a7deb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8964df4da92f2dff02434b868f22b9df2387d1ddcd42aa7b5801809df3038744a34e4ba97ecc9840a07262ae1c7c52c08c09b1c7c3a0c04cfeb149f8ca6ca14d"} 11:11:15 INFO - Running post-run listener: copy_logs_to_upload_dir 11:11:15 INFO - Copying logs to upload dir... 11:11:15 INFO - mkdir: /builds/slave/test/build/upload/logs 11:11:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.397095 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-03 11:11:15.378332) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 11:11:15.382071) ========= 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.xstz2FJriY/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.tP19qv1lZe/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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/Mozilla-Aurora/sha512/548ed42118ae0fad4b9f3cedefeb6069fbccfc1869ab2ca64ced87333f040097d665176425f6a68b6f28da9f38093a2c3193193838f9770e68d62b2fa5c58d3d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32cb206892ee0d134de87253a2496e3ffe96cd09d7e74179541fe621f23cd15b5565c9733977aa74fa5698b2e970d75add84499deced95e2062cf57da883dc8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f26e23c91d9ff4d9658c2a2fb0db4426bca6b1045da2a366473b37e8b2d50babf43aba93c86b8ad65a4066db00fa85c45d6aa5a388d5a8e7b1de2a92e9a7deb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8964df4da92f2dff02434b868f22b9df2387d1ddcd42aa7b5801809df3038744a34e4ba97ecc9840a07262ae1c7c52c08c09b1c7c3a0c04cfeb149f8ca6ca14d"} build_url:https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010600 build_url: 'https://queue.taskcluster.net/v1/task/R_9q56QXQVOk4pRm9PnFag/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/548ed42118ae0fad4b9f3cedefeb6069fbccfc1869ab2ca64ced87333f040097d665176425f6a68b6f28da9f38093a2c3193193838f9770e68d62b2fa5c58d3d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32cb206892ee0d134de87253a2496e3ffe96cd09d7e74179541fe621f23cd15b5565c9733977aa74fa5698b2e970d75add84499deced95e2062cf57da883dc8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f26e23c91d9ff4d9658c2a2fb0db4426bca6b1045da2a366473b37e8b2d50babf43aba93c86b8ad65a4066db00fa85c45d6aa5a388d5a8e7b1de2a92e9a7deb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8964df4da92f2dff02434b868f22b9df2387d1ddcd42aa7b5801809df3038744a34e4ba97ecc9840a07262ae1c7c52c08c09b1c7c3a0c04cfeb149f8ca6ca14d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 11:11:15.415418) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 11:11:15.415761) ========= 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.xstz2FJriY/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.tP19qv1lZe/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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.005266 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 11:11:15.464226) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 11:11:15.464521) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 11:11:15.464831) ========= ========= Total master_lag: 0.36 =========