builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0320 starttime: 1490979945.27 results: success (0) buildid: 20170331085322 builduid: 3441c7a146ab4f80905f619275f556c1 revision: 5bd82c644e1fdc15b92ca9e34b31841151b44957 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 10:05:45.273154) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 10:05:45.273672) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 10:05:45.273953) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 10:05:45.302302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 10:05:45.302718) ========= 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.6oWvsXWNyv/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.6aYFnX7NnW/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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-03-31 10:05:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 55.6M=0s 2017-03-31 10:05:45 (55.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137620 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 10:05:45.466292) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 10:05:45.466758) ========= 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.6oWvsXWNyv/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.6aYFnX7NnW/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.026494 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 10:05:45.518044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-03-31 10:05:45.518702) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5bd82c644e1fdc15b92ca9e34b31841151b44957 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5bd82c644e1fdc15b92ca9e34b31841151b44957 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6oWvsXWNyv/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.6aYFnX7NnW/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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-03-31 10:05:45,628 truncating revision to first 12 chars 2017-03-31 10:05:45,628 Setting DEBUG logging. 2017-03-31 10:05:45,629 attempt 1/10 2017-03-31 10:05:45,629 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5bd82c644e1f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 10:05:46,810 unpacking tar archive at: mozilla-central-5bd82c644e1f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.678239 ========= master_lag: 2.61 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-03-31 10:05:49.807294) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 10:05:49.807591) ========= script_repo_revision: 5bd82c644e1fdc15b92ca9e34b31841151b44957 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 10:05:49.807987) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 10:05:49.808276) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 10:05:49.842488) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-31 10:05:49.842844) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6oWvsXWNyv/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.6aYFnX7NnW/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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:05:50 INFO - MultiFileLogger online at 20170331 10:05:50 in /builds/slave/test 10:05:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:05:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:50 INFO - {'append_to_log': False, 10:05:50 INFO - 'base_work_dir': '/builds/slave/test', 10:05:50 INFO - 'blob_upload_branch': 'Firefox', 10:05:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:50 INFO - 'branch': 'Firefox', 10:05:50 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:50 INFO - 'config_files': ('talos/mac_config.py',), 10:05:50 INFO - 'default_actions': ('clobber', 10:05:50 INFO - 'read-buildbot-config', 10:05:50 INFO - 'download-and-extract', 10:05:50 INFO - 'populate-webroot', 10:05:50 INFO - 'create-virtualenv', 10:05:50 INFO - 'install', 10:05:50 INFO - 'run-tests'), 10:05:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:50 INFO - 'download_minidump_stackwalk': True, 10:05:50 INFO - 'download_symbols': 'ondemand', 10:05:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:50 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:50 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:50 INFO - 'gecko_profile': False, 10:05:50 INFO - 'gecko_profile_interval': 0, 10:05:50 INFO - 'installer_path': 'installer.exe', 10:05:50 INFO - 'log_level': 'info', 10:05:50 INFO - 'log_name': 'talos', 10:05:50 INFO - 'log_to_console': True, 10:05:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:05:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:05:50 INFO - 'opt_config_files': (), 10:05:50 INFO - 'pip_index': False, 10:05:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:05:50 INFO - 'cmd': ('bash', 10:05:50 INFO - '-c', 10:05:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:05:50 INFO - 'enabled': True, 10:05:50 INFO - 'halt_on_failure': False, 10:05:50 INFO - 'name': 'check_screen_resolution'},), 10:05:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:05:50 INFO - 'cmd': ('bash', 10:05:50 INFO - '-c', 10:05:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:05:50 INFO - 'enabled': True, 10:05:50 INFO - 'halt_on_failure': False, 10:05:50 INFO - 'name': 'check_screen_resolution'},), 10:05:50 INFO - 'run_cmd_checks_enabled': True, 10:05:50 INFO - 'suite': 'dromaeojs-e10s', 10:05:50 INFO - 'system_bits': '32', 10:05:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:50 INFO - 'title': 't-yosemite-r7-0320', 10:05:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:50 INFO - 'use_talos_json': True, 10:05:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:50 INFO - 'work_dir': 'build'} 10:05:50 INFO - [mozharness: 2017-03-31 17:05:50.055793Z] Running clobber step. 10:05:50 INFO - Running pre-action listener: _resource_record_pre_action 10:05:50 INFO - Running main action method: clobber 10:05:50 INFO - rmtree: /builds/slave/test/build 10:05:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:52 INFO - Running post-action listener: _resource_record_post_action 10:05:52 INFO - [mozharness: 2017-03-31 17:05:52.452287Z] Finished clobber step (success) 10:05:52 INFO - [mozharness: 2017-03-31 17:05:52.452417Z] Running read-buildbot-config step. 10:05:52 INFO - Running pre-action listener: _resource_record_pre_action 10:05:52 INFO - Running main action method: read_buildbot_config 10:05:52 INFO - Using buildbot properties: 10:05:52 INFO - { 10:05:52 INFO - "project": "", 10:05:52 INFO - "product": "firefox", 10:05:52 INFO - "script_repo_revision": "production", 10:05:52 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:05:52 INFO - "repository": "", 10:05:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:05:52 INFO - "buildid": "20170331085322", 10:05:52 INFO - "pgo_build": "False", 10:05:52 INFO - "basedir": "/builds/slave/test", 10:05:52 INFO - "buildnumber": 7, 10:05:52 INFO - "slavename": "t-yosemite-r7-0320", 10:05:52 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:05:52 INFO - "platform": "yosemite_r7", 10:05:52 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:05:52 INFO - "branch": "mozilla-central", 10:05:52 INFO - "repo_path": "mozilla-central", 10:05:52 INFO - "revision": "5bd82c644e1fdc15b92ca9e34b31841151b44957", 10:05:52 INFO - "stage_platform": "macosx64", 10:05:52 INFO - "builduid": "3441c7a146ab4f80905f619275f556c1", 10:05:52 INFO - "slavebuilddir": "test" 10:05:52 INFO - } 10:05:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:05:52 INFO - Running post-action listener: _resource_record_post_action 10:05:52 INFO - [mozharness: 2017-03-31 17:05:52.455579Z] Finished read-buildbot-config step (success) 10:05:52 INFO - [mozharness: 2017-03-31 17:05:52.455695Z] Running download-and-extract step. 10:05:52 INFO - Running pre-action listener: _resource_record_pre_action 10:05:52 INFO - Running main action method: download_and_extract 10:05:52 INFO - mkdir: /builds/slave/test/build/tests 10:05: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:05:52 INFO - trying https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:05:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:05:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 10:05:53 INFO - Downloaded 1325 bytes. 10:05:53 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:05:53 INFO - Using the following test package requirements: 10:05:53 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:05:53 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 10:05:53 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:05:53 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:05:53 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:05:53 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:05:53 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:05:53 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:05:53 INFO - u'jsshell-mac.zip'], 10:05:53 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:05:53 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:05:53 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:05:53 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:05:53 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:05:53 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:05:53 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:05:53 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:05:53 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:05:53 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:05:53 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:05:53 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:05:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:05:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:05:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:05:55 INFO - Expected file size: 52507842 10:05:55 INFO - Obtained file size: 52507842 10:06:11 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:06:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:06:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:06:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:06:13 INFO - Expected file size: 52507842 10:06:13 INFO - Obtained file size: 52507842 10:06:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:06:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:06:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:06:30 INFO - Expected file size: 14404152 10:06:30 INFO - Obtained file size: 14404152 10:06: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:06:31 INFO - trying https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:06:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 10:06:33 INFO - Downloaded 75601703 bytes. 10:06:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:06:33 INFO - mkdir: /builds/slave/test/properties 10:06:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:06:33 INFO - Writing to file /builds/slave/test/properties/build_url 10:06:33 INFO - Contents: 10:06:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:06:33 INFO - Running post-action listener: _resource_record_post_action 10:06:33 INFO - Running post-action listener: set_extra_try_arguments 10:06:33 INFO - [mozharness: 2017-03-31 17:06:33.870266Z] Finished download-and-extract step (success) 10:06:33 INFO - [mozharness: 2017-03-31 17:06:33.870442Z] Running populate-webroot step. 10:06:33 INFO - Running pre-action listener: _resource_record_pre_action 10:06:33 INFO - Running main action method: populate_webroot 10:06:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:06:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:06:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:06:33 INFO - '--tppagecycles', 10:06:33 INFO - '7'], 10:06:33 INFO - 'tests': ['tsvgm']}}, 10:06:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:06:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:06:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:06:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:06:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:06:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:06:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:06:33 INFO - 'talos_options': ['--disable-e10s'], 10:06:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:06:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:06:33 INFO - 'talos_options': ['--disable-e10s'], 10:06:33 INFO - 'tests': ['damp', 'tps']}, 10:06:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:06:33 INFO - 'tests': ['damp', 'tps']}, 10:06:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:06:33 INFO - 'tests': ['dromaeo_dom']}, 10:06:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:06:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:06:33 INFO - 'tests': ['basic_compositor_video']}, 10:06:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:06:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:06:33 INFO - 'tests': ['a11yr', 10:06:33 INFO - 'ts_paint', 10:06:33 INFO - 'tpaint', 10:06:33 INFO - 'sessionrestore', 10:06:33 INFO - 'sessionrestore_no_auto_restore', 10:06:33 INFO - 'tabpaint']}, 10:06:33 INFO - 'other-e10s': {'tests': ['a11yr', 10:06:33 INFO - 'ts_paint', 10:06:33 INFO - 'tpaint', 10:06:33 INFO - 'sessionrestore', 10:06:33 INFO - 'sessionrestore_no_auto_restore', 10:06:33 INFO - 'tabpaint']}, 10:06:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:06:33 INFO - 'ts_paint', 10:06:33 INFO - 'tpaint', 10:06:33 INFO - 'sessionrestore', 10:06:33 INFO - 'sessionrestore_no_auto_restore', 10:06:33 INFO - 'tabpaint']}, 10:06:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:06:33 INFO - 'ts_paint', 10:06:33 INFO - 'tpaint', 10:06:33 INFO - 'sessionrestore', 10:06:33 INFO - 'sessionrestore_no_auto_restore', 10:06:33 INFO - 'tabpaint']}, 10:06:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:06:33 INFO - 'tests': ['a11yr', 10:06:33 INFO - 'ts_paint', 10:06:33 INFO - 'tpaint', 10:06:33 INFO - 'sessionrestore', 10:06:33 INFO - 'sessionrestore_no_auto_restore', 10:06:33 INFO - 'tabpaint']}, 10:06:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:06:33 INFO - 'tests': ['a11yr', 10:06:33 INFO - 'ts_paint', 10:06:33 INFO - 'tpaint', 10:06:33 INFO - 'sessionrestore', 10:06:33 INFO - 'sessionrestore_no_auto_restore', 10:06:33 INFO - 'tabpaint']}, 10:06:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:06:33 INFO - 'tests': ['tsvgx', 10:06:33 INFO - 'tsvgr_opacity', 10:06:33 INFO - 'tart', 10:06:33 INFO - 'tscrollx', 10:06:33 INFO - 'cart', 10:06:33 INFO - 'tsvg_static']}, 10:06:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:06:33 INFO - 'tsvgr_opacity', 10:06:33 INFO - 'tart', 10:06:33 INFO - 'tscrollx', 10:06:33 INFO - 'cart', 10:06:33 INFO - 'tsvg_static']}, 10:06:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:06:33 INFO - 'talos_options': ['--disable-e10s'], 10:06:33 INFO - 'tests': ['tp5o']}, 10:06:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:06:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:06:33 INFO - 'talos_options': ['--disable-e10s', 10:06:33 INFO - '--xperf_path', 10:06:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:33 INFO - 'tests': ['tp5n']}, 10:06:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:06:33 INFO - 'talos_options': ['--xperf_path', 10:06:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:33 INFO - 'tests': ['tp5n']}}, 10:06:33 INFO - 'talos.zip': {'path': '', 10:06:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:06:33 INFO - Running post-action listener: _resource_record_post_action 10:06:33 INFO - [mozharness: 2017-03-31 17:06:33.888872Z] Finished populate-webroot step (success) 10:06:33 INFO - [mozharness: 2017-03-31 17:06:33.889003Z] Running create-virtualenv step. 10:06:33 INFO - Running pre-action listener: _resource_record_pre_action 10:06:33 INFO - Running main action method: create_virtualenv 10:06:33 INFO - Creating virtualenv /builds/slave/test/build/venv 10:06:33 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:06:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:06:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:06:34 INFO - Using real prefix '/tools/python27' 10:06:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:06:34 INFO - Installing distribute.............................................................................................................................................................................................done. 10:06:37 INFO - Installing pip.................done. 10:06:37 INFO - Return code: 0 10:06:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:06:37 INFO - Reading from file tmpfile_stdout 10:06:37 INFO - Output received: 10:06:37 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:06:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103f9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81596140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7cd30>, '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 0x103ca3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d71be8>, '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.6oWvsXWNyv/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.6aYFnX7NnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:06:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6oWvsXWNyv/Render', 10:06:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:37 INFO - 'HOME': '/Users/cltbld', 10:06:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:37 INFO - 'LOGNAME': 'cltbld', 10:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:37 INFO - 'MOZ_NO_REMOTE': '1', 10:06:37 INFO - 'NO_EM_RESTART': '1', 10:06:37 INFO - 'PAGER': '/bin/cat', 10:06:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:37 INFO - 'PWD': '/builds/slave/test', 10:06:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:37 INFO - 'SHELL': '/bin/bash', 10:06:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aYFnX7NnW/Listeners', 10:06:37 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:06:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:37 INFO - 'USER': 'cltbld', 10:06:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:37 INFO - 'XPC_FLAGS': '0x0', 10:06:37 INFO - 'XPC_SERVICE_NAME': '0', 10:06:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:38 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:06:38 INFO - Cleaning up... 10:06:38 INFO - Return code: 0 10:06:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:06: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:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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', '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 0x103f9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81596140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7cd30>, '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 0x103ca3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d71be8>, '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.6oWvsXWNyv/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.6aYFnX7NnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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:06: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', 'psutil>=3.1.1'] in /builds/slave/test/build 10:06: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 psutil>=3.1.1 10:06:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6oWvsXWNyv/Render', 10:06:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:38 INFO - 'HOME': '/Users/cltbld', 10:06:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:38 INFO - 'LOGNAME': 'cltbld', 10:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:38 INFO - 'MOZ_NO_REMOTE': '1', 10:06:38 INFO - 'NO_EM_RESTART': '1', 10:06:38 INFO - 'PAGER': '/bin/cat', 10:06:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:38 INFO - 'PWD': '/builds/slave/test', 10:06:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:38 INFO - 'SHELL': '/bin/bash', 10:06:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aYFnX7NnW/Listeners', 10:06:38 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:06:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:38 INFO - 'USER': 'cltbld', 10:06:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:38 INFO - 'XPC_FLAGS': '0x0', 10:06:38 INFO - 'XPC_SERVICE_NAME': '0', 10:06:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:38 INFO - Downloading/unpacking psutil>=3.1.1 10:06:38 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:06:38 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:06:38 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:06:38 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:06:38 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:06:38 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:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:06:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:41 INFO - Installing collected packages: psutil 10:06:41 INFO - Running setup.py install for psutil 10:06:41 INFO - building 'psutil._psutil_osx' extension 10:06:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:06:42 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:06:42 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:06:42 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:06:42 INFO - building 'psutil._psutil_posix' extension 10:06:42 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:06:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:06:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:06:42 INFO - ^ 10:06:42 INFO - 1 warning generated. 10:06:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:06:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:42 INFO - Successfully installed psutil 10:06:42 INFO - Cleaning up... 10:06:43 INFO - Return code: 0 10:06:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:06: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:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103f9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81596140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7cd30>, '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 0x103ca3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d71be8>, '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.6oWvsXWNyv/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.6aYFnX7NnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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:06:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:06:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6oWvsXWNyv/Render', 10:06:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:43 INFO - 'HOME': '/Users/cltbld', 10:06:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:43 INFO - 'LOGNAME': 'cltbld', 10:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:43 INFO - 'MOZ_NO_REMOTE': '1', 10:06:43 INFO - 'NO_EM_RESTART': '1', 10:06:43 INFO - 'PAGER': '/bin/cat', 10:06:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:43 INFO - 'PWD': '/builds/slave/test', 10:06:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:43 INFO - 'SHELL': '/bin/bash', 10:06:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aYFnX7NnW/Listeners', 10:06:43 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:06:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:43 INFO - 'USER': 'cltbld', 10:06:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:43 INFO - 'XPC_FLAGS': '0x0', 10:06:43 INFO - 'XPC_SERVICE_NAME': '0', 10:06:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:06: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:06: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:06: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:06: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:06: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:06: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:06:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:06:47 INFO - Installing collected packages: mozsystemmonitor 10:06:47 INFO - Running setup.py install for mozsystemmonitor 10:06:47 INFO - Successfully installed mozsystemmonitor 10:06:47 INFO - Cleaning up... 10:06:47 INFO - Return code: 0 10:06:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:06:47 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:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:47 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:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:47 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 0x103f9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81596140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7cd30>, '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 0x103ca3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d71be8>, '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.6oWvsXWNyv/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.6aYFnX7NnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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:06:47 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:06:47 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:06:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6oWvsXWNyv/Render', 10:06:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:47 INFO - 'HOME': '/Users/cltbld', 10:06:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:47 INFO - 'LOGNAME': 'cltbld', 10:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:47 INFO - 'MOZ_NO_REMOTE': '1', 10:06:47 INFO - 'NO_EM_RESTART': '1', 10:06:47 INFO - 'PAGER': '/bin/cat', 10:06:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:47 INFO - 'PWD': '/builds/slave/test', 10:06:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:47 INFO - 'SHELL': '/bin/bash', 10:06:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aYFnX7NnW/Listeners', 10:06:47 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:06:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:47 INFO - 'USER': 'cltbld', 10:06:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:47 INFO - 'XPC_FLAGS': '0x0', 10:06:47 INFO - 'XPC_SERVICE_NAME': '0', 10:06:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:47 INFO - Downloading/unpacking jsonschema==2.5.1 10:06:47 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:06:47 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:06:47 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:06:47 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:06:47 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:06:47 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:06:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:06:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:06:50 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:06:50 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:06:50 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:06:50 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:06:50 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:06:50 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:06:50 INFO - Downloading functools32-3.2.3-2.tar.gz 10:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:06:50 INFO - warning: no files found matching '*.txt' 10:06:50 INFO - no previously-included directories found matching 'build' 10:06:50 INFO - no previously-included directories found matching 'dist' 10:06:50 INFO - no previously-included directories found matching '.git*' 10:06:50 INFO - Installing collected packages: jsonschema, functools32 10:06:50 INFO - Running setup.py install for functools32 10:06:50 INFO - warning: no files found matching '*.txt' 10:06:50 INFO - no previously-included directories found matching 'build' 10:06:50 INFO - no previously-included directories found matching 'dist' 10:06:50 INFO - no previously-included directories found matching '.git*' 10:06:50 INFO - Successfully installed jsonschema functools32 10:06:50 INFO - Cleaning up... 10:06:50 INFO - Return code: 0 10:06:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:06:50 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:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:50 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:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:50 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 0x103f9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81596140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7cd30>, '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 0x103ca3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d71be8>, '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.6oWvsXWNyv/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.6aYFnX7NnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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:06:50 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:06:50 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:06:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6oWvsXWNyv/Render', 10:06:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:50 INFO - 'HOME': '/Users/cltbld', 10:06:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:50 INFO - 'LOGNAME': 'cltbld', 10:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:50 INFO - 'MOZ_NO_REMOTE': '1', 10:06:50 INFO - 'NO_EM_RESTART': '1', 10:06:50 INFO - 'PAGER': '/bin/cat', 10:06:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:50 INFO - 'PWD': '/builds/slave/test', 10:06:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:50 INFO - 'SHELL': '/bin/bash', 10:06:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aYFnX7NnW/Listeners', 10:06:50 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:06:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:50 INFO - 'USER': 'cltbld', 10:06:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:50 INFO - 'XPC_FLAGS': '0x0', 10:06:50 INFO - 'XPC_SERVICE_NAME': '0', 10:06:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:06:51 INFO - Cleaning up... 10:06:51 INFO - Return code: 0 10:06:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103f9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81596140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7cd30>, '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 0x103ca3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d71be8>, '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.6oWvsXWNyv/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.6aYFnX7NnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:06:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6oWvsXWNyv/Render', 10:06:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:51 INFO - 'HOME': '/Users/cltbld', 10:06:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:51 INFO - 'LOGNAME': 'cltbld', 10:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:51 INFO - 'MOZ_NO_REMOTE': '1', 10:06:51 INFO - 'NO_EM_RESTART': '1', 10:06:51 INFO - 'PAGER': '/bin/cat', 10:06:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:51 INFO - 'PWD': '/builds/slave/test', 10:06:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:51 INFO - 'SHELL': '/bin/bash', 10:06:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aYFnX7NnW/Listeners', 10:06:51 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:06:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:51 INFO - 'USER': 'cltbld', 10:06:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:51 INFO - 'XPC_FLAGS': '0x0', 10:06:51 INFO - 'XPC_SERVICE_NAME': '0', 10:06:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:51 INFO - Downloading/unpacking blobuploader==1.2.4 10:06: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:06: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:06: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:06: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:06: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:06: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:06:54 INFO - Downloading blobuploader-1.2.4.tar.gz 10:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:06:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:06:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:55 INFO - Downloading docopt-0.6.1.tar.gz 10:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:06:55 INFO - Installing collected packages: blobuploader, requests, docopt 10:06:55 INFO - Running setup.py install for blobuploader 10:06:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:06:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:06:55 INFO - Running setup.py install for requests 10:06:55 INFO - Running setup.py install for docopt 10:06:56 INFO - Successfully installed blobuploader requests docopt 10:06:56 INFO - Cleaning up... 10:06:56 INFO - Return code: 0 10:06:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:56 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 0x103f9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81596140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7cd30>, '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 0x103ca3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d71be8>, '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.6oWvsXWNyv/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.6aYFnX7NnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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:06:56 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:06:56 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:06:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6oWvsXWNyv/Render', 10:06:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:56 INFO - 'HOME': '/Users/cltbld', 10:06:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:56 INFO - 'LOGNAME': 'cltbld', 10:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:56 INFO - 'MOZ_NO_REMOTE': '1', 10:06:56 INFO - 'NO_EM_RESTART': '1', 10:06:56 INFO - 'PAGER': '/bin/cat', 10:06:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:56 INFO - 'PWD': '/builds/slave/test', 10:06:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:56 INFO - 'SHELL': '/bin/bash', 10:06:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aYFnX7NnW/Listeners', 10:06:56 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:06:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:56 INFO - 'USER': 'cltbld', 10:06:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:56 INFO - 'XPC_FLAGS': '0x0', 10:06:56 INFO - 'XPC_SERVICE_NAME': '0', 10:06:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:56 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-u1ugTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:56 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-jeQ4Hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:56 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-HiZoXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:56 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-xMl1GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:56 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-og_VXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:56 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-swoSPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:57 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-fPcXUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:57 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-cc9PFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:57 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-txQJqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:57 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-dqOdx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:57 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-4Qn4ZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:57 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-_UFJb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:57 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-y3_c8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:57 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-40PbBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:57 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-yVoLdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:58 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-X5EULU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:58 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-LtOlmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:06:58 INFO - Running setup.py install for manifestparser 10:06:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:06:58 INFO - Running setup.py install for mozcrash 10:06:58 INFO - Running setup.py install for mozdebug 10:06:58 INFO - Running setup.py install for mozdevice 10:06:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:06:58 INFO - Running setup.py install for mozfile 10:06:58 INFO - Running setup.py install for mozhttpd 10:06:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:06:59 INFO - Running setup.py install for mozinfo 10:06:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:06:59 INFO - Running setup.py install for mozInstall 10:06:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:06:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:06:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:06:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:06:59 INFO - Running setup.py install for mozleak 10:06:59 INFO - Running setup.py install for mozlog 10:06:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:06:59 INFO - Running setup.py install for moznetwork 10:06:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:06:59 INFO - Running setup.py install for mozprocess 10:06:59 INFO - Running setup.py install for mozprofile 10:07:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:07:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:07:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:07:00 INFO - Running setup.py install for mozrunner 10:07:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:07:00 INFO - Running setup.py install for mozscreenshot 10:07:00 INFO - Running setup.py install for moztest 10:07:00 INFO - Running setup.py install for mozversion 10:07:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:07:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:07:00 INFO - Cleaning up... 10:07:00 INFO - Return code: 0 10:07:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:00 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 0x103f9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81596140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7cd30>, '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 0x103ca3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d71be8>, '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.6oWvsXWNyv/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.6aYFnX7NnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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:07:00 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:07:00 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:07:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6oWvsXWNyv/Render', 10:07:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:07:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:07:00 INFO - 'HOME': '/Users/cltbld', 10:07:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:07:00 INFO - 'LOGNAME': 'cltbld', 10:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:00 INFO - 'MOZ_NO_REMOTE': '1', 10:07:00 INFO - 'NO_EM_RESTART': '1', 10:07:00 INFO - 'PAGER': '/bin/cat', 10:07:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:00 INFO - 'PWD': '/builds/slave/test', 10:07:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:07:00 INFO - 'SHELL': '/bin/bash', 10:07:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aYFnX7NnW/Listeners', 10:07:00 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:07:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:07:00 INFO - 'USER': 'cltbld', 10:07:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:07:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:00 INFO - 'XPC_FLAGS': '0x0', 10:07:00 INFO - 'XPC_SERVICE_NAME': '0', 10:07:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:01 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-PAZTay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:01 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:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:01 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-dRoSnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:01 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:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:01 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-I9CCuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:01 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:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:01 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Xg09W_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:01 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:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:01 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-3HRRCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:01 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:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:01 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-szEsWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:01 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:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:01 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-UDuYnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:01 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:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:01 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Qvab0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:01 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:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:01 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-dYzl6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:01 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:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:01 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Vmqh1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:02 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:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:02 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-J9EcsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:02 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:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:02 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-_K3JxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:02 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:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:02 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-zEPoeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:02 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:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:02 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-bsWY9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:02 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:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:02 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-JGAfyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:02 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:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:02 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-SwM0hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:02 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:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:02 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-UjzPrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:02 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:07:02 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:07:02 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:07:02 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:07:02 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:07:02 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:07:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:07:02 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:07:02 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:07:02 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:07:02 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:07:02 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:07:02 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:07:05 INFO - Downloading blessings-1.6.tar.gz 10:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:07:05 INFO - Installing collected packages: blessings 10:07:05 INFO - Running setup.py install for blessings 10:07:05 INFO - Successfully installed blessings 10:07:05 INFO - Cleaning up... 10:07:05 INFO - Return code: 0 10:07:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:07:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:06 INFO - Reading from file tmpfile_stdout 10:07:06 INFO - Current package versions: 10:07:06 INFO - blessings == 1.6 10:07:06 INFO - blobuploader == 1.2.4 10:07:06 INFO - docopt == 0.6.1 10:07:06 INFO - functools32 == 3.2.3-2 10:07:06 INFO - jsonschema == 2.5.1 10:07:06 INFO - manifestparser == 1.1 10:07:06 INFO - mozInstall == 1.12 10:07:06 INFO - mozcrash == 1.0 10:07:06 INFO - mozdebug == 0.1 10:07:06 INFO - mozdevice == 0.49 10:07:06 INFO - mozfile == 1.2 10:07:06 INFO - mozhttpd == 0.7 10:07:06 INFO - mozinfo == 0.9 10:07:06 INFO - mozleak == 0.1 10:07:06 INFO - mozlog == 3.4 10:07:06 INFO - moznetwork == 0.27 10:07:06 INFO - mozprocess == 0.25 10:07:06 INFO - mozprofile == 0.28 10:07:06 INFO - mozrunner == 6.13 10:07:06 INFO - mozscreenshot == 0.1 10:07:06 INFO - mozsystemmonitor == 0.3 10:07:06 INFO - moztest == 0.8 10:07:06 INFO - mozversion == 1.4 10:07:06 INFO - psutil == 3.1.1 10:07:06 INFO - requests == 1.2.3 10:07:06 INFO - wsgiref == 0.1.2 10:07:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:06 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:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:06 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:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:06 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 0x103f9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81596140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7cd30>, '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 0x103ca3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d71be8>, '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.6oWvsXWNyv/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.6aYFnX7NnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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:07:06 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:07:06 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:07:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6oWvsXWNyv/Render', 10:07:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:07:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:07:06 INFO - 'HOME': '/Users/cltbld', 10:07:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:07:06 INFO - 'LOGNAME': 'cltbld', 10:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:06 INFO - 'MOZ_NO_REMOTE': '1', 10:07:06 INFO - 'NO_EM_RESTART': '1', 10:07:06 INFO - 'PAGER': '/bin/cat', 10:07:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:06 INFO - 'PWD': '/builds/slave/test', 10:07:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:07:06 INFO - 'SHELL': '/bin/bash', 10:07:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aYFnX7NnW/Listeners', 10:07:06 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:07:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:07:06 INFO - 'USER': 'cltbld', 10:07:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:07:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:06 INFO - 'XPC_FLAGS': '0x0', 10:07:06 INFO - 'XPC_SERVICE_NAME': '0', 10:07:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:06 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:07:06 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:07:06 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:07:06 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:07:06 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:07:06 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:07:06 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:07:06 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:07:06 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:07:06 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:07:06 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:07:06 INFO - Cleaning up... 10:07:06 INFO - Return code: 0 10:07:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:07:06 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:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:06 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:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:06 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 0x103f9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81596140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7cd30>, '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 0x103ca3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d71be8>, '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.6oWvsXWNyv/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.6aYFnX7NnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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:07:06 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:07:06 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:07:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6oWvsXWNyv/Render', 10:07:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:07:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:07:06 INFO - 'HOME': '/Users/cltbld', 10:07:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:07:06 INFO - 'LOGNAME': 'cltbld', 10:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:06 INFO - 'MOZ_NO_REMOTE': '1', 10:07:06 INFO - 'NO_EM_RESTART': '1', 10:07:06 INFO - 'PAGER': '/bin/cat', 10:07:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:06 INFO - 'PWD': '/builds/slave/test', 10:07:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:07:06 INFO - 'SHELL': '/bin/bash', 10:07:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aYFnX7NnW/Listeners', 10:07:06 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:07:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:07:06 INFO - 'USER': 'cltbld', 10:07:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:07:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:06 INFO - 'XPC_FLAGS': '0x0', 10:07:06 INFO - 'XPC_SERVICE_NAME': '0', 10:07:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:07:06 INFO - Cleaning up... 10:07:06 INFO - Return code: 0 10:07:06 INFO - Running post-action listener: _resource_record_post_action 10:07:06 INFO - Running post-action listener: _start_resource_monitoring 10:07:06 INFO - Starting resource monitoring. 10:07:06 INFO - [mozharness: 2017-03-31 17:07:06.654292Z] Finished create-virtualenv step (success) 10:07:06 INFO - [mozharness: 2017-03-31 17:07:06.655226Z] Running install step. 10:07:06 INFO - Running pre-action listener: _resource_record_pre_action 10:07:06 INFO - Running main action method: install 10:07:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:06 INFO - Reading from file tmpfile_stdout 10:07:06 INFO - Detecting whether we're running mozinstall >=1.0... 10:07:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:07:07 INFO - Reading from file tmpfile_stdout 10:07:07 INFO - Output received: 10:07:07 INFO - Usage: mozinstall [options] installer 10:07:07 INFO - Options: 10:07:07 INFO - -h, --help show this help message and exit 10:07:07 INFO - -d DEST, --destination=DEST 10:07:07 INFO - Directory to install application into. [default: 10:07:07 INFO - "/builds/slave/test"] 10:07:07 INFO - --app=APP Application being installed. [default: firefox] 10:07:07 INFO - mkdir: /builds/slave/test/build/application 10:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:07:27 INFO - Reading from file tmpfile_stdout 10:07:27 INFO - Output received: 10:07:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:07:27 INFO - Running post-action listener: _resource_record_post_action 10:07:27 INFO - [mozharness: 2017-03-31 17:07:27.226559Z] Finished install step (success) 10:07:27 INFO - [mozharness: 2017-03-31 17:07:27.226689Z] Running run-tests step. 10:07:27 INFO - Running pre-action listener: _resource_record_pre_action 10:07:27 INFO - Running main action method: run_tests 10:07:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:07:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:07:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:07:27 INFO - 2017-03-31 10:07:27.241 screenresolution[1624:7503] starting screenresolution argv=screenresolution get 10:07:27 INFO - 2017-03-31 10:07:27.243 screenresolution[1624:7503] Display 0: 1600x1200x32@60 10:07:27 INFO - 2017-03-31 10:07:27.249 screenresolution[1625:7506] starting screenresolution argv=screenresolution list 10:07:27 INFO - Available Modes on Display 0 10:07:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:07:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:07:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:07:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:07:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:07:27 INFO - Intel Iris: 10:07:27 INFO - Chipset Model: Intel Iris 10:07:27 INFO - Type: GPU 10:07:27 INFO - Bus: Built-In 10:07:27 INFO - VRAM (Dynamic, Max): 1536 MB 10:07:27 INFO - Vendor: Intel (0x8086) 10:07:27 INFO - Device ID: 0x0a2e 10:07:27 INFO - Revision ID: 0x0009 10:07:27 INFO - Displays: 10:07:27 INFO - Display: 10:07:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:07:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:07:27 INFO - Display Serial Number: 1600x1200 60 10:07:27 INFO - Main Display: Yes 10:07:27 INFO - Mirror: Off 10:07:27 INFO - Online: Yes 10:07:27 INFO - Rotation: Supported 10:07:27 INFO - Return code: 0 10:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:07:27 INFO - Python 2.7.3 10:07:27 INFO - Return code: 0 10:07:27 INFO - grabbing minidump binary from tooltool 10:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:27 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 0x103d7cd30>, '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 0x103ca3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d71be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:07:27 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:07:27 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:07:27 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:07:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:07:27 INFO - Return code: 0 10:07:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:07:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:07:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:07:27 INFO - ENV: RUST_BACKTRACE is now 1 10:07:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:07:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--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:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0320 --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:07:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6oWvsXWNyv/Render', 10:07:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:07:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:07:27 INFO - 'HOME': '/Users/cltbld', 10:07:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:07:27 INFO - 'LOGNAME': 'cltbld', 10:07:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:07:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:27 INFO - 'MOZ_NO_REMOTE': '1', 10:07:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:07:27 INFO - 'NO_EM_RESTART': '1', 10:07:27 INFO - 'PAGER': '/bin/cat', 10:07:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:27 INFO - 'PWD': '/builds/slave/test', 10:07:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:07:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:07:27 INFO - 'RUST_BACKTRACE': '1', 10:07:27 INFO - 'SHELL': '/bin/bash', 10:07:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aYFnX7NnW/Listeners', 10:07:27 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 10:07:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:07:27 INFO - 'USER': 'cltbld', 10:07:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:07:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:27 INFO - 'XPC_FLAGS': '0x0', 10:07:27 INFO - 'XPC_SERVICE_NAME': '0', 10:07:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:07:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--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:07:27 INFO - mozversion application_buildid: 20170331085322 10:07:27 INFO - mozversion application_changeset: 5bd82c644e1fdc15b92ca9e34b31841151b44957 10:07:27 INFO - mozversion application_display_name: Nightly 10:07:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:07:27 INFO - mozversion application_name: Firefox 10:07:27 INFO - mozversion application_remotingname: firefox 10:07:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:07:27 INFO - mozversion application_vendor: Mozilla 10:07:27 INFO - mozversion application_version: 55.0a1 10:07:27 INFO - mozversion platform_buildid: 20170331085322 10:07:27 INFO - mozversion platform_changeset: 5bd82c644e1fdc15b92ca9e34b31841151b44957 10:07:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:07:27 INFO - mozversion platform_version: 55.0a1 10:07:27 INFO - using testdate: 1490980047 10:07:27 INFO - actual date: 1490980047 10:07:27 INFO - starting webserver on 'localhost:49249' 10:07:27 INFO - SUITE-START | Running 2 tests 10:07:27 INFO - TEST-START | dromaeo_css 10:07:27 INFO - operating with platform_type : mac_ 10:07:27 INFO - Initialising browser for dromaeo_css test... 10:07:27 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpvQbaAR/profile http://localhost:49249/getInfo.html) 10:07:30 INFO - PID 1635 | 2017-03-31 10:07:30.899 plugin-container[1637:7696] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 10:07:30 INFO - PID 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:07:30 INFO - PID 1635 | 2017-03-31 10:07:30.902 plugin-container[1637:7696] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 10:07:30 INFO - PID 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:07:30 INFO - PID 1635 | 2017-03-31 10:07:30.902 plugin-container[1637:7696] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:07:30 INFO - PID 1635 | __metrics Screen width/height:1600/1200 10:07:30 INFO - PID 1635 | colorDepth:24 10:07:30 INFO - PID 1635 | Browser inner width/height: 1024/689 10:07:30 INFO - PID 1635 | __metrics 10:07:31 ERROR - PID 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 10:07:31 INFO - TEST-INFO | 1635: exit 0 10:07:31 INFO - Browser initialized. 10:07:31 INFO - Running cycle 1/1 for dromaeo_css test... 10:07:31 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpvQbaAR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:34 INFO - PID 1638 | 2017-03-31 10:07:34.301 plugin-container[1639:7825] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 10:07:34 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:07:34 INFO - PID 1638 | 2017-03-31 10:07:34.301 plugin-container[1639:7825] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 10:07:34 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:07:34 INFO - PID 1638 | 2017-03-31 10:07:34.301 plugin-container[1639:7825] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:07:44 INFO - PID 1638 | RSS: Main: 228995072 10:07:44 INFO - PID 1638 | 10:10:47 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 10:10:49 INFO - PID 1638 | RSS: Main: 252018688 10:10:49 INFO - PID 1638 | 10:12:32 INFO - PID 1638 | ************************* 10:12:32 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 10:12:32 INFO - PID 1638 | 10:12:32 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:12:32 INFO - PID 1638 | Full stack: 10:12:32 INFO - PID 1638 | ************************* 10:12:32 INFO - PID 1638 | ************************* 10:12:32 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 10:12:32 INFO - PID 1638 | 10:12:32 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:12:32 INFO - PID 1638 | Full stack: 10:12:32 INFO - PID 1638 | ************************* 10:12:32 INFO - PID 1638 | ************************* 10:12:32 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 10:12:32 INFO - PID 1638 | 10:12:32 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:12:32 INFO - PID 1638 | Full stack: 10:12:32 INFO - PID 1638 | ************************* 10:12:32 INFO - PID 1638 | ************************* 10:12:32 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 10:12:32 INFO - PID 1638 | 10:12:32 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:12:32 INFO - PID 1638 | Full stack: 10:12:32 INFO - PID 1638 | ************************* 10:13:51 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 10:13:52 INFO - PID 1638 | RSS: Main: 259956736 10:13:52 INFO - PID 1638 | 10:16:54 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 10:16:55 INFO - PID 1638 | RSS: Main: 272199680 10:16:55 INFO - PID 1638 | 10:19:56 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 10:19:57 INFO - PID 1638 | RSS: Main: 264925184 10:19:57 INFO - PID 1638 | 10:23:00 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 10:23:01 INFO - PID 1638 | RSS: Main: 274292736 10:23:01 INFO - PID 1638 | 10:26:03 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 10:26:04 INFO - PID 1638 | RSS: Main: 273133568 10:26:04 INFO - PID 1638 | 10:26:04 INFO - PID 1638 | __start_tp_report 10:26:04 INFO - PID 1638 | _x_x_mozilla_page_load 10:26:04 INFO - PID 1638 | _x_x_mozilla_page_load_details 10:26:04 INFO - PID 1638 | |i|pagename|runs| 10:26:04 INFO - PID 1638 | |0;dojo.html;3390.8813191538297;3593.802340871251;3609.1698909250854;3654.9817250913743;3664.9816750916243;5495.477929596682;6098.3717168910725;6229.84425389365;6234.189555357802;6265.812025639232;6185.907211391833;6196.194494715692;6208.192934918466;6234.940060189767;6258.2490101187805;5464.371597266306;5502.80740174095;5518.889622207554;5578.107502799553;5620.100783874581;5417.6207665463235;5519.089350257223;5598.104303311471;5626.634268772537;5655.745491452874;5295.708736019517;5299.920501192485;5392.05639013175;5535.806246781363;5549.916751248735;5408.486193811582;5430.321209848769;5451.3458384993655;5509.696966666832;5531.751071201766;4533.818647254139;5124.692518448867;5413.512783849473;5437.972810135963;5479.068558345091;5024.67339622927;6108.205933228652;6247.312795592481;6266.248050233956;6270.372962703739;6465.12720782693;6551.80344589663;6675.6662166891465;6763.425108865752;6772.458203343721;6807.625580593065;6856.965715171442;6880.174379074493;6883.621400822953;6894.310568943116;5302.390225124122;5329.706866122362;6229.408206220402;6369.681515924185;6370.522210834206;6472.385123413363;6475.514336424787;6680;7053.224145344008;7060.646967651597;6340.968295158495;6390.552661313756;6511.576747511396;6574.211094668574;6636.834079147963;6814.216365117975;6834;6852.314768523108;6853.17761868579;6863.965680171567;5733.197352370671;6584.736610535525;6729.831754206184;6750.628715420699;6759.831004224934;6425.775097871646;6511.934880651228;6597.439217666456;6718.126643536407;6740.629265390353;5412.296401467863;5439.184122381595;5440.591955603346;5454.127339625641;5483.835484935458;4798.23228283473;4827.300041493963;4842.903141937141;4850.175470170079;4863.562279394871;6242.781502647385;6278.372162783685;6405.071264666597;6416.903746443807;6437.581557198767;6137.683438940261;6351.396617321347;6810.182778066564;6810.6254156020905;6816.284290149562;6351.555391122577;6379.553431259767;6386.808395748135;6391.488680905516;6393.488520918316;5756.65460072397;6068.362821903725;6069.939300607026;6088.908666370008;6096.268447786294;6874.828129296908;6937.202221744564;6990.930090699231;7027.191872934678;7048.859022819617;6812.93187068123;6814.591124532544;6832.0435139081565;6832.829179270359;6833;6944.861102778017;6997.96501017512;7028.367446929801;7041.260667629826;7056.400205982343;6410.102585637921;6510.73957041713;6585.967070164618;6682.131322928182;6712.563683360566;5459.657154230773;6509.544331896911;6805.319468053155;6820.113385259884;6821.3519715626935;6318.526110541819;6413.134226879311;6559.836004099936;6581.901271481028;6588;5840.014395105684;5954.970225148846;6597.571157874723;6626.900596491153;6635.668216589054;5158.329417175743;6346.90479642815;6410.676842659619;6461.256955449995;6482.254540727877;6616.272210056986;6617.636030018395;6629.635370054693;6635;6646.966765166143;6214.658193799384;6343;6410.423061924449;6424.38968298011;6467.385598368148 10:26:04 INFO - PID 1638 | |1;ext.html;687.384790612402;811.2293321344722;843.1147295339891;1099.619976928954;1286.298967062951;40043.599564004355;40871.79564102175;40910.59089409105;40945;40986.18027639445;40551.79724101375;40741.59258407415;40808.79595602025;40839.387409188814;40970.59029409705;8183.6726530938695;8348.791280217982;8621.224089831914;8865.157810008039;8884;8796.34027447944;8873.3344999125;8897.288216942628;8932.687355942544;8947.865782013276;7866.741321388579;8518.829623407528;8892.466452012899;8910.777230569223;8973.506457144855;8874.511901845395;8882.511461869595;8885.2447541959;8890.288776897833;8896.688615898413;8676.956615216946;8705.912940870638;8741;8748;8748.8687669685;31040.37919241625;32273.031809045766;38767.61232387668;39154.21691566181;39361.803190984145;2652.4960257551197;3010.2497760971196;3099.269769239163;3123.141136187544;3123.9843800781077;20357;23381.766182338128;28526.71473285261;28532.5192301936;29164.416711665646;2756.3798145417322;2799.384135490189;2801.887924483018;2824.4209936962875;2842.7725781937397;271092;276203;310591.89408106083;331184;332638;49044;49413;49448;49489.010219795404;49698.006039879;51133.72165695887;51344;51446.485535144915;51526.74236628793;51551.484485155415;14464.710705785825;14543.563693089225;14546.927265363605;14571.41714331436;14594.270286485846;11808.822867656992;11905.166638335233;11960.461779219955;11962.282263064244;11963.88036119645;13566.932165339307;13629.318534073256;13689.726205475834;13713.520026799015;13722.725545489035;5965.522758179335;5981.162637230791;5984.294476074298;6011.458968692838;6030.33666296707;864.5936409887343;965.1747755668943;978.9265805064506;1009.8535712321673;1013.2096964367805;23438.828058597002;24306.392340191636;24614.015439382583;24668;24765.752342476346;985.3742873275521;1068.1614932278123;1077.5528155815405;1114.7714718482691;1167.4221260476118;11354.432278386048;11902.642920712393;12613.990880729703;12616.87383126157;12637.87362126367;472432;475209;475900;476474;478177;56710.7164464175;57148.71425642845;57231;57256.71371643115;57385.85228295411;1436.547487541421;1446.7178900114377;1494.1707352419294;1499.8800095992294;1512.311898086368;23908.24878694304;24120.527683389824;24179;24199.63700544458;24227.138143137086;38037.80981095077;38147.85556433311;38154.42768358421;38243.23513529769;38282.61717382791;334885;400366;401342;402256;403393;26982;27102.593461097706;27484.175474735788;31978.84010579932;32556.51165232571;41674.166516670106;42512.1497570053;42637;43392.56607434012;43539.12921741484;28639.854405823535;28938.13185604435;29644.258893527833;30071.849640751658;30139.69860301369;25328.493430131664;29111.708882910898;29149;29486;29967.4006519864;34203;35611.109722256115;36227.637723623484;36277.27445451023;36431.817840910626;27748.306292342044;29308.56037159487;29708.554371684873;29933.850330748206;30397.088087357413;24057.879710602036;24314.392140196636;24322.391940201636;24897.75102249027;24934.127305544218 10:26:04 INFO - PID 1638 | |2;jquery.html;380.6574083325007;418.9664826813855;422.7717032802289;434.3354667358941;447.5435056242632;16562.91718541407;21957.902104894772;22709.545809083807;22733.976971036303;22951.540969180627;19628.92040937748;22009.66985495219;23461.648075278885;23689.40776480589;23755.406114847137;6144.754209831602;6388.584741991779;6452.257990331125;6453.548251622388;6460.289368169498;5959.493443057346;6273.749050037993;6351;6364.204474440695;6374.585651932633;6065.999110146842;6252.906206406908;6314.494840412756;6321.936780632203;6339.461145802612;6195.783147589836;6334.366563343698;6340.302566717657;6343.175387199634;6363.045543168516;5411.21537377082;5579.13523403873;5624.690642014729;5638;5651.660900345993;27158.728412715816;27337.726622733717;27433.725662743316;27497.587536186973;27712.03007894714;2054.753429588444;2056.814886660208;2072.0882811563015;2083.916643334265;2098.2131700612117;14798.926005369904;16375.099369534671;17008;17056.658866822592;17270.654586908317;1897.3074827687794;1909.6562618728763;1934.2746470073723;1960.6372821028156;1984.642764302425;131448.34275828654;134813.9777903332;139796;141638;143308.2834585831;12688.80966785499;12791.296478693761;12880.355982200852;12967;13070.477180912658;16740.41408550695;16744.66510669804;16748.83251167497;16753.246103925354;16800.83199168017;8689.13108689126;8989.685361012464;9021.77445563853;9116.270698344117;9141.31440141992;8492.70275540353;8517;8558.52928088961;8693.608787604573;8710.782230444163;6342.365763423713;7102.4318054555515;7973.521588704696;7982.521048737094;8031.678732850737;1698.4628910835713;1899.6580615489067;2090.9545227386307;2148.5165837686395;2183.1376606240447;829.2702421868717;953.68051702679;954.6372378496127;957.2198658093631;1011.3072545306488;15591.766123508156;20377.796222037887;20537.17851285932;21305.934703265084;21535.67696484554;935.8970513243538;962.8651988721584;994.6817018554138;1019.3781793106199;1020.4081632653043;9074.86387704185;10892.183086268562;11146.331220126818;11151.609693660683;11182.21724479295;623962;643222.7838860869;687648;697263;701450;154126.45873541344;155433;158557;167018;171616;1081.978360432787;1178.6051672689573;1219.9634010979685;1237.0804900434966;1251.7246205834701;19596.706049408986;20678.379648610568;22610.321690349316;22702.545949081257;23182.65226021577;48067.51932480631;65810.67094664495;66287.67424651576;67069.51349520254;68077;91044.08955910357;96049.5197524008;96545.51727241318;97337.05325893585;97638;8892.955535222283;8941;9054.773630659287;9098.090190980849;9126.817463650823;14072.014958952775;14226.075305105134;14293;14602.415903364172;14628;11421.828672570084;11683.357415342238;11786;11870.940645296718;11896.583619573274;9987.151092156957;10726.356418614909;11319.773604528027;11380.829287560528;11708.531658733897;10056.69829905104;11875.168738188244;12077.57728479499;12275;12411.875881241072;8711.607977640895;8733.257673097603;8763.948326200642;9150.222231110163;9166.083391661048;11731.941340293244;11892.048636109264;12110.970567501508;12137.271763694207;12198.939005304917 10:26:04 INFO - PID 1638 | |3;mootools.html;1374.9793753093704;1426.7360538300409;1426.7503186942283;1432.5559076686234;1454.0984589554478;10752;10976.012158905696;11026.00765931067;11145.219834611571;11243.943780281088;10962.725931851708;10982.121430285579;11118.444077796119;11136.665900022992;11146.944265278682;2074.439901226668;2441.6825812644333;2470.3330100872754;2477.7770000699934;2484.763947424992;2377.6076947303673;2455.0302630460956;2465.1988103866224;2468.5309791139716;2472.9010839566395;1924.5092501412191;2369.5616310982437;2371.9407014824596;2452.2152911068465;2454.631805229212;2306;2437.792787613046;2447.3392184110367;2447.36368544178;2452.6688896998853;2037.6535988881778;2113.323736404351;2379.964300535476;2444.706635203769;2450.534398464304;10944.17918656104;10946.945265273702;11012.229143959927;11018.779624407547;11103.000729934263;6199.318075011745;6209.59637623553;6436.517261205428;6443.323451037667;6456.806295811133;3941.586133456003;4006.379011253231;4090.877273681794;4113.835446582133;4128.174365126986;1060.7030031591166;1100.756145555525;1184.798584240681;1211.7758214730216;1234.1669373173072;15239.466618668404;15284.847151528566;15333.539993800205;15335.693286134327;15372.231388430646;4639.628829693616;5467.125259958467;5756.222909907193;5887.322957859901;5933.1396947443245;11523.366214858263;11533.538658453735;11551;11582.826257606142;11605.825912611317;6328.936710632926;6330.8100756977365;6346.079818426302;6348.333424990402;6349.174607301114;5700.116481945305;5864.648121112747;5885.411458854081;5885.440883116097;5897.469227769436;4091.202215567995;4231.280682284019;4267.679924005712;4268.061026574149;4353.238183317907;1171.718787490996;1173.2725710059647;1257.4844313831286;1280.9807852882213;1288.9548865789652;748.5097261293861;753.5629334985695;775.4959276470339;775.9340456061298;797.5892415406071;5845.415458454206;5906;5999.730012149464;6074.605150665193;6075.544334174954;563.605476166685;583.4836169989505;584.6375247346672;601.380578004656;601.8796240751867;3327.966720332814;3587.2287458196615;3962.0689138052535;4202.138561594866;4202.222588821078;11752.647420577396;13547.390367433292;13788.93105534466;13789.379477923518;13923.23422211788;11030.558777648805;13336.933315333361;13662.590122296348;13845.861541384456;13865.653358666113;10071.899281007243;10119.59521619127;10155.898441015643;10186.592536298465;10295.07344339013;6305.716242769178;6374.968125159345;6394.936050639434;6438.139562636072;6461.838454038687;11447.885521144683;12239.510419583117;12381.938090309492;12473.87526124727;12784.360781961052;12186.939065304618;12645.87354126447;12647;12685.23888566689;12916;8908.86636700437;9175.495347755937;9199.126083022102;9202.769930751518;9207.447553146832;9708.75728106803;9951.751206219902;10039.849402258826;10074.244431667508;10079.596816127272;8117.985251843519;8767.956160219159;9120.543972801466;9160.038195989591;9287.674931377369;6820.624865632438;7378.557286562824;8666.372431850883;8920.553972301488;9139.725808225763;7721.691132354643;7739.496932699357;7841;7860.174681658572;7866.567338796192;5699.404166833293;5861.531077513874;5931.673757943182;5933.169356290209;6039.969800150971;5869.325027621878;5950.583459157818;6011.849703757441;6084.787032453843;6308.243010838729 10:26:04 INFO - PID 1638 | |4;prototype.html;383.8790780904015;390.87882756345533;397.54282575038684;406.13290624516645;406.85149920279105;5115.311947057471;6388.169537960064;6456.160699109115;6482.222133344006;6483.481321494281;6175.7529698811995;6182.474489668372;6248.625082495042;6326.778562750304;6333.5883167594075;3852.8826640274287;3969.8610548630804;4543.136804007228;4583.243764778807;4601.516840731725;4076.735012224196;4444.22226110431;4554.2485489894125;4596.3794887690065;4607.1571371451355;3510.859565617385;4495.5729205725565;4516.39028731122;4531.773411329436;4563.429571303587;4364.8472303469225;4529.233598896433;4557.179707652621;4575.99328147807;4580.473245576768;3731.3656678364473;3882.9223415531533;3915.138669492707;3920.647141757227;3925.685945124383;6143.1092491588915;6163;6167.902913009553;6169.9383006170265;6175.07373893915;5442;5454.372747134091;5455.699936503531;5456.7544460498975;5468.507834294933;5409.918851217235;6427.40065563286;6572.408483236484;6666.300038495937;6759.763408280686;3919.333713268751;4435.445569303837;4443.489213667336;4453.1761624099645;4456.598906098434;6508.9023664645065;6820.93179068208;6977.860442791167;7018.684159212848;7120.465965052642;4467.6202522785925;4499.032707967737;4512.120136573337;4513.638908887281;4514.909701806011;3958.44581758554;4471.463424389029;4583.679142460062;4587.977060114678;4595.070070570302;5203.349581302337;5384.273123128406;5441.252167655309;5478.863028424321;5485.890282194414;5574.498295153456;6286.49708023357;6642.236142843538;6741.078792544199;6780.864382712318;1294.288141522159;1312.5143696832233;1562.3203906300796;1567.639442928133;1570.2227397438342;776.3711393771064;963.9614415423445;974.5284620223514;1028.4292217819182;1030.6032177611523;5323.281357016831;6438.420542151229;6442.420182183532;6448.193975753031;6469.644169570624;6554.410103090745;6710.429613482908;7007.719691212396;7019;7067.92932070683;5568.860778480489;6408.55273017931;6501.894677904767;6504.38208370204;6579.276279609239;3199.5200719891736;3250.358568922679;3617.3127105849803;3625.184333524936;3670.907582677848;6947.652617369111;7257.346838784535;7298.2701729826595;7312.23221561739;7337;5903.406080358365;6301.054841773771;6484.708188131545;6667.566338286588;7231.89152162718;5780.450857168562;7111.82220444493;7232.45756568249;7320.231375705687;7325.633718314063;7064.32888875556;7066.752663656747;7069.646517674199;7073.893891591733;7096.148462184365;5118.617973147155;6456.935430645822;6634.402903738686;6923.515353925177;6990.650467476504;6423.550351475539;6917.054306171111;6959.234484206834;7355.963220184079;7385.446091543263;4484.237679594542;4496;4520.706154099973;4525.208088584419;4556.270996640522;5893.075636127447;6835.897461537981;7034.331738484836;7036.824079397851;7056.364927156581;6793.218779840184;6797.479676015592;6798.048273241849;6805.6937437816405;6820.863582728219;6127.84680382994;6602.8349291268105;6707.5304728668525;6729.5625784323865;6794.8641027180165;5132.9743351283005;6642.568233064835;6662.966685166543;6673;6722.697478613376;6593.604383736991;6690.1971763386755;6758.42553382968;6820.147481564804;6836.28219036994;6485.081713228971;6604.735810567716;6622.205335359788;6633.038209459505;6648.501362397743 10:26:04 INFO - PID 1638 | |5;yui.html;698.8148140742704;704.7216349541928;737.3363972424819;739.1352118021914;745.1728581274785;15817.84182158178;16485.175741212952;16511.09188994605;16541.751873721903;16604.501864944043;15106.320215590298;15137.091774493538;15274.08355498668;15303.617409564766;15309.0814551127;932.8414169591152;937.878075850142;980.6371642492288;1013.2096964367768;1014.3609525998611;1023.2632504596716;1023.6366090038041;1024.027174184524;1025.2874252394588;1026.3585259212991;1073.9624113156042;1085.1427372375813;1086.869575650923;1090.4983707494562;1090.8309212072143;1075.0109898893038;1075.0754351257913;1076.386459717961;1078.6763970808804;1084.7613525024483;672.8721542906832;721.8087206890178;798.5687728626534;802.8835818806241;804.3243675312765;16163.83836161635;16505.33978640853;16586.75119873203;17030.914845425694;17316.91341543297;12060.577879774253;14840.332185051591;14898.553043408716;15108.924455377763;15693.372265109381;9814.509274536245;11451.828222576669;11728.358089761996;11761.882621150977;11825.704357391134;3001.6848230935657;3055.908322750321;3066.6626671066165;3111.0355789705263;3134.229820355122;113676;115471;118462;119439.4028029863;120000.3999880005;9791.804163916824;11201.66395008151;11646.475908584134;11654.766904662029;11843.170978031627;24902.875485622455;24988.250352489453;25516.234512964642;25537.361565961;25619.487610247692;7088.149422069385;7133.357997780225;7177.952363137549;7287.708491660274;7311.049563556704;4078.184363127327;4162.354835000579;4168.916621667549;4191.790410479463;4192.266353388145;3484;4055.858044968471;4126.319157339066;4177.373393990865;4178.791060447026;774.6475353714046;775.1899265267808;784.3842583571869;785.3442375616424;792.0653628718053;558.7122631844603;561.6180996922051;566.3656704490996;597.1401182297478;609.1897775957965;9538.046195380406;10027.598896044077;10841.349519028883;11207.775844483065;11564.42177891102;546.9316335458068;559.7956745787758;567.4807551090788;579.7478097027806;585.429206523636;4295.952236187712;4617;4624.838130665411;4781.880452988634;4832.710037397767;96438.51780741052;97152.51423742836;97372;98934;100463;67526.64946701039;68657;87493;89123.77190570158;92833;77502.6124869372;80254;80994.78507822387;82257.58871205845;83274.58362708268;9307.395019323721;10435.634752783617;10798.352098874093;10968;10972.780544389227;39350.40974385329;39428.80285598669;39709.205815884096;39775;39933.40266389312;48766;49281;50028.499715002385;50183;50286.74856625694;12670.303133327387;13506.851917587115;13763.174209547458;13776.380062896993;13780.862191377957;11500.712482188012;14539.345729442412;14904.105753654816;15020.549383518512;15084.698306033599;12066.939665301617;12463.153694605779;13313.201207927556;13382.263975481443;13411.195328280335;11372.943135284602;13532.391042402918;13654.453821847015;13875.167489950636;14277.785833212303;12489.125761196992;13267.29506312295;13376.799348009594;13404.396802143732;14212.289385530476;9781.706548803548;9848.753781155528;9945.264124300913;10066.597336106473;10647.988441098083;8041.276285134366;8659.653613855628;9637.42175469474;11118.777624447628;11137.665870023913 10:26:04 INFO - PID 1638 | __end_tp_report 10:26:04 INFO - PID 1638 | __start_cc_report 10:26:04 INFO - PID 1638 | _x_x_mozilla_cycle_collect,430 10:26:04 INFO - PID 1638 | __end_cc_report 10:26:04 INFO - PID 1638 | __startTimestamp1490981164219__endTimestamp 10:26:04 INFO - PID 1638 | 10:26:04 INFO - PID 1638 | ------- Summary: start ------- 10:26:04 INFO - PID 1638 | Number of tests: 6 10:26:04 INFO - PID 1638 | 10:26:04 INFO - PID 1638 | [#0] dojo.html Cycles:165 Average:6155.92 Median:6390.55 stddev:746.77 (11.7%) stddev-sans-first:716.87 10:26:04 INFO - PID 1638 | Values: 3390.9 3593.8 3609.2 3655.0 3665.0 5495.5 6098.4 6229.8 6234.2 6265.8 6185.9 6196.2 6208.2 6234.9 6258.2 5464.4 5502.8 5518.9 5578.1 5620.1 5417.6 5519.1 5598.1 5626.6 5655.7 5295.7 5299.9 5392.1 5535.8 5549.9 5408.5 5430.3 5451.3 5509.7 5531.8 4533.8 5124.7 5413.5 5438.0 5479.1 5024.7 6108.2 6247.3 6266.2 6270.4 6465.1 6551.8 6675.7 6763.4 6772.5 6807.6 6857.0 6880.2 6883.6 6894.3 5302.4 5329.7 6229.4 6369.7 6370.5 6472.4 6475.5 6680.0 7053.2 7060.6 6341.0 6390.6 6511.6 6574.2 6636.8 6814.2 6834.0 6852.3 6853.2 6864.0 5733.2 6584.7 6729.8 6750.6 6759.8 6425.8 6511.9 6597.4 6718.1 6740.6 5412.3 5439.2 5440.6 5454.1 5483.8 4798.2 4827.3 4842.9 4850.2 4863.6 6242.8 6278.4 6405.1 6416.9 6437.6 6137.7 6351.4 6810.2 6810.6 6816.3 6351.6 6379.6 6386.8 6391.5 6393.5 5756.7 6068.4 6069.9 6088.9 6096.3 6874.8 6937.2 6990.9 7027.2 7048.9 6812.9 6814.6 6832.0 6832.8 6833.0 6944.9 6998.0 7028.4 7041.3 7056.4 6410.1 6510.7 6586.0 6682.1 6712.6 5459.7 6509.5 6805.3 6820.1 6821.4 6318.5 6413.1 6559.8 6581.9 6588.0 5840.0 5955.0 6597.6 6626.9 6635.7 5158.3 6346.9 6410.7 6461.3 6482.3 6616.3 6617.6 6629.6 6635.0 6647.0 6214.7 6343.0 6410.4 6424.4 6467.4 10:26:04 INFO - PID 1638 | 10:26:04 INFO - PID 1638 | [#1] ext.html Cycles:180 Average:52466.13 Median:184544.00 stddev:105257.45 (57.0%) stddev-sans-first:105480.93 10:26:04 INFO - PID 1638 | Values: 687.4 811.2 843.1 1099.6 1286.3 40043.6 40871.8 40910.6 40945.0 40986.2 40551.8 40741.6 40808.8 40839.4 40970.6 8183.7 8348.8 8621.2 8865.2 8884.0 8796.3 8873.3 8897.3 8932.7 8947.9 7866.7 8518.8 8892.5 8910.8 8973.5 8874.5 8882.5 8885.2 8890.3 8896.7 8677.0 8705.9 8741.0 8748.0 8748.9 31040.4 32273.0 38767.6 39154.2 39361.8 2652.5 3010.2 3099.3 3123.1 3124.0 20357.0 23381.8 28526.7 28532.5 29164.4 2756.4 2799.4 2801.9 2824.4 2842.8 271092.0 276203.0 310591.9 331184.0 332638.0 49044.0 49413.0 49448.0 49489.0 49698.0 51133.7 51344.0 51446.5 51526.7 51551.5 14464.7 14543.6 14546.9 14571.4 14594.3 11808.8 11905.2 11960.5 11962.3 11963.9 13566.9 13629.3 13689.7 13713.5 13722.7 5965.5 5981.2 5984.3 6011.5 6030.3 864.6 965.2 978.9 1009.9 1013.2 23438.8 24306.4 24614.0 24668.0 24765.8 985.4 1068.2 1077.6 1114.8 1167.4 11354.4 11902.6 12614.0 12616.9 12637.9 472432.0 475209.0 475900.0 476474.0 478177.0 56710.7 57148.7 57231.0 57256.7 57385.9 1436.5 1446.7 1494.2 1499.9 1512.3 23908.2 24120.5 24179.0 24199.6 24227.1 38037.8 38147.9 38154.4 38243.2 38282.6 334885.0 400366.0 401342.0 402256.0 403393.0 26982.0 27102.6 27484.2 31978.8 32556.5 41674.2 42512.1 42637.0 43392.6 43539.1 28639.9 28938.1 29644.3 30071.8 30139.7 25328.5 29111.7 29149.0 29486.0 29967.4 34203.0 35611.1 36227.6 36277.3 36431.8 27748.3 29308.6 29708.6 29933.9 30397.1 24057.9 24314.4 24322.4 24897.8 24934.1 10:26:04 INFO - PID 1638 | 10:26:04 INFO - PID 1638 | [#2] jquery.html Cycles:180 Average:40084.70 Median:22842.76 stddev:112878.12 (494.2%) stddev-sans-first:113155.40 10:26:04 INFO - PID 1638 | Values: 380.7 419.0 422.8 434.3 447.5 16562.9 21957.9 22709.5 22734.0 22951.5 19628.9 22009.7 23461.6 23689.4 23755.4 6144.8 6388.6 6452.3 6453.5 6460.3 5959.5 6273.7 6351.0 6364.2 6374.6 6066.0 6252.9 6314.5 6321.9 6339.5 6195.8 6334.4 6340.3 6343.2 6363.0 5411.2 5579.1 5624.7 5638.0 5651.7 27158.7 27337.7 27433.7 27497.6 27712.0 2054.8 2056.8 2072.1 2083.9 2098.2 14798.9 16375.1 17008.0 17056.7 17270.7 1897.3 1909.7 1934.3 1960.6 1984.6 131448.3 134814.0 139796.0 141638.0 143308.3 12688.8 12791.3 12880.4 12967.0 13070.5 16740.4 16744.7 16748.8 16753.2 16800.8 8689.1 8989.7 9021.8 9116.3 9141.3 8492.7 8517.0 8558.5 8693.6 8710.8 6342.4 7102.4 7973.5 7982.5 8031.7 1698.5 1899.7 2091.0 2148.5 2183.1 829.3 953.7 954.6 957.2 1011.3 15591.8 20377.8 20537.2 21305.9 21535.7 935.9 962.9 994.7 1019.4 1020.4 9074.9 10892.2 11146.3 11151.6 11182.2 623962.0 643222.8 687648.0 697263.0 701450.0 154126.5 155433.0 158557.0 167018.0 171616.0 1082.0 1178.6 1220.0 1237.1 1251.7 19596.7 20678.4 22610.3 22702.5 23182.7 48067.5 65810.7 66287.7 67069.5 68077.0 91044.1 96049.5 96545.5 97337.1 97638.0 8893.0 8941.0 9054.8 9098.1 9126.8 14072.0 14226.1 14293.0 14602.4 14628.0 11421.8 11683.4 11786.0 11870.9 11896.6 9987.2 10726.4 11319.8 11380.8 11708.5 10056.7 11875.2 12077.6 12275.0 12411.9 8711.6 8733.3 8763.9 9150.2 9166.1 11731.9 11892.0 12111.0 12137.3 12198.9 10:26:04 INFO - PID 1638 | 10:26:04 INFO - PID 1638 | [#3] mootools.html Cycles:180 Average:6752.59 Median:2475.34 stddev:4182.92 (169.0%) stddev-sans-first:4175.14 10:26:04 INFO - PID 1638 | Values: 1375.0 1426.7 1426.8 1432.6 1454.1 10752.0 10976.0 11026.0 11145.2 11243.9 10962.7 10982.1 11118.4 11136.7 11146.9 2074.4 2441.7 2470.3 2477.8 2484.8 2377.6 2455.0 2465.2 2468.5 2472.9 1924.5 2369.6 2371.9 2452.2 2454.6 2306.0 2437.8 2447.3 2447.4 2452.7 2037.7 2113.3 2380.0 2444.7 2450.5 10944.2 10946.9 11012.2 11018.8 11103.0 6199.3 6209.6 6436.5 6443.3 6456.8 3941.6 4006.4 4090.9 4113.8 4128.2 1060.7 1100.8 1184.8 1211.8 1234.2 15239.5 15284.8 15333.5 15335.7 15372.2 4639.6 5467.1 5756.2 5887.3 5933.1 11523.4 11533.5 11551.0 11582.8 11605.8 6328.9 6330.8 6346.1 6348.3 6349.2 5700.1 5864.6 5885.4 5885.4 5897.5 4091.2 4231.3 4267.7 4268.1 4353.2 1171.7 1173.3 1257.5 1281.0 1289.0 748.5 753.6 775.5 775.9 797.6 5845.4 5906.0 5999.7 6074.6 6075.5 563.6 583.5 584.6 601.4 601.9 3328.0 3587.2 3962.1 4202.1 4202.2 11752.6 13547.4 13788.9 13789.4 13923.2 11030.6 13336.9 13662.6 13845.9 13865.7 10071.9 10119.6 10155.9 10186.6 10295.1 6305.7 6375.0 6394.9 6438.1 6461.8 11447.9 12239.5 12381.9 12473.9 12784.4 12186.9 12645.9 12647.0 12685.2 12916.0 8908.9 9175.5 9199.1 9202.8 9207.4 9708.8 9951.8 10039.8 10074.2 10079.6 8118.0 8768.0 9120.5 9160.0 9287.7 6820.6 7378.6 8666.4 8920.6 9139.7 7721.7 7739.5 7841.0 7860.2 7866.6 5699.4 5861.5 5931.7 5933.2 6040.0 5869.3 5950.6 6011.8 6084.8 6308.2 10:26:04 INFO - PID 1638 | 10:26:04 INFO - PID 1638 | [#4] prototype.html Cycles:180 Average:5421.66 Median:6267.56 stddev:1753.74 (28.0%) stddev-sans-first:1717.41 10:26:04 INFO - PID 1638 | Values: 383.9 390.9 397.5 406.1 406.9 5115.3 6388.2 6456.2 6482.2 6483.5 6175.8 6182.5 6248.6 6326.8 6333.6 3852.9 3969.9 4543.1 4583.2 4601.5 4076.7 4444.2 4554.2 4596.4 4607.2 3510.9 4495.6 4516.4 4531.8 4563.4 4364.8 4529.2 4557.2 4576.0 4580.5 3731.4 3882.9 3915.1 3920.6 3925.7 6143.1 6163.0 6167.9 6169.9 6175.1 5442.0 5454.4 5455.7 5456.8 5468.5 5409.9 6427.4 6572.4 6666.3 6759.8 3919.3 4435.4 4443.5 4453.2 4456.6 6508.9 6820.9 6977.9 7018.7 7120.5 4467.6 4499.0 4512.1 4513.6 4514.9 3958.4 4471.5 4583.7 4588.0 4595.1 5203.3 5384.3 5441.3 5478.9 5485.9 5574.5 6286.5 6642.2 6741.1 6780.9 1294.3 1312.5 1562.3 1567.6 1570.2 776.4 964.0 974.5 1028.4 1030.6 5323.3 6438.4 6442.4 6448.2 6469.6 6554.4 6710.4 7007.7 7019.0 7067.9 5568.9 6408.6 6501.9 6504.4 6579.3 3199.5 3250.4 3617.3 3625.2 3670.9 6947.7 7257.3 7298.3 7312.2 7337.0 5903.4 6301.1 6484.7 6667.6 7231.9 5780.5 7111.8 7232.5 7320.2 7325.6 7064.3 7066.8 7069.6 7073.9 7096.1 5118.6 6456.9 6634.4 6923.5 6990.7 6423.6 6917.1 6959.2 7356.0 7385.4 4484.2 4496.0 4520.7 4525.2 4556.3 5893.1 6835.9 7034.3 7036.8 7056.4 6793.2 6797.5 6798.0 6805.7 6820.9 6127.8 6602.8 6707.5 6729.6 6794.9 5133.0 6642.6 6663.0 6673.0 6722.7 6593.6 6690.2 6758.4 6820.1 6836.3 6485.1 6604.7 6622.2 6633.0 6648.5 10:26:04 INFO - PID 1638 | 10:26:04 INFO - PID 1638 | [#5] yui.html Cycles:180 Average:19900.36 Median:25526.80 stddev:28842.26 (113.0%) stddev-sans-first:28887.14 10:26:04 INFO - PID 1638 | Values: 698.8 704.7 737.3 739.1 745.2 15817.8 16485.2 16511.1 16541.8 16604.5 15106.3 15137.1 15274.1 15303.6 15309.1 932.8 937.9 980.6 1013.2 1014.4 1023.3 1023.6 1024.0 1025.3 1026.4 1074.0 1085.1 1086.9 1090.5 1090.8 1075.0 1075.1 1076.4 1078.7 1084.8 672.9 721.8 798.6 802.9 804.3 16163.8 16505.3 16586.8 17030.9 17316.9 12060.6 14840.3 14898.6 15108.9 15693.4 9814.5 11451.8 11728.4 11761.9 11825.7 3001.7 3055.9 3066.7 3111.0 3134.2 113676.0 115471.0 118462.0 119439.4 120000.4 9791.8 11201.7 11646.5 11654.8 11843.2 24902.9 24988.3 25516.2 25537.4 25619.5 7088.1 7133.4 7178.0 7287.7 7311.0 4078.2 4162.4 4168.9 4191.8 4192.3 3484.0 4055.9 4126.3 4177.4 4178.8 774.6 775.2 784.4 785.3 792.1 558.7 561.6 566.4 597.1 609.2 9538.0 10027.6 10841.3 11207.8 11564.4 546.9 559.8 567.5 579.7 585.4 4296.0 4617.0 4624.8 4781.9 4832.7 96438.5 97152.5 97372.0 98934.0 100463.0 67526.6 68657.0 87493.0 89123.8 92833.0 77502.6 80254.0 80994.8 82257.6 83274.6 9307.4 10435.6 10798.4 10968.0 10972.8 39350.4 39428.8 39709.2 39775.0 39933.4 48766.0 49281.0 50028.5 50183.0 50286.7 12670.3 13506.9 13763.2 13776.4 13780.9 11500.7 14539.3 14904.1 15020.5 15084.7 12066.9 12463.2 13313.2 13382.3 13411.2 11372.9 13532.4 13654.5 13875.2 14277.8 12489.1 13267.3 13376.8 13404.4 14212.3 9781.7 9848.8 9945.3 10066.6 10648.0 8041.3 8659.7 9637.4 11118.8 11137.7 10:26:04 INFO - PID 1638 | -------- Summary: end -------- 10:26:04 INFO - PID 1638 | 10:26:04 INFO - TEST-INFO | 1638: exit 0 10:26:04 INFO - TEST-OK | dromaeo_css | took 1117060ms 10:26:04 INFO - TEST-START | kraken 10:26:04 INFO - operating with platform_type : mac_ 10:26:04 INFO - Initialising browser for kraken test... 10:26:04 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmp1qap0u/profile http://localhost:49249/getInfo.html) 10:26:07 INFO - PID 1650 | 2017-03-31 10:26:07.501 plugin-container[1651:10408] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 10:26:07 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:26:07 INFO - PID 1650 | 2017-03-31 10:26:07.503 plugin-container[1651:10408] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 10:26:07 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:26:07 INFO - PID 1650 | 2017-03-31 10:26:07.503 plugin-container[1651:10408] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:26:07 INFO - PID 1650 | __metrics Screen width/height:1600/1200 10:26:07 INFO - PID 1650 | colorDepth:24 10:26:07 INFO - PID 1650 | Browser inner width/height: 1024/689 10:26:07 INFO - PID 1650 | __metrics 10:26:07 ERROR - PID 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 10:26:08 INFO - TEST-INFO | 1650: exit 0 10:26:08 INFO - Browser initialized. 10:26:08 INFO - Running cycle 1/1 for kraken test... 10:26:08 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmp1qap0u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:26:11 INFO - PID 1652 | 2017-03-31 10:26:11.195 plugin-container[1653:10533] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 10:26:11 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:26:11 INFO - PID 1652 | 2017-03-31 10:26:11.195 plugin-container[1653:10533] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 10:26:11 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:26:11 INFO - PID 1652 | 2017-03-31 10:26:11.195 plugin-container[1653:10533] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:26:20 INFO - PID 1652 | RSS: Main: 228818944 10:26:20 INFO - PID 1652 | 10:26:23 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 10:26:24 INFO - PID 1652 | RSS: Main: 243605504 10:26:24 INFO - PID 1652 | 10:26:27 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 10:26:28 INFO - PID 1652 | RSS: Main: 252153856 10:26:28 INFO - PID 1652 | 10:26:31 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 10:26:32 INFO - PID 1652 | RSS: Main: 254472192 10:26:32 INFO - PID 1652 | 10:26:34 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 10:26:35 INFO - PID 1652 | RSS: Main: 255418368 10:26:35 INFO - PID 1652 | 10:26:37 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:26:37 INFO - PID 1652 | RSS: Main: 257159168 10:26:37 INFO - PID 1652 | 10:26:40 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 10:26:41 INFO - PID 1652 | RSS: Main: 263110656 10:26:41 INFO - PID 1652 | 10:26:44 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 10:26:45 INFO - PID 1652 | RSS: Main: 263348224 10:26:45 INFO - PID 1652 | 10:26:48 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 10:26:49 INFO - PID 1652 | RSS: Main: 263106560 10:26:49 INFO - PID 1652 | 10:26:50 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:26:51 INFO - PID 1652 | RSS: Main: 262799360 10:26:51 INFO - PID 1652 | 10:26:53 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:26:53 INFO - PID 1652 | RSS: Main: 262893568 10:26:53 INFO - PID 1652 | 10:26:56 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:26:56 INFO - PID 1652 | RSS: Main: 262832128 10:26:56 INFO - PID 1652 | 10:26:59 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:27:00 INFO - PID 1652 | RSS: Main: 263442432 10:27:00 INFO - PID 1652 | 10:27:04 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:27:04 INFO - PID 1652 | RSS: Main: 260407296 10:27:04 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 10:27:06 INFO - PID 1652 | RSS: Main: 263737344 10:27:06 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | __start_tp_report 10:27:06 INFO - PID 1652 | _x_x_mozilla_page_load 10:27:06 INFO - PID 1652 | _x_x_mozilla_page_load_details 10:27:06 INFO - PID 1652 | |i|pagename|runs| 10:27:06 INFO - PID 1652 | |0;ai-astar;113;181;167;120;121;124;121;121;122;129 10:27:06 INFO - PID 1652 | |1;audio-beat-detection;151;121;122;157;119;121;123;120;155;156 10:27:06 INFO - PID 1652 | |2;audio-dft;219;254;292;256;297;212;214;206;214;255 10:27:06 INFO - PID 1652 | |3;audio-fft;91;74;83;123;52;78;94;89;73;81 10:27:06 INFO - PID 1652 | |4;audio-oscillator;97;70;90;72;71;75;85;71;75;70 10:27:06 INFO - PID 1652 | |5;imaging-gaussian-blur;90;108;105;90;90;92;92;108;106;89 10:27:06 INFO - PID 1652 | |6;imaging-darkroom;99;98;99;102;98;98;100;100;100;120 10:27:06 INFO - PID 1652 | |7;imaging-desaturate;101;119;100;101;99;101;101;103;104;111 10:27:06 INFO - PID 1652 | |8;json-parse-financial;54;51;51;52;53;53;52;50;52;52 10:27:06 INFO - PID 1652 | |9;json-stringify-tinderbox;60;62;87;105;62;60;60;60;61;60 10:27:06 INFO - PID 1652 | |10;stanford-crypto-aes;87;89;81;77;100;117;118;117;78;104 10:27:06 INFO - PID 1652 | |11;stanford-crypto-ccm;153;163;170;173;174;153;166;172;222;166 10:27:06 INFO - PID 1652 | |12;stanford-crypto-pbkdf2;185;237;168;197;254;201;256;261;196;196 10:27:06 INFO - PID 1652 | |13;stanford-crypto-sha256-iterative;72;73;72;69;70;74;73;71;70;72 10:27:06 INFO - PID 1652 | __end_tp_report 10:27:06 INFO - PID 1652 | __start_cc_report 10:27:06 INFO - PID 1652 | _x_x_mozilla_cycle_collect,1014 10:27:06 INFO - PID 1652 | __end_cc_report 10:27:06 INFO - PID 1652 | __startTimestamp1490981226770__endTimestamp 10:27:06 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | ------- Summary: start ------- 10:27:06 INFO - PID 1652 | Number of tests: 14 10:27:06 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | [#0] ai-astar Cycles:10 Average:131.90 Median:123.00 stddev:22.77 (18.5%) stddev-sans-first:23.10 10:27:06 INFO - PID 1652 | Values: 113.0 181.0 167.0 120.0 121.0 124.0 121.0 121.0 122.0 129.0 10:27:06 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:137.00 stddev:17.53 (12.8%) stddev-sans-first:17.54 10:27:06 INFO - PID 1652 | Values: 151.0 121.0 122.0 157.0 119.0 121.0 123.0 120.0 155.0 156.0 10:27:06 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | [#2] audio-dft Cycles:10 Average:241.90 Median:254.50 stddev:33.87 (13.3%) stddev-sans-first:34.90 10:27:06 INFO - PID 1652 | Values: 219.0 254.0 292.0 256.0 297.0 212.0 214.0 206.0 214.0 255.0 10:27:06 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | [#3] audio-fft Cycles:10 Average:83.80 Median:82.00 stddev:18.21 (22.2%) stddev-sans-first:19.13 10:27:06 INFO - PID 1652 | Values: 91.0 74.0 83.0 123.0 52.0 78.0 94.0 89.0 73.0 81.0 10:27:06 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:75.00 stddev:9.62 (12.8%) stddev-sans-first:7.20 10:27:06 INFO - PID 1652 | Values: 97.0 70.0 90.0 72.0 71.0 75.0 85.0 71.0 75.0 70.0 10:27:06 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:97.00 Median:90.00 stddev:8.49 (9.4%) stddev-sans-first:8.61 10:27:06 INFO - PID 1652 | Values: 90.0 108.0 105.0 90.0 90.0 92.0 92.0 108.0 106.0 89.0 10:27:06 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | [#6] imaging-darkroom Cycles:10 Average:101.40 Median:98.00 stddev:6.65 (6.8%) stddev-sans-first:7.00 10:27:06 INFO - PID 1652 | Values: 99.0 98.0 99.0 102.0 98.0 98.0 100.0 100.0 100.0 120.0 10:27:06 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | [#7] imaging-desaturate Cycles:10 Average:104.00 Median:103.50 stddev:6.25 (6.0%) stddev-sans-first:6.54 10:27:06 INFO - PID 1652 | Values: 101.0 119.0 100.0 101.0 99.0 101.0 101.0 103.0 104.0 111.0 10:27:06 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.15 (2.2%) stddev-sans-first:0.97 10:27:06 INFO - PID 1652 | Values: 54.0 51.0 51.0 52.0 53.0 53.0 52.0 50.0 52.0 52.0 10:27:06 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:60.50 stddev:15.53 (25.7%) stddev-sans-first:16.22 10:27:06 INFO - PID 1652 | Values: 60.0 62.0 87.0 105.0 62.0 60.0 60.0 60.0 61.0 60.0 10:27:06 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | [#10] stanford-crypto-aes Cycles:10 Average:96.80 Median:77.50 stddev:16.60 (21.4%) stddev-sans-first:17.22 10:27:06 INFO - PID 1652 | Values: 87.0 89.0 81.0 77.0 100.0 117.0 118.0 117.0 78.0 104.0 10:27:06 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:171.20 Median:171.00 stddev:19.37 (11.3%) stddev-sans-first:19.40 10:27:06 INFO - PID 1652 | Values: 153.0 163.0 170.0 173.0 174.0 153.0 166.0 172.0 222.0 166.0 10:27:06 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:215.10 Median:219.00 stddev:33.59 (15.3%) stddev-sans-first:33.81 10:27:06 INFO - PID 1652 | Values: 185.0 237.0 168.0 197.0 254.0 201.0 256.0 261.0 196.0 196.0 10:27:06 INFO - PID 1652 | 10:27:06 INFO - PID 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:1.58 (2.2%) stddev-sans-first:1.67 10:27:06 INFO - PID 1652 | Values: 72.0 73.0 72.0 69.0 70.0 74.0 73.0 71.0 70.0 72.0 10:27:06 INFO - PID 1652 | -------- Summary: end -------- 10:27:06 INFO - PID 1652 | 10:27:07 INFO - TEST-INFO | 1652: exit 0 10:27:07 INFO - TEST-OK | kraken | took 62741ms 10:27:07 INFO - SUITE-END | took 1179s 10:27:07 INFO - Completed test suite (00:19:40) 10:27:07 INFO - javascript benchmark 10:27:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7733.413897207355, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3390.8813191538297, 3593.802340871251, 3609.1698909250854, 3654.9817250913743, 3664.9816750916243, 5495.477929596682, 6098.3717168910725, 6229.84425389365, 6234.189555357802, 6265.812025639232, 6185.907211391833, 6196.194494715692, 6208.192934918466, 6234.940060189767, 6258.2490101187805, 5464.371597266306, 5502.80740174095, 5518.889622207554, 5578.107502799553, 5620.100783874581, 5417.6207665463235, 5519.089350257223, 5598.104303311471, 5626.634268772537, 5655.745491452874, 5295.708736019517, 5299.920501192485, 5392.05639013175, 5535.806246781363, 5549.916751248735, 5408.486193811582, 5430.321209848769, 5451.3458384993655, 5509.696966666832, 5531.751071201766, 4533.818647254139, 5124.692518448867, 5413.512783849473, 5437.972810135963, 5479.068558345091, 5024.67339622927, 6108.205933228652, 6247.312795592481, 6266.248050233956, 6270.372962703739, 6465.12720782693, 6551.80344589663, 6675.6662166891465, 6763.425108865752, 6772.458203343721, 6807.625580593065, 6856.965715171442, 6880.174379074493, 6883.621400822953, 6894.310568943116, 5302.390225124122, 5329.706866122362, 6229.408206220402, 6369.681515924185, 6370.522210834206, 6472.385123413363, 6475.514336424787, 6680.0, 7053.224145344008, 7060.646967651597, 6340.968295158495, 6390.552661313756, 6511.576747511396, 6574.211094668574, 6636.834079147963, 6814.216365117975, 6834.0, 6852.314768523108, 6853.17761868579, 6863.965680171567, 5733.197352370671, 6584.736610535525, 6729.831754206184, 6750.628715420699, 6759.831004224934, 6425.775097871646, 6511.934880651228, 6597.439217666456, 6718.126643536407, 6740.629265390353, 5412.296401467863, 5439.184122381595, 5440.591955603346, 5454.127339625641, 5483.835484935458, 4798.23228283473, 4827.300041493963, 4842.903141937141, 4850.175470170079, 4863.562279394871, 6242.781502647385, 6278.372162783685, 6405.071264666597, 6416.903746443807, 6437.581557198767, 6137.683438940261, 6351.396617321347, 6810.182778066564, 6810.6254156020905, 6816.284290149562, 6351.555391122577, 6379.553431259767, 6386.808395748135, 6391.488680905516, 6393.488520918316, 5756.65460072397, 6068.362821903725, 6069.939300607026, 6088.908666370008, 6096.268447786294, 6874.828129296908, 6937.202221744564, 6990.930090699231, 7027.191872934678, 7048.859022819617, 6812.93187068123, 6814.591124532544, 6832.0435139081565, 6832.829179270359, 6833.0, 6944.861102778017, 6997.96501017512, 7028.367446929801, 7041.260667629826, 7056.400205982343, 6410.102585637921, 6510.73957041713, 6585.967070164618, 6682.131322928182, 6712.563683360566, 5459.657154230773, 6509.544331896911, 6805.319468053155, 6820.113385259884, 6821.3519715626935, 6318.526110541819, 6413.134226879311, 6559.836004099936, 6581.901271481028, 6588.0, 5840.014395105684, 5954.970225148846, 6597.571157874723, 6626.900596491153, 6635.668216589054, 5158.329417175743, 6346.90479642815, 6410.676842659619, 6461.256955449995, 6482.254540727877, 6616.272210056986, 6617.636030018395, 6629.635370054693, 6635.0, 6646.966765166143, 6214.658193799384, 6343.0, 6410.423061924449, 6424.38968298011, 6467.385598368148], "value": 6108.111008876699, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.384790612402, 811.2293321344722, 843.1147295339891, 1099.619976928954, 1286.298967062951, 40043.599564004355, 40871.79564102175, 40910.59089409105, 40945.0, 40986.18027639445, 40551.79724101375, 40741.59258407415, 40808.79595602025, 40839.387409188814, 40970.59029409705, 8183.6726530938695, 8348.791280217982, 8621.224089831914, 8865.157810008039, 8884.0, 8796.34027447944, 8873.3344999125, 8897.288216942628, 8932.687355942544, 8947.865782013276, 7866.741321388579, 8518.829623407528, 8892.466452012899, 8910.777230569223, 8973.506457144855, 8874.511901845395, 8882.511461869595, 8885.2447541959, 8890.288776897833, 8896.688615898413, 8676.956615216946, 8705.912940870638, 8741.0, 8748.0, 8748.8687669685, 31040.37919241625, 32273.031809045766, 38767.61232387668, 39154.21691566181, 39361.803190984145, 2652.4960257551197, 3010.2497760971196, 3099.269769239163, 3123.141136187544, 3123.9843800781077, 20357.0, 23381.766182338128, 28526.71473285261, 28532.5192301936, 29164.416711665646, 2756.3798145417322, 2799.384135490189, 2801.887924483018, 2824.4209936962875, 2842.7725781937397, 271092.0, 276203.0, 310591.89408106083, 331184.0, 332638.0, 49044.0, 49413.0, 49448.0, 49489.010219795404, 49698.006039879, 51133.72165695887, 51344.0, 51446.485535144915, 51526.74236628793, 51551.484485155415, 14464.710705785825, 14543.563693089225, 14546.927265363605, 14571.41714331436, 14594.270286485846, 11808.822867656992, 11905.166638335233, 11960.461779219955, 11962.282263064244, 11963.88036119645, 13566.932165339307, 13629.318534073256, 13689.726205475834, 13713.520026799015, 13722.725545489035, 5965.522758179335, 5981.162637230791, 5984.294476074298, 6011.458968692838, 6030.33666296707, 864.5936409887343, 965.1747755668943, 978.9265805064506, 1009.8535712321673, 1013.2096964367805, 23438.828058597002, 24306.392340191636, 24614.015439382583, 24668.0, 24765.752342476346, 985.3742873275521, 1068.1614932278123, 1077.5528155815405, 1114.7714718482691, 1167.4221260476118, 11354.432278386048, 11902.642920712393, 12613.990880729703, 12616.87383126157, 12637.87362126367, 472432.0, 475209.0, 475900.0, 476474.0, 478177.0, 56710.7164464175, 57148.71425642845, 57231.0, 57256.71371643115, 57385.85228295411, 1436.547487541421, 1446.7178900114377, 1494.1707352419294, 1499.8800095992294, 1512.311898086368, 23908.24878694304, 24120.527683389824, 24179.0, 24199.63700544458, 24227.138143137086, 38037.80981095077, 38147.85556433311, 38154.42768358421, 38243.23513529769, 38282.61717382791, 334885.0, 400366.0, 401342.0, 402256.0, 403393.0, 26982.0, 27102.593461097706, 27484.175474735788, 31978.84010579932, 32556.51165232571, 41674.166516670106, 42512.1497570053, 42637.0, 43392.56607434012, 43539.12921741484, 28639.854405823535, 28938.13185604435, 29644.258893527833, 30071.849640751658, 30139.69860301369, 25328.493430131664, 29111.708882910898, 29149.0, 29486.0, 29967.4006519864, 34203.0, 35611.109722256115, 36227.637723623484, 36277.27445451023, 36431.817840910626, 27748.306292342044, 29308.56037159487, 29708.554371684873, 29933.850330748206, 30397.088087357413, 24057.879710602036, 24314.392140196636, 24322.391940201636, 24897.75102249027, 24934.127305544218], "value": 17702.62541125346, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.6574083325007, 418.9664826813855, 422.7717032802289, 434.3354667358941, 447.5435056242632, 16562.91718541407, 21957.902104894772, 22709.545809083807, 22733.976971036303, 22951.540969180627, 19628.92040937748, 22009.66985495219, 23461.648075278885, 23689.40776480589, 23755.406114847137, 6144.754209831602, 6388.584741991779, 6452.257990331125, 6453.548251622388, 6460.289368169498, 5959.493443057346, 6273.749050037993, 6351.0, 6364.204474440695, 6374.585651932633, 6065.999110146842, 6252.906206406908, 6314.494840412756, 6321.936780632203, 6339.461145802612, 6195.783147589836, 6334.366563343698, 6340.302566717657, 6343.175387199634, 6363.045543168516, 5411.21537377082, 5579.13523403873, 5624.690642014729, 5638.0, 5651.660900345993, 27158.728412715816, 27337.726622733717, 27433.725662743316, 27497.587536186973, 27712.03007894714, 2054.753429588444, 2056.814886660208, 2072.0882811563015, 2083.916643334265, 2098.2131700612117, 14798.926005369904, 16375.099369534671, 17008.0, 17056.658866822592, 17270.654586908317, 1897.3074827687794, 1909.6562618728763, 1934.2746470073723, 1960.6372821028156, 1984.642764302425, 131448.34275828654, 134813.9777903332, 139796.0, 141638.0, 143308.2834585831, 12688.80966785499, 12791.296478693761, 12880.355982200852, 12967.0, 13070.477180912658, 16740.41408550695, 16744.66510669804, 16748.83251167497, 16753.246103925354, 16800.83199168017, 8689.13108689126, 8989.685361012464, 9021.77445563853, 9116.270698344117, 9141.31440141992, 8492.70275540353, 8517.0, 8558.52928088961, 8693.608787604573, 8710.782230444163, 6342.365763423713, 7102.4318054555515, 7973.521588704696, 7982.521048737094, 8031.678732850737, 1698.4628910835713, 1899.6580615489067, 2090.9545227386307, 2148.5165837686395, 2183.1376606240447, 829.2702421868717, 953.68051702679, 954.6372378496127, 957.2198658093631, 1011.3072545306488, 15591.766123508156, 20377.796222037887, 20537.17851285932, 21305.934703265084, 21535.67696484554, 935.8970513243538, 962.8651988721584, 994.6817018554138, 1019.3781793106199, 1020.4081632653043, 9074.86387704185, 10892.183086268562, 11146.331220126818, 11151.609693660683, 11182.21724479295, 623962.0, 643222.7838860869, 687648.0, 697263.0, 701450.0, 154126.45873541344, 155433.0, 158557.0, 167018.0, 171616.0, 1081.978360432787, 1178.6051672689573, 1219.9634010979685, 1237.0804900434966, 1251.7246205834701, 19596.706049408986, 20678.379648610568, 22610.321690349316, 22702.545949081257, 23182.65226021577, 48067.51932480631, 65810.67094664495, 66287.67424651576, 67069.51349520254, 68077.0, 91044.08955910357, 96049.5197524008, 96545.51727241318, 97337.05325893585, 97638.0, 8892.955535222283, 8941.0, 9054.773630659287, 9098.090190980849, 9126.817463650823, 14072.014958952775, 14226.075305105134, 14293.0, 14602.415903364172, 14628.0, 11421.828672570084, 11683.357415342238, 11786.0, 11870.940645296718, 11896.583619573274, 9987.151092156957, 10726.356418614909, 11319.773604528027, 11380.829287560528, 11708.531658733897, 10056.69829905104, 11875.168738188244, 12077.57728479499, 12275.0, 12411.875881241072, 8711.607977640895, 8733.257673097603, 8763.948326200642, 9150.222231110163, 9166.083391661048, 11731.941340293244, 11892.048636109264, 12110.970567501508, 12137.271763694207, 12198.939005304917], "value": 10593.030157417017, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.9793753093704, 1426.7360538300409, 1426.7503186942283, 1432.5559076686234, 1454.0984589554478, 10752.0, 10976.012158905696, 11026.00765931067, 11145.219834611571, 11243.943780281088, 10962.725931851708, 10982.121430285579, 11118.444077796119, 11136.665900022992, 11146.944265278682, 2074.439901226668, 2441.6825812644333, 2470.3330100872754, 2477.7770000699934, 2484.763947424992, 2377.6076947303673, 2455.0302630460956, 2465.1988103866224, 2468.5309791139716, 2472.9010839566395, 1924.5092501412191, 2369.5616310982437, 2371.9407014824596, 2452.2152911068465, 2454.631805229212, 2306.0, 2437.792787613046, 2447.3392184110367, 2447.36368544178, 2452.6688896998853, 2037.6535988881778, 2113.323736404351, 2379.964300535476, 2444.706635203769, 2450.534398464304, 10944.17918656104, 10946.945265273702, 11012.229143959927, 11018.779624407547, 11103.000729934263, 6199.318075011745, 6209.59637623553, 6436.517261205428, 6443.323451037667, 6456.806295811133, 3941.586133456003, 4006.379011253231, 4090.877273681794, 4113.835446582133, 4128.174365126986, 1060.7030031591166, 1100.756145555525, 1184.798584240681, 1211.7758214730216, 1234.1669373173072, 15239.466618668404, 15284.847151528566, 15333.539993800205, 15335.693286134327, 15372.231388430646, 4639.628829693616, 5467.125259958467, 5756.222909907193, 5887.322957859901, 5933.1396947443245, 11523.366214858263, 11533.538658453735, 11551.0, 11582.826257606142, 11605.825912611317, 6328.936710632926, 6330.8100756977365, 6346.079818426302, 6348.333424990402, 6349.174607301114, 5700.116481945305, 5864.648121112747, 5885.411458854081, 5885.440883116097, 5897.469227769436, 4091.202215567995, 4231.280682284019, 4267.679924005712, 4268.061026574149, 4353.238183317907, 1171.718787490996, 1173.2725710059647, 1257.4844313831286, 1280.9807852882213, 1288.9548865789652, 748.5097261293861, 753.5629334985695, 775.4959276470339, 775.9340456061298, 797.5892415406071, 5845.415458454206, 5906.0, 5999.730012149464, 6074.605150665193, 6075.544334174954, 563.605476166685, 583.4836169989505, 584.6375247346672, 601.380578004656, 601.8796240751867, 3327.966720332814, 3587.2287458196615, 3962.0689138052535, 4202.138561594866, 4202.222588821078, 11752.647420577396, 13547.390367433292, 13788.93105534466, 13789.379477923518, 13923.23422211788, 11030.558777648805, 13336.933315333361, 13662.590122296348, 13845.861541384456, 13865.653358666113, 10071.899281007243, 10119.59521619127, 10155.898441015643, 10186.592536298465, 10295.07344339013, 6305.716242769178, 6374.968125159345, 6394.936050639434, 6438.139562636072, 6461.838454038687, 11447.885521144683, 12239.510419583117, 12381.938090309492, 12473.87526124727, 12784.360781961052, 12186.939065304618, 12645.87354126447, 12647.0, 12685.23888566689, 12916.0, 8908.86636700437, 9175.495347755937, 9199.126083022102, 9202.769930751518, 9207.447553146832, 9708.75728106803, 9951.751206219902, 10039.849402258826, 10074.244431667508, 10079.596816127272, 8117.985251843519, 8767.956160219159, 9120.543972801466, 9160.038195989591, 9287.674931377369, 6820.624865632438, 7378.557286562824, 8666.372431850883, 8920.553972301488, 9139.725808225763, 7721.691132354643, 7739.496932699357, 7841.0, 7860.174681658572, 7866.567338796192, 5699.404166833293, 5861.531077513874, 5931.673757943182, 5933.169356290209, 6039.969800150971, 5869.325027621878, 5950.583459157818, 6011.849703757441, 6084.787032453843, 6308.243010838729], "value": 5090.195057183968, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.8790780904015, 390.87882756345533, 397.54282575038684, 406.13290624516645, 406.85149920279105, 5115.311947057471, 6388.169537960064, 6456.160699109115, 6482.222133344006, 6483.481321494281, 6175.7529698811995, 6182.474489668372, 6248.625082495042, 6326.778562750304, 6333.5883167594075, 3852.8826640274287, 3969.8610548630804, 4543.136804007228, 4583.243764778807, 4601.516840731725, 4076.735012224196, 4444.22226110431, 4554.2485489894125, 4596.3794887690065, 4607.1571371451355, 3510.859565617385, 4495.5729205725565, 4516.39028731122, 4531.773411329436, 4563.429571303587, 4364.8472303469225, 4529.233598896433, 4557.179707652621, 4575.99328147807, 4580.473245576768, 3731.3656678364473, 3882.9223415531533, 3915.138669492707, 3920.647141757227, 3925.685945124383, 6143.1092491588915, 6163.0, 6167.902913009553, 6169.9383006170265, 6175.07373893915, 5442.0, 5454.372747134091, 5455.699936503531, 5456.7544460498975, 5468.507834294933, 5409.918851217235, 6427.40065563286, 6572.408483236484, 6666.300038495937, 6759.763408280686, 3919.333713268751, 4435.445569303837, 4443.489213667336, 4453.1761624099645, 4456.598906098434, 6508.9023664645065, 6820.93179068208, 6977.860442791167, 7018.684159212848, 7120.465965052642, 4467.6202522785925, 4499.032707967737, 4512.120136573337, 4513.638908887281, 4514.909701806011, 3958.44581758554, 4471.463424389029, 4583.679142460062, 4587.977060114678, 4595.070070570302, 5203.349581302337, 5384.273123128406, 5441.252167655309, 5478.863028424321, 5485.890282194414, 5574.498295153456, 6286.49708023357, 6642.236142843538, 6741.078792544199, 6780.864382712318, 1294.288141522159, 1312.5143696832233, 1562.3203906300796, 1567.639442928133, 1570.2227397438342, 776.3711393771064, 963.9614415423445, 974.5284620223514, 1028.4292217819182, 1030.6032177611523, 5323.281357016831, 6438.420542151229, 6442.420182183532, 6448.193975753031, 6469.644169570624, 6554.410103090745, 6710.429613482908, 7007.719691212396, 7019.0, 7067.92932070683, 5568.860778480489, 6408.55273017931, 6501.894677904767, 6504.38208370204, 6579.276279609239, 3199.5200719891736, 3250.358568922679, 3617.3127105849803, 3625.184333524936, 3670.907582677848, 6947.652617369111, 7257.346838784535, 7298.2701729826595, 7312.23221561739, 7337.0, 5903.406080358365, 6301.054841773771, 6484.708188131545, 6667.566338286588, 7231.89152162718, 5780.450857168562, 7111.82220444493, 7232.45756568249, 7320.231375705687, 7325.633718314063, 7064.32888875556, 7066.752663656747, 7069.646517674199, 7073.893891591733, 7096.148462184365, 5118.617973147155, 6456.935430645822, 6634.402903738686, 6923.515353925177, 6990.650467476504, 6423.550351475539, 6917.054306171111, 6959.234484206834, 7355.963220184079, 7385.446091543263, 4484.237679594542, 4496.0, 4520.706154099973, 4525.208088584419, 4556.270996640522, 5893.075636127447, 6835.897461537981, 7034.331738484836, 7036.824079397851, 7056.364927156581, 6793.218779840184, 6797.479676015592, 6798.048273241849, 6805.6937437816405, 6820.863582728219, 6127.84680382994, 6602.8349291268105, 6707.5304728668525, 6729.5625784323865, 6794.8641027180165, 5132.9743351283005, 6642.568233064835, 6662.966685166543, 6673.0, 6722.697478613376, 6593.604383736991, 6690.1971763386755, 6758.42553382968, 6820.147481564804, 6836.28219036994, 6485.081713228971, 6604.735810567716, 6622.205335359788, 6633.038209459505, 6648.501362397743], "value": 4860.621108377929, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.8148140742704, 704.7216349541928, 737.3363972424819, 739.1352118021914, 745.1728581274785, 15817.84182158178, 16485.175741212952, 16511.09188994605, 16541.751873721903, 16604.501864944043, 15106.320215590298, 15137.091774493538, 15274.08355498668, 15303.617409564766, 15309.0814551127, 932.8414169591152, 937.878075850142, 980.6371642492288, 1013.2096964367768, 1014.3609525998611, 1023.2632504596716, 1023.6366090038041, 1024.027174184524, 1025.2874252394588, 1026.3585259212991, 1073.9624113156042, 1085.1427372375813, 1086.869575650923, 1090.4983707494562, 1090.8309212072143, 1075.0109898893038, 1075.0754351257913, 1076.386459717961, 1078.6763970808804, 1084.7613525024483, 672.8721542906832, 721.8087206890178, 798.5687728626534, 802.8835818806241, 804.3243675312765, 16163.83836161635, 16505.33978640853, 16586.75119873203, 17030.914845425694, 17316.91341543297, 12060.577879774253, 14840.332185051591, 14898.553043408716, 15108.924455377763, 15693.372265109381, 9814.509274536245, 11451.828222576669, 11728.358089761996, 11761.882621150977, 11825.704357391134, 3001.6848230935657, 3055.908322750321, 3066.6626671066165, 3111.0355789705263, 3134.229820355122, 113676.0, 115471.0, 118462.0, 119439.4028029863, 120000.3999880005, 9791.804163916824, 11201.66395008151, 11646.475908584134, 11654.766904662029, 11843.170978031627, 24902.875485622455, 24988.250352489453, 25516.234512964642, 25537.361565961, 25619.487610247692, 7088.149422069385, 7133.357997780225, 7177.952363137549, 7287.708491660274, 7311.049563556704, 4078.184363127327, 4162.354835000579, 4168.916621667549, 4191.790410479463, 4192.266353388145, 3484.0, 4055.858044968471, 4126.319157339066, 4177.373393990865, 4178.791060447026, 774.6475353714046, 775.1899265267808, 784.3842583571869, 785.3442375616424, 792.0653628718053, 558.7122631844603, 561.6180996922051, 566.3656704490996, 597.1401182297478, 609.1897775957965, 9538.046195380406, 10027.598896044077, 10841.349519028883, 11207.775844483065, 11564.42177891102, 546.9316335458068, 559.7956745787758, 567.4807551090788, 579.7478097027806, 585.429206523636, 4295.952236187712, 4617.0, 4624.838130665411, 4781.880452988634, 4832.710037397767, 96438.51780741052, 97152.51423742836, 97372.0, 98934.0, 100463.0, 67526.64946701039, 68657.0, 87493.0, 89123.77190570158, 92833.0, 77502.6124869372, 80254.0, 80994.78507822387, 82257.58871205845, 83274.58362708268, 9307.395019323721, 10435.634752783617, 10798.352098874093, 10968.0, 10972.780544389227, 39350.40974385329, 39428.80285598669, 39709.205815884096, 39775.0, 39933.40266389312, 48766.0, 49281.0, 50028.499715002385, 50183.0, 50286.74856625694, 12670.303133327387, 13506.851917587115, 13763.174209547458, 13776.380062896993, 13780.862191377957, 11500.712482188012, 14539.345729442412, 14904.105753654816, 15020.549383518512, 15084.698306033599, 12066.939665301617, 12463.153694605779, 13313.201207927556, 13382.263975481443, 13411.195328280335, 11372.943135284602, 13532.391042402918, 13654.453821847015, 13875.167489950636, 14277.785833212303, 12489.125761196992, 13267.29506312295, 13376.799348009594, 13404.396802143732, 14212.289385530476, 9781.706548803548, 9848.753781155528, 9945.264124300913, 10066.597336106473, 10647.988441098083, 8041.276285134366, 8659.653613855628, 9637.42175469474, 11118.777624447628, 11137.665870023913], "value": 7547.5263535487875, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1646.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 181.0, 167.0, 120.0, 121.0, 124.0, 121.0, 121.0, 122.0, 129.0], "value": 131.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 122.0, 157.0, 119.0, 121.0, 123.0, 120.0, 155.0, 156.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [219.0, 254.0, 292.0, 256.0, 297.0, 212.0, 214.0, 206.0, 214.0, 255.0], "value": 241.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 74.0, 83.0, 123.0, 52.0, 78.0, 94.0, 89.0, 73.0, 81.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 70.0, 90.0, 72.0, 71.0, 75.0, 85.0, 71.0, 75.0, 70.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 108.0, 105.0, 90.0, 90.0, 92.0, 92.0, 108.0, 106.0, 89.0], "value": 97.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 98.0, 99.0, 102.0, 98.0, 98.0, 100.0, 100.0, 100.0, 120.0], "value": 101.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 119.0, 100.0, 101.0, 99.0, 101.0, 101.0, 103.0, 104.0, 111.0], "value": 104.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 51.0, 52.0, 53.0, 53.0, 52.0, 50.0, 52.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 87.0, 105.0, 62.0, 60.0, 60.0, 60.0, 61.0, 60.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 81.0, 77.0, 100.0, 117.0, 118.0, 117.0, 78.0, 104.0], "value": 96.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 163.0, 170.0, 173.0, 174.0, 153.0, 166.0, 172.0, 222.0, 166.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 237.0, 168.0, 197.0, 254.0, 201.0, 256.0, 261.0, 196.0, 196.0], "value": 215.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 69.0, 70.0, 74.0, 73.0, 71.0, 70.0, 72.0], "value": 71.6, "unit": "score"}]}]} 10:27:08 INFO - Return code: 0 10:27:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:27:08 ERROR - # TBPL SUCCESS # 10:27:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:27:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:27:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:27:08 INFO - 2017-03-31 10:27:08.098 screenresolution[1657:10927] starting screenresolution argv=screenresolution get 10:27:08 INFO - 2017-03-31 10:27:08.101 screenresolution[1657:10927] Display 0: 1600x1200x32@60 10:27:08 INFO - 2017-03-31 10:27:08.107 screenresolution[1658:10930] starting screenresolution argv=screenresolution list 10:27:08 INFO - Available Modes on Display 0 10:27:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:27:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:27:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:27:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:27:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:27:08 INFO - Intel Iris: 10:27:08 INFO - Chipset Model: Intel Iris 10:27:08 INFO - Type: GPU 10:27:08 INFO - Bus: Built-In 10:27:08 INFO - VRAM (Dynamic, Max): 1536 MB 10:27:08 INFO - Vendor: Intel (0x8086) 10:27:08 INFO - Device ID: 0x0a2e 10:27:08 INFO - Revision ID: 0x0009 10:27:08 INFO - Displays: 10:27:08 INFO - Display: 10:27:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:27:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:27:08 INFO - Display Serial Number: 1600x1200 60 10:27:08 INFO - Main Display: Yes 10:27:08 INFO - Mirror: Off 10:27:08 INFO - Online: Yes 10:27:08 INFO - Rotation: Supported 10:27:08 INFO - Return code: 0 10:27:08 INFO - Running post-action listener: _resource_record_post_action 10:27:08 INFO - [mozharness: 2017-03-31 17:27:08.341544Z] Finished run-tests step (success) 10:27:08 INFO - Running post-run listener: _resource_record_post_run 10:27:08 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 39221760; Write bytes: 518275072; Read time: 248; Write time: 1615 10:27:08 INFO - TinderboxPrint: CPU usage
54.1% 10:27:08 INFO - TinderboxPrint: I/O read bytes / time
39,221,760 / 248 10:27:08 INFO - TinderboxPrint: I/O write bytes / time
518,275,072 / 1,615 10:27:08 INFO - TinderboxPrint: CPU idle
2,206.1 (45.9%) 10:27:08 INFO - TinderboxPrint: CPU system
965.0 (20.1%) 10:27:08 INFO - TinderboxPrint: CPU user
1,634.5 (34.0%) 10:27:08 INFO - TinderboxPrint: Swap in / out
251,322,368 / 0 10:27:08 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 205242880; Write bytes: 204334592; Read time: 15867; Write time: 436 10:27:08 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 37222912; Write bytes: 303106560; Read time: 226; Write time: 1145 10:27:08 INFO - Running post-run listener: _upload_blobber_files 10:27:08 INFO - Blob upload gear active. 10:27:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:27:08 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 10:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:27:09 INFO - (blobuploader) - INFO - Open directory for files ... 10:27:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:27:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:27:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:10 INFO - (blobuploader) - INFO - Done attempting. 10:27:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:27:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:27:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:11 INFO - (blobuploader) - INFO - Done attempting. 10:27:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:27:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:27:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:12 INFO - (blobuploader) - INFO - Done attempting. 10:27:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:27:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:27:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:14 INFO - (blobuploader) - INFO - Done attempting. 10:27:14 INFO - (blobuploader) - INFO - Iteration through files over. 10:27:14 INFO - Return code: 0 10:27:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:27:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:27:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1588600a5cc5e34a8728cf0afd7782a246672e6546364c2bd19c24952f7e5a1186b3725cdc754a9d1c57a77d566533d50ce961a09b5ec2058fbb3d34ca1c5c97", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f83dd058eaa091f6654634d6768e73f464ac71f25024319d52f0b8f64fc4774d949f69d25408f0ea538e75cc889a3fd53a80bb15c38baa5eb1ed8b6bd6218e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfb07924339b82d601999c9007230f07f624f86b48d08df5e92b742b87ccbe918c701163628bdd393c4f65148618d72591f3fd39eea70caff326891a3234f9b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f686e884025178c5d83aead8141a4091569488092a25883f104c009abd39f44da8108bede013e86ea9e10f8c5c73bca7209f51558106db40de0d3d1440c1a43"} 10:27:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:27:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:27:14 INFO - Contents: 10:27:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1588600a5cc5e34a8728cf0afd7782a246672e6546364c2bd19c24952f7e5a1186b3725cdc754a9d1c57a77d566533d50ce961a09b5ec2058fbb3d34ca1c5c97", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f83dd058eaa091f6654634d6768e73f464ac71f25024319d52f0b8f64fc4774d949f69d25408f0ea538e75cc889a3fd53a80bb15c38baa5eb1ed8b6bd6218e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfb07924339b82d601999c9007230f07f624f86b48d08df5e92b742b87ccbe918c701163628bdd393c4f65148618d72591f3fd39eea70caff326891a3234f9b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f686e884025178c5d83aead8141a4091569488092a25883f104c009abd39f44da8108bede013e86ea9e10f8c5c73bca7209f51558106db40de0d3d1440c1a43"} 10:27:14 INFO - Running post-run listener: copy_logs_to_upload_dir 10:27:14 INFO - Copying logs to upload dir... 10:27:14 INFO - mkdir: /builds/slave/test/build/upload/logs 10:27:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.745766 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-31 10:27:14.634433) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 10:27:14.638027) ========= 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.6oWvsXWNyv/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.6aYFnX7NnW/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1588600a5cc5e34a8728cf0afd7782a246672e6546364c2bd19c24952f7e5a1186b3725cdc754a9d1c57a77d566533d50ce961a09b5ec2058fbb3d34ca1c5c97", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f83dd058eaa091f6654634d6768e73f464ac71f25024319d52f0b8f64fc4774d949f69d25408f0ea538e75cc889a3fd53a80bb15c38baa5eb1ed8b6bd6218e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfb07924339b82d601999c9007230f07f624f86b48d08df5e92b742b87ccbe918c701163628bdd393c4f65148618d72591f3fd39eea70caff326891a3234f9b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f686e884025178c5d83aead8141a4091569488092a25883f104c009abd39f44da8108bede013e86ea9e10f8c5c73bca7209f51558106db40de0d3d1440c1a43"} build_url:https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011122 build_url: 'https://queue.taskcluster.net/v1/task/Z8ZHuxD_QQaBnjZYQVyk-w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1588600a5cc5e34a8728cf0afd7782a246672e6546364c2bd19c24952f7e5a1186b3725cdc754a9d1c57a77d566533d50ce961a09b5ec2058fbb3d34ca1c5c97", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f83dd058eaa091f6654634d6768e73f464ac71f25024319d52f0b8f64fc4774d949f69d25408f0ea538e75cc889a3fd53a80bb15c38baa5eb1ed8b6bd6218e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfb07924339b82d601999c9007230f07f624f86b48d08df5e92b742b87ccbe918c701163628bdd393c4f65148618d72591f3fd39eea70caff326891a3234f9b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f686e884025178c5d83aead8141a4091569488092a25883f104c009abd39f44da8108bede013e86ea9e10f8c5c73bca7209f51558106db40de0d3d1440c1a43"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 10:27:14.679041) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 10:27:14.679572) ========= 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.6oWvsXWNyv/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.6aYFnX7NnW/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.005067 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 10:27:14.729610) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 10:27:14.729948) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 10:27:14.730297) ========= ========= Total master_lag: 2.78 =========