builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0250 starttime: 1492342973.5 results: success (0) buildid: 20170416030209 builduid: 9bdb920c82814d18843f36e5cd64aba7 revision: ce69b6e1773e9e0d0a190ce899f34b1658e66ca4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-16 04:42:53.503855) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-16 04:42:53.504303) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-16 04:42:53.504598) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-16 04:42:53.535480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-16 04:42:53.535879) ========= 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.glgzxr1qIL/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.ifsKwhdxrV/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-16 04:42:53-- 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% 70.8M=0s 2017-04-16 04:42:55 (70.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.797700 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-16 04:42:55.355304) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 04:42:55.355631) ========= 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.glgzxr1qIL/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.ifsKwhdxrV/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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.026343 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 04:42:55.404009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 04:42:55.404384) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ce69b6e1773e9e0d0a190ce899f34b1658e66ca4 --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 ce69b6e1773e9e0d0a190ce899f34b1658e66ca4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.glgzxr1qIL/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.ifsKwhdxrV/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-16 04:42:55,517 truncating revision to first 12 chars 2017-04-16 04:42:55,517 Setting DEBUG logging. 2017-04-16 04:42:55,517 attempt 1/10 2017-04-16 04:42:55,518 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ce69b6e1773e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-16 04:42:56,176 unpacking tar archive at: mozilla-central-ce69b6e1773e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.936003 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 04:42:56.365547) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-16 04:42:56.365872) ========= script_repo_revision: ce69b6e1773e9e0d0a190ce899f34b1658e66ca4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-16 04:42:56.366303) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-16 04:42:56.366568) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-16 04:42:56.386094) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-16 04:42:56.386456) ========= /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.glgzxr1qIL/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.ifsKwhdxrV/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:42:56 INFO - MultiFileLogger online at 20170416 04:42:56 in /builds/slave/test 04:42:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:42:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:42:56 INFO - {'append_to_log': False, 04:42:56 INFO - 'base_work_dir': '/builds/slave/test', 04:42:56 INFO - 'blob_upload_branch': 'Firefox', 04:42:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:42:56 INFO - 'branch': 'Firefox', 04:42:56 INFO - 'buildbot_json_path': 'buildprops.json', 04:42:56 INFO - 'config_files': ('talos/mac_config.py',), 04:42:56 INFO - 'default_actions': ('clobber', 04:42:56 INFO - 'read-buildbot-config', 04:42:56 INFO - 'download-and-extract', 04:42:56 INFO - 'populate-webroot', 04:42:56 INFO - 'create-virtualenv', 04:42:56 INFO - 'install', 04:42:56 INFO - 'run-tests'), 04:42:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:42:56 INFO - 'download_minidump_stackwalk': True, 04:42:56 INFO - 'download_symbols': 'ondemand', 04:42:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:42:56 INFO - 'tooltool.py': '/tools/tooltool.py', 04:42:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:42:56 INFO - '/tools/misc-python/virtualenv.py')}, 04:42:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:42:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:42:56 INFO - 'gecko_profile': False, 04:42:56 INFO - 'gecko_profile_interval': 0, 04:42:56 INFO - 'installer_path': 'installer.exe', 04:42:56 INFO - 'log_level': 'info', 04:42:56 INFO - 'log_name': 'talos', 04:42:56 INFO - 'log_to_console': True, 04:42:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:42:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:42:56 INFO - 'opt_config_files': (), 04:42:56 INFO - 'pip_index': False, 04:42:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:56 INFO - 'cmd': ('bash', 04:42:56 INFO - '-c', 04:42:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:56 INFO - 'enabled': True, 04:42:56 INFO - 'halt_on_failure': False, 04:42:56 INFO - 'name': 'check_screen_resolution'},), 04:42:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:56 INFO - 'cmd': ('bash', 04:42:56 INFO - '-c', 04:42:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:56 INFO - 'enabled': True, 04:42:56 INFO - 'halt_on_failure': False, 04:42:56 INFO - 'name': 'check_screen_resolution'},), 04:42:56 INFO - 'run_cmd_checks_enabled': True, 04:42:56 INFO - 'suite': 'dromaeojs-e10s', 04:42:56 INFO - 'system_bits': '32', 04:42:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:42:56 INFO - 'title': 't-yosemite-r7-0250', 04:42:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:42:56 INFO - 'use_talos_json': True, 04:42:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:42:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:42:56 INFO - 'work_dir': 'build'} 04:42:56 INFO - [mozharness: 2017-04-16 11:42:56.601561Z] Running clobber step. 04:42:56 INFO - Running pre-action listener: _resource_record_pre_action 04:42:56 INFO - Running main action method: clobber 04:42:56 INFO - rmtree: /builds/slave/test/build 04:42:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:42:59 INFO - Running post-action listener: _resource_record_post_action 04:42:59 INFO - [mozharness: 2017-04-16 11:42:59.157274Z] Finished clobber step (success) 04:42:59 INFO - [mozharness: 2017-04-16 11:42:59.157391Z] Running read-buildbot-config step. 04:42:59 INFO - Running pre-action listener: _resource_record_pre_action 04:42:59 INFO - Running main action method: read_buildbot_config 04:42:59 INFO - Using buildbot properties: 04:42:59 INFO - { 04:42:59 INFO - "project": "", 04:42:59 INFO - "product": "firefox", 04:42:59 INFO - "script_repo_revision": "production", 04:42:59 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:42:59 INFO - "repository": "", 04:42:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:42:59 INFO - "buildid": "20170416030209", 04:42:59 INFO - "stage_platform": "macosx64", 04:42:59 INFO - "basedir": "/builds/slave/test", 04:42:59 INFO - "nightly_build": "True", 04:42:59 INFO - "buildnumber": 13, 04:42:59 INFO - "slavename": "t-yosemite-r7-0250", 04:42:59 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:42:59 INFO - "platform": "yosemite_r7", 04:42:59 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:42:59 INFO - "branch": "mozilla-central", 04:42:59 INFO - "repo_path": "mozilla-central", 04:42:59 INFO - "revision": "ce69b6e1773e9e0d0a190ce899f34b1658e66ca4", 04:42:59 INFO - "pgo_build": "False", 04:42:59 INFO - "builduid": "9bdb920c82814d18843f36e5cd64aba7", 04:42:59 INFO - "slavebuilddir": "test" 04:42:59 INFO - } 04:42:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:42:59 INFO - Running post-action listener: _resource_record_post_action 04:42:59 INFO - [mozharness: 2017-04-16 11:42:59.160933Z] Finished read-buildbot-config step (success) 04:42:59 INFO - [mozharness: 2017-04-16 11:42:59.161044Z] Running download-and-extract step. 04:42:59 INFO - Running pre-action listener: _resource_record_pre_action 04:42:59 INFO - Running main action method: download_and_extract 04:42:59 INFO - mkdir: /builds/slave/test/build/tests 04:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:59 INFO - trying https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:42:59 INFO - Downloading https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:42:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:43:00 INFO - Downloaded 1325 bytes. 04:43:00 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:43:00 INFO - Using the following test package requirements: 04:43:00 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:00 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:43:00 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:43:00 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:00 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:43:00 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:00 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:43:00 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:00 INFO - u'jsshell-mac.zip'], 04:43:00 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:00 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:43:00 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:43:00 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:00 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:43:00 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:00 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:43:00 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:00 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:43:00 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:00 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:43:00 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:43:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:43:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:43:00 INFO - Fetch https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:43:01 INFO - Expected file size: 52660612 04:43:01 INFO - Obtained file size: 52660612 04:43:17 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:43:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:43:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:43:17 INFO - Fetch https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:43:19 INFO - Expected file size: 52660612 04:43:19 INFO - Obtained file size: 52660612 04:43:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:43:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:43:35 INFO - Fetch https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:43:37 INFO - Expected file size: 14408802 04:43:37 INFO - Obtained file size: 14408802 04:43: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')]} 04:43:37 INFO - trying https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:43:37 INFO - Downloading https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:43:40 INFO - Downloaded 71520739 bytes. 04:43:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:43:40 INFO - mkdir: /builds/slave/test/properties 04:43:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:43:40 INFO - Writing to file /builds/slave/test/properties/build_url 04:43:40 INFO - Contents: 04:43:40 INFO - build_url:https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:43:40 INFO - Running post-action listener: _resource_record_post_action 04:43:40 INFO - Running post-action listener: set_extra_try_arguments 04:43:40 INFO - [mozharness: 2017-04-16 11:43:40.849817Z] Finished download-and-extract step (success) 04:43:40 INFO - [mozharness: 2017-04-16 11:43:40.849961Z] Running populate-webroot step. 04:43:40 INFO - Running pre-action listener: _resource_record_pre_action 04:43:40 INFO - Running main action method: populate_webroot 04:43:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:43:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:43:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:43:40 INFO - '--tppagecycles', 04:43:40 INFO - '7'], 04:43:40 INFO - 'tests': ['tsvgm']}}, 04:43:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:43:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:43:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:43:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:43:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:43:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:43:40 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:43:40 INFO - 'talos_options': ['--disable-e10s'], 04:43:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:43:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:43:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:43:40 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:43:40 INFO - 'talos_options': ['--disable-e10s'], 04:43:40 INFO - 'tests': ['damp', 'tps']}, 04:43:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:43:40 INFO - 'tests': ['damp', 'tps']}, 04:43:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:43:40 INFO - 'tests': ['dromaeo_dom']}, 04:43:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:43:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:43:40 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:43:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:43:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:43:40 INFO - 'tests': ['a11yr', 04:43:40 INFO - 'ts_paint', 04:43:40 INFO - 'tpaint', 04:43:40 INFO - 'sessionrestore', 04:43:40 INFO - 'sessionrestore_no_auto_restore', 04:43:40 INFO - 'tabpaint']}, 04:43:40 INFO - 'other-e10s': {'tests': ['a11yr', 04:43:40 INFO - 'ts_paint', 04:43:40 INFO - 'tpaint', 04:43:40 INFO - 'sessionrestore', 04:43:40 INFO - 'sessionrestore_no_auto_restore', 04:43:40 INFO - 'tabpaint']}, 04:43:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:43:40 INFO - 'ts_paint', 04:43:40 INFO - 'tpaint', 04:43:40 INFO - 'sessionrestore', 04:43:40 INFO - 'sessionrestore_no_auto_restore', 04:43:40 INFO - 'tabpaint']}, 04:43:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:43:40 INFO - 'ts_paint', 04:43:40 INFO - 'tpaint', 04:43:40 INFO - 'sessionrestore', 04:43:40 INFO - 'sessionrestore_no_auto_restore', 04:43:40 INFO - 'tabpaint']}, 04:43:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:43:40 INFO - 'tests': ['a11yr', 04:43:40 INFO - 'ts_paint', 04:43:40 INFO - 'tpaint', 04:43:40 INFO - 'sessionrestore', 04:43:40 INFO - 'sessionrestore_no_auto_restore', 04:43:40 INFO - 'tabpaint']}, 04:43:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:43:40 INFO - 'tests': ['a11yr', 04:43:40 INFO - 'ts_paint', 04:43:40 INFO - 'tpaint', 04:43:40 INFO - 'sessionrestore', 04:43:40 INFO - 'sessionrestore_no_auto_restore', 04:43:40 INFO - 'tabpaint']}, 04:43:40 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:43:40 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:43:40 INFO - 'bloom_basic_ref']}, 04:43:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:43:40 INFO - 'tests': ['tsvgx', 04:43:40 INFO - 'tsvgr_opacity', 04:43:40 INFO - 'tart', 04:43:40 INFO - 'tscrollx', 04:43:40 INFO - 'cart', 04:43:40 INFO - 'tsvg_static']}, 04:43:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:43:40 INFO - 'tsvgr_opacity', 04:43:40 INFO - 'tart', 04:43:40 INFO - 'tscrollx', 04:43:40 INFO - 'cart', 04:43:40 INFO - 'tsvg_static']}, 04:43:40 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:43:40 INFO - 'talos_options': ['--disable-e10s'], 04:43:40 INFO - 'tests': ['tp5o']}, 04:43:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:43:40 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:43:40 INFO - 'talos_options': ['--disable-e10s', 04:43:40 INFO - '--xperf_path', 04:43:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:43:40 INFO - 'tests': ['tp5n']}, 04:43:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:43:40 INFO - 'talos_options': ['--xperf_path', 04:43:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:43:40 INFO - 'tests': ['tp5n']}}, 04:43:40 INFO - 'talos.zip': {'path': '', 04:43:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:43:40 INFO - Running post-action listener: _resource_record_post_action 04:43:40 INFO - [mozharness: 2017-04-16 11:43:40.869106Z] Finished populate-webroot step (success) 04:43:40 INFO - [mozharness: 2017-04-16 11:43:40.869243Z] Running create-virtualenv step. 04:43:40 INFO - Running pre-action listener: _resource_record_pre_action 04:43:40 INFO - Running main action method: create_virtualenv 04:43:40 INFO - Creating virtualenv /builds/slave/test/build/venv 04:43:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:43:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:43:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:43:40 INFO - Using real prefix '/tools/python27' 04:43:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:43:41 INFO - Installing distribute.............................................................................................................................................................................................done. 04:43:44 INFO - Installing pip.................done. 04:43:44 INFO - Return code: 0 04:43:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:43:44 INFO - Reading from file tmpfile_stdout 04:43:44 INFO - Output received: 04:43:44 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:43:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0314a4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6bdd30>, '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 0x10f5e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2be8>, '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.glgzxr1qIL/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.ifsKwhdxrV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:43:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.glgzxr1qIL/Render', 04:43:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:45 INFO - 'HOME': '/Users/cltbld', 04:43:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:45 INFO - 'LOGNAME': 'cltbld', 04:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:45 INFO - 'MOZ_NO_REMOTE': '1', 04:43:45 INFO - 'NO_EM_RESTART': '1', 04:43:45 INFO - 'PAGER': '/bin/cat', 04:43:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:45 INFO - 'PWD': '/builds/slave/test', 04:43:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:45 INFO - 'SHELL': '/bin/bash', 04:43:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifsKwhdxrV/Listeners', 04:43:45 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:43:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:45 INFO - 'USER': 'cltbld', 04:43:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:45 INFO - 'XPC_FLAGS': '0x0', 04:43:45 INFO - 'XPC_SERVICE_NAME': '0', 04:43:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:43:45 INFO - Cleaning up... 04:43:45 INFO - Return code: 0 04:43:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f8dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0314a4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6bdd30>, '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 0x10f5e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2be8>, '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.glgzxr1qIL/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.ifsKwhdxrV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:43:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.glgzxr1qIL/Render', 04:43:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:45 INFO - 'HOME': '/Users/cltbld', 04:43:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:45 INFO - 'LOGNAME': 'cltbld', 04:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:45 INFO - 'MOZ_NO_REMOTE': '1', 04:43:45 INFO - 'NO_EM_RESTART': '1', 04:43:45 INFO - 'PAGER': '/bin/cat', 04:43:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:45 INFO - 'PWD': '/builds/slave/test', 04:43:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:45 INFO - 'SHELL': '/bin/bash', 04:43:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifsKwhdxrV/Listeners', 04:43:45 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:43:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:45 INFO - 'USER': 'cltbld', 04:43:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:45 INFO - 'XPC_FLAGS': '0x0', 04:43:45 INFO - 'XPC_SERVICE_NAME': '0', 04:43:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:46 INFO - Downloading/unpacking psutil>=3.1.1 04:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:43:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:51 INFO - Installing collected packages: psutil 04:43:51 INFO - Running setup.py install for psutil 04:43:51 INFO - building 'psutil._psutil_osx' extension 04:43:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:43:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:43:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:43:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:43:52 INFO - building 'psutil._psutil_posix' extension 04:43:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:43:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:43:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:43:52 INFO - ^ 04:43:52 INFO - 1 warning generated. 04:43:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:43:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:52 INFO - Successfully installed psutil 04:43:52 INFO - Cleaning up... 04:43:52 INFO - Return code: 0 04:43:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:43: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')]} 04:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43: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')]} 04:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0314a4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6bdd30>, '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 0x10f5e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2be8>, '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.glgzxr1qIL/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.ifsKwhdxrV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:43:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.glgzxr1qIL/Render', 04:43:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:52 INFO - 'HOME': '/Users/cltbld', 04:43:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:52 INFO - 'LOGNAME': 'cltbld', 04:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:52 INFO - 'MOZ_NO_REMOTE': '1', 04:43:52 INFO - 'NO_EM_RESTART': '1', 04:43:52 INFO - 'PAGER': '/bin/cat', 04:43:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:52 INFO - 'PWD': '/builds/slave/test', 04:43:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:52 INFO - 'SHELL': '/bin/bash', 04:43:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifsKwhdxrV/Listeners', 04:43:52 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:43:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:52 INFO - 'USER': 'cltbld', 04:43:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:52 INFO - 'XPC_FLAGS': '0x0', 04:43:52 INFO - 'XPC_SERVICE_NAME': '0', 04:43:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:43:56 INFO - Installing collected packages: mozsystemmonitor 04:43:56 INFO - Running setup.py install for mozsystemmonitor 04:43:56 INFO - Successfully installed mozsystemmonitor 04:43:56 INFO - Cleaning up... 04:43:56 INFO - Return code: 0 04:43:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:43: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')]} 04:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43: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')]} 04:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:56 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 0x10f8dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0314a4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6bdd30>, '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 0x10f5e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2be8>, '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.glgzxr1qIL/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.ifsKwhdxrV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:43:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.glgzxr1qIL/Render', 04:43:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:56 INFO - 'HOME': '/Users/cltbld', 04:43:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:56 INFO - 'LOGNAME': 'cltbld', 04:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:56 INFO - 'MOZ_NO_REMOTE': '1', 04:43:56 INFO - 'NO_EM_RESTART': '1', 04:43:56 INFO - 'PAGER': '/bin/cat', 04:43:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:56 INFO - 'PWD': '/builds/slave/test', 04:43:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:56 INFO - 'SHELL': '/bin/bash', 04:43:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifsKwhdxrV/Listeners', 04:43:56 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:43:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:56 INFO - 'USER': 'cltbld', 04:43:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:56 INFO - 'XPC_FLAGS': '0x0', 04:43:56 INFO - 'XPC_SERVICE_NAME': '0', 04:43:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:56 INFO - Downloading/unpacking jsonschema==2.5.1 04:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:43:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:59 INFO - Downloading functools32-3.2.3-2.tar.gz 04:43:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:43:59 INFO - warning: no files found matching '*.txt' 04:43:59 INFO - no previously-included directories found matching 'build' 04:43:59 INFO - no previously-included directories found matching 'dist' 04:43:59 INFO - no previously-included directories found matching '.git*' 04:43:59 INFO - Installing collected packages: jsonschema, functools32 04:43:59 INFO - Running setup.py install for functools32 04:44:00 INFO - warning: no files found matching '*.txt' 04:44:00 INFO - no previously-included directories found matching 'build' 04:44:00 INFO - no previously-included directories found matching 'dist' 04:44:00 INFO - no previously-included directories found matching '.git*' 04:44:00 INFO - Successfully installed jsonschema functools32 04:44:00 INFO - Cleaning up... 04:44:00 INFO - Return code: 0 04:44:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:00 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 0x10f8dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0314a4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6bdd30>, '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 0x10f5e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2be8>, '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.glgzxr1qIL/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.ifsKwhdxrV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:44:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:44:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.glgzxr1qIL/Render', 04:44:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:00 INFO - 'HOME': '/Users/cltbld', 04:44:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:00 INFO - 'LOGNAME': 'cltbld', 04:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:00 INFO - 'MOZ_NO_REMOTE': '1', 04:44:00 INFO - 'NO_EM_RESTART': '1', 04:44:00 INFO - 'PAGER': '/bin/cat', 04:44:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:00 INFO - 'PWD': '/builds/slave/test', 04:44:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:00 INFO - 'SHELL': '/bin/bash', 04:44:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifsKwhdxrV/Listeners', 04:44:00 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:44:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:00 INFO - 'USER': 'cltbld', 04:44:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:00 INFO - 'XPC_FLAGS': '0x0', 04:44:00 INFO - 'XPC_SERVICE_NAME': '0', 04:44:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:44:00 INFO - Cleaning up... 04:44:00 INFO - Return code: 0 04:44:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:00 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 0x10f8dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0314a4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6bdd30>, '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 0x10f5e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2be8>, '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.glgzxr1qIL/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.ifsKwhdxrV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:44:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:44:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.glgzxr1qIL/Render', 04:44:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:00 INFO - 'HOME': '/Users/cltbld', 04:44:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:00 INFO - 'LOGNAME': 'cltbld', 04:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:00 INFO - 'MOZ_NO_REMOTE': '1', 04:44:00 INFO - 'NO_EM_RESTART': '1', 04:44:00 INFO - 'PAGER': '/bin/cat', 04:44:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:00 INFO - 'PWD': '/builds/slave/test', 04:44:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:00 INFO - 'SHELL': '/bin/bash', 04:44:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifsKwhdxrV/Listeners', 04:44:00 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:44:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:00 INFO - 'USER': 'cltbld', 04:44:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:00 INFO - 'XPC_FLAGS': '0x0', 04:44:00 INFO - 'XPC_SERVICE_NAME': '0', 04:44:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:00 INFO - Downloading/unpacking blobuploader==1.2.4 04:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:05 INFO - Downloading blobuploader-1.2.4.tar.gz 04:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:44:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:44:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:07 INFO - Downloading docopt-0.6.1.tar.gz 04:44:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:44:07 INFO - Installing collected packages: blobuploader, requests, docopt 04:44:07 INFO - Running setup.py install for blobuploader 04:44:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:44:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:44:07 INFO - Running setup.py install for requests 04:44:07 INFO - Running setup.py install for docopt 04:44:07 INFO - Successfully installed blobuploader requests docopt 04:44:07 INFO - Cleaning up... 04:44:08 INFO - Return code: 0 04:44:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:08 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 0x10f8dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0314a4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6bdd30>, '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 0x10f5e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2be8>, '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.glgzxr1qIL/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.ifsKwhdxrV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:44:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.glgzxr1qIL/Render', 04:44:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:08 INFO - 'HOME': '/Users/cltbld', 04:44:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:08 INFO - 'LOGNAME': 'cltbld', 04:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:08 INFO - 'MOZ_NO_REMOTE': '1', 04:44:08 INFO - 'NO_EM_RESTART': '1', 04:44:08 INFO - 'PAGER': '/bin/cat', 04:44:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:08 INFO - 'PWD': '/builds/slave/test', 04:44:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:08 INFO - 'SHELL': '/bin/bash', 04:44:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifsKwhdxrV/Listeners', 04:44:08 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:44:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:08 INFO - 'USER': 'cltbld', 04:44:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:08 INFO - 'XPC_FLAGS': '0x0', 04:44:08 INFO - 'XPC_SERVICE_NAME': '0', 04:44:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:08 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-KvlzQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:08 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-eI9UU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:08 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-HUszSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:08 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-ypMiRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:08 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-5SF0vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:08 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-HIhObX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:08 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-BimdOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:09 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-venuul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:09 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-Sv92lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:09 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-_baXbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:09 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-yArWHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:09 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-3pmipW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:09 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-OmGvm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:09 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-rhIjIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:09 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-W6LWLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:09 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-tKR0Yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:09 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-Qh3422-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:44:10 INFO - Running setup.py install for manifestparser 04:44:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:44:10 INFO - Running setup.py install for mozcrash 04:44:10 INFO - Running setup.py install for mozdebug 04:44:10 INFO - Running setup.py install for mozdevice 04:44:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:44:10 INFO - Running setup.py install for mozfile 04:44:10 INFO - Running setup.py install for mozhttpd 04:44:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:44:10 INFO - Running setup.py install for mozinfo 04:44:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:44:11 INFO - Running setup.py install for mozInstall 04:44:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:44:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:44:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:44:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:44:11 INFO - Running setup.py install for mozleak 04:44:11 INFO - Running setup.py install for mozlog 04:44:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:44:11 INFO - Running setup.py install for moznetwork 04:44:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:44:11 INFO - Running setup.py install for mozprocess 04:44:11 INFO - Running setup.py install for mozprofile 04:44:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:44:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:44:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:44:11 INFO - Running setup.py install for mozrunner 04:44:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:44:12 INFO - Running setup.py install for mozscreenshot 04:44:12 INFO - Running setup.py install for moztest 04:44:12 INFO - Running setup.py install for mozversion 04:44:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:44:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:44:12 INFO - Cleaning up... 04:44:12 INFO - Return code: 0 04:44:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:12 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 0x10f8dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0314a4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6bdd30>, '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 0x10f5e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2be8>, '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.glgzxr1qIL/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.ifsKwhdxrV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.glgzxr1qIL/Render', 04:44:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:12 INFO - 'HOME': '/Users/cltbld', 04:44:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:12 INFO - 'LOGNAME': 'cltbld', 04:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:12 INFO - 'MOZ_NO_REMOTE': '1', 04:44:12 INFO - 'NO_EM_RESTART': '1', 04:44:12 INFO - 'PAGER': '/bin/cat', 04:44:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:12 INFO - 'PWD': '/builds/slave/test', 04:44:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:12 INFO - 'SHELL': '/bin/bash', 04:44:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifsKwhdxrV/Listeners', 04:44:12 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:44:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:12 INFO - 'USER': 'cltbld', 04:44:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:12 INFO - 'XPC_FLAGS': '0x0', 04:44:12 INFO - 'XPC_SERVICE_NAME': '0', 04:44:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:12 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-5NFa8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:12 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-gMQQ09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:13 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-9T5Gss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:13 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-r3bBFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:13 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-qSG0Ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:13 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-xmn0h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:13 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-BbrbE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:13 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-dBLC1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:13 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-0g0guO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:13 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-FWIMst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:13 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-Spwihl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:14 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-Ozyaea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:14 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-vuJRaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:14 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-D61Jpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:14 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-xCQOMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:14 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-nDwW1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:14 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-TKgvym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:19 INFO - Downloading blessings-1.6.tar.gz 04:44:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:44:19 INFO - Installing collected packages: blessings 04:44:19 INFO - Running setup.py install for blessings 04:44:19 INFO - Successfully installed blessings 04:44:19 INFO - Cleaning up... 04:44:19 INFO - Return code: 0 04:44:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:44:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:19 INFO - Reading from file tmpfile_stdout 04:44:19 INFO - Current package versions: 04:44:19 INFO - blessings == 1.6 04:44:19 INFO - blobuploader == 1.2.4 04:44:19 INFO - docopt == 0.6.1 04:44:19 INFO - functools32 == 3.2.3-2 04:44:19 INFO - jsonschema == 2.5.1 04:44:19 INFO - manifestparser == 1.1 04:44:19 INFO - mozInstall == 1.12 04:44:19 INFO - mozcrash == 1.0 04:44:19 INFO - mozdebug == 0.1 04:44:19 INFO - mozdevice == 0.50 04:44:19 INFO - mozfile == 1.2 04:44:19 INFO - mozhttpd == 0.7 04:44:19 INFO - mozinfo == 0.9 04:44:19 INFO - mozleak == 0.1 04:44:19 INFO - mozlog == 3.4 04:44:19 INFO - moznetwork == 0.27 04:44:19 INFO - mozprocess == 0.25 04:44:19 INFO - mozprofile == 0.28 04:44:19 INFO - mozrunner == 6.13 04:44:19 INFO - mozscreenshot == 0.1 04:44:19 INFO - mozsystemmonitor == 0.3 04:44:19 INFO - moztest == 0.8 04:44:19 INFO - mozversion == 1.4 04:44:19 INFO - psutil == 3.1.1 04:44:19 INFO - requests == 1.2.3 04:44:19 INFO - wsgiref == 0.1.2 04:44:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:19 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 0x10f8dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0314a4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6bdd30>, '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 0x10f5e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2be8>, '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.glgzxr1qIL/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.ifsKwhdxrV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:44:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.glgzxr1qIL/Render', 04:44:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:19 INFO - 'HOME': '/Users/cltbld', 04:44:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:19 INFO - 'LOGNAME': 'cltbld', 04:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:19 INFO - 'MOZ_NO_REMOTE': '1', 04:44:19 INFO - 'NO_EM_RESTART': '1', 04:44:19 INFO - 'PAGER': '/bin/cat', 04:44:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:19 INFO - 'PWD': '/builds/slave/test', 04:44:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:19 INFO - 'SHELL': '/bin/bash', 04:44:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifsKwhdxrV/Listeners', 04:44:19 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:44:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:19 INFO - 'USER': 'cltbld', 04:44:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:19 INFO - 'XPC_FLAGS': '0x0', 04:44:19 INFO - 'XPC_SERVICE_NAME': '0', 04:44:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:44:20 INFO - Cleaning up... 04:44:20 INFO - Return code: 0 04:44:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:20 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 0x10f8dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0314a4360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6bdd30>, '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 0x10f5e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2be8>, '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.glgzxr1qIL/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.ifsKwhdxrV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:44:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:44:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.glgzxr1qIL/Render', 04:44:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:20 INFO - 'HOME': '/Users/cltbld', 04:44:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:20 INFO - 'LOGNAME': 'cltbld', 04:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:20 INFO - 'MOZ_NO_REMOTE': '1', 04:44:20 INFO - 'NO_EM_RESTART': '1', 04:44:20 INFO - 'PAGER': '/bin/cat', 04:44:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:20 INFO - 'PWD': '/builds/slave/test', 04:44:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:20 INFO - 'SHELL': '/bin/bash', 04:44:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifsKwhdxrV/Listeners', 04:44:20 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:44:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:20 INFO - 'USER': 'cltbld', 04:44:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:20 INFO - 'XPC_FLAGS': '0x0', 04:44:20 INFO - 'XPC_SERVICE_NAME': '0', 04:44:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:44:20 INFO - Cleaning up... 04:44:20 INFO - Return code: 0 04:44:20 INFO - Running post-action listener: _resource_record_post_action 04:44:20 INFO - Running post-action listener: _start_resource_monitoring 04:44:20 INFO - Starting resource monitoring. 04:44:20 INFO - [mozharness: 2017-04-16 11:44:20.322823Z] Finished create-virtualenv step (success) 04:44:20 INFO - [mozharness: 2017-04-16 11:44:20.323736Z] Running install step. 04:44:20 INFO - Running pre-action listener: _resource_record_pre_action 04:44:20 INFO - Running main action method: install 04:44:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:20 INFO - Reading from file tmpfile_stdout 04:44:20 INFO - Detecting whether we're running mozinstall >=1.0... 04:44:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:44:20 INFO - Reading from file tmpfile_stdout 04:44:20 INFO - Output received: 04:44:20 INFO - Usage: mozinstall [options] installer 04:44:20 INFO - Options: 04:44:20 INFO - -h, --help show this help message and exit 04:44:20 INFO - -d DEST, --destination=DEST 04:44:20 INFO - Directory to install application into. [default: 04:44:20 INFO - "/builds/slave/test"] 04:44:20 INFO - --app=APP Application being installed. [default: firefox] 04:44:20 INFO - mkdir: /builds/slave/test/build/application 04:44:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:44:40 INFO - Reading from file tmpfile_stdout 04:44:40 INFO - Output received: 04:44:40 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:44:40 INFO - Running post-action listener: _resource_record_post_action 04:44:40 INFO - [mozharness: 2017-04-16 11:44:40.161097Z] Finished install step (success) 04:44:40 INFO - [mozharness: 2017-04-16 11:44:40.161254Z] Running run-tests step. 04:44:40 INFO - Running pre-action listener: _resource_record_pre_action 04:44:40 INFO - Running main action method: run_tests 04:44:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:44:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:44:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:44:40 INFO - 2017-04-16 04:44:40.175 screenresolution[1660:15138] starting screenresolution argv=screenresolution get 04:44:40 INFO - 2017-04-16 04:44:40.178 screenresolution[1660:15138] Display 0: 1600x1200x32@60 04:44:40 INFO - 2017-04-16 04:44:40.184 screenresolution[1661:15141] starting screenresolution argv=screenresolution list 04:44:40 INFO - Available Modes on Display 0 04:44:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:44:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:44:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:44:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:44:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:44:40 INFO - Intel Iris: 04:44:40 INFO - Chipset Model: Intel Iris 04:44:40 INFO - Type: GPU 04:44:40 INFO - Bus: Built-In 04:44:40 INFO - VRAM (Dynamic, Max): 1536 MB 04:44:40 INFO - Vendor: Intel (0x8086) 04:44:40 INFO - Device ID: 0x0a2e 04:44:40 INFO - Revision ID: 0x0009 04:44:40 INFO - Displays: 04:44:40 INFO - Display: 04:44:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:44:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:44:40 INFO - Display Serial Number: 1600x1200 60 04:44:40 INFO - Main Display: Yes 04:44:40 INFO - Mirror: Off 04:44:40 INFO - Online: Yes 04:44:40 INFO - Rotation: Supported 04:44:40 INFO - Return code: 0 04:44:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:44:40 INFO - Python 2.7.3 04:44:40 INFO - Return code: 0 04:44:40 INFO - grabbing minidump binary from tooltool 04:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:40 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 0x10f6bdd30>, '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 0x10f5e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:44:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:44:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:44:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:44:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:44:40 INFO - Return code: 0 04:44:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:44:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:44:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:44:40 INFO - ENV: RUST_BACKTRACE is now 1 04:44:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:44:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:44:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0250', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0250 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:44:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.glgzxr1qIL/Render', 04:44:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:40 INFO - 'HOME': '/Users/cltbld', 04:44:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:40 INFO - 'LOGNAME': 'cltbld', 04:44:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:44:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:40 INFO - 'MOZ_NO_REMOTE': '1', 04:44:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:44:40 INFO - 'NO_EM_RESTART': '1', 04:44:40 INFO - 'PAGER': '/bin/cat', 04:44:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:40 INFO - 'PWD': '/builds/slave/test', 04:44:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:44:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:40 INFO - 'RUST_BACKTRACE': '1', 04:44:40 INFO - 'SHELL': '/bin/bash', 04:44:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifsKwhdxrV/Listeners', 04:44:40 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:44:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:40 INFO - 'USER': 'cltbld', 04:44:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:40 INFO - 'XPC_FLAGS': '0x0', 04:44:40 INFO - 'XPC_SERVICE_NAME': '0', 04:44:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0250', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:44:40 INFO - mozversion application_buildid: 20170416030209 04:44:40 INFO - mozversion application_changeset: ce69b6e1773e9e0d0a190ce899f34b1658e66ca4 04:44:40 INFO - mozversion application_display_name: Nightly 04:44:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:44:40 INFO - mozversion application_name: Firefox 04:44:40 INFO - mozversion application_remotingname: firefox 04:44:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:44:40 INFO - mozversion application_vendor: Mozilla 04:44:40 INFO - mozversion application_version: 55.0a1 04:44:40 INFO - mozversion platform_buildid: 20170416030209 04:44:40 INFO - mozversion platform_changeset: ce69b6e1773e9e0d0a190ce899f34b1658e66ca4 04:44:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:44:40 INFO - mozversion platform_version: 55.0a1 04:44:40 INFO - using testdate: 1492343080 04:44:40 INFO - actual date: 1492343080 04:44:40 INFO - starting webserver on 'localhost:49241' 04:44:40 INFO - SUITE-START | Running 2 tests 04:44:40 INFO - TEST-START | dromaeo_css 04:44:40 INFO - operating with platform_type : mac_ 04:44:40 INFO - Initialising browser for dromaeo_css test... 04:44:40 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpZL1eHi/profile http://localhost:49241/getInfo.html) 04:44:43 INFO - PID 1671 | 2017-04-16 04:44:43.924 plugin-container[1674:15328] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x934f, name = 'com.apple.tsm.portname' 04:44:43 INFO - PID 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:44:43 INFO - PID 1671 | 2017-04-16 04:44:43.924 plugin-container[1674:15328] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 04:44:43 INFO - PID 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:44:43 INFO - PID 1671 | 2017-04-16 04:44:43.924 plugin-container[1674:15328] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:44:44 INFO - PID 1671 | __metrics Screen width/height:1600/1200 04:44:44 INFO - PID 1671 | colorDepth:24 04:44:44 INFO - PID 1671 | Browser inner width/height: 1024/689 04:44:44 INFO - PID 1671 | __metrics 04:44:44 ERROR - PID 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 04:44:45 INFO - TEST-INFO | 1671: exit 0 04:44:45 INFO - Browser initialized. 04:44:45 INFO - Running cycle 1/1 for dromaeo_css test... 04:44:45 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpZL1eHi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:47 INFO - PID 1676 | 2017-04-16 04:44:47.875 plugin-container[1677:15480] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 04:44:47 INFO - PID 1676 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:44:47 INFO - PID 1676 | 2017-04-16 04:44:47.875 plugin-container[1677:15480] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 04:44:47 INFO - PID 1676 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:44:47 INFO - PID 1676 | 2017-04-16 04:44:47.876 plugin-container[1677:15480] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:44:57 INFO - PID 1676 | RSS: Main: 237092864 04:44:57 INFO - PID 1676 | 04:48:01 INFO - PID 1676 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 04:48:03 INFO - PID 1676 | RSS: Main: 252067840 04:48:03 INFO - PID 1676 | 04:49:45 INFO - PID 1676 | ************************* 04:49:45 INFO - PID 1676 | A coding exception was thrown and uncaught in a Task. 04:49:45 INFO - PID 1676 | 04:49:45 ERROR - PID 1676 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:49:45 INFO - PID 1676 | Full stack: 04:49:45 INFO - PID 1676 | ************************* 04:49:45 INFO - PID 1676 | ************************* 04:49:45 INFO - PID 1676 | A coding exception was thrown and uncaught in a Task. 04:49:45 INFO - PID 1676 | 04:49:45 ERROR - PID 1676 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:49:45 INFO - PID 1676 | Full stack: 04:49:45 INFO - PID 1676 | ************************* 04:49:45 INFO - PID 1676 | ************************* 04:49:45 INFO - PID 1676 | A coding exception was thrown and uncaught in a Task. 04:49:45 INFO - PID 1676 | 04:49:45 ERROR - PID 1676 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:49:45 INFO - PID 1676 | Full stack: 04:49:45 INFO - PID 1676 | ************************* 04:49:45 INFO - PID 1676 | ************************* 04:49:45 INFO - PID 1676 | A coding exception was thrown and uncaught in a Task. 04:49:45 INFO - PID 1676 | 04:49:45 ERROR - PID 1676 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:49:45 INFO - PID 1676 | Full stack: 04:49:45 INFO - PID 1676 | ************************* 04:51:04 INFO - PID 1676 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 04:51:05 INFO - PID 1676 | RSS: Main: 257474560 04:51:05 INFO - PID 1676 | 04:54:07 INFO - PID 1676 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 04:54:07 INFO - PID 1676 | RSS: Main: 268103680 04:54:07 INFO - PID 1676 | 04:57:09 INFO - PID 1676 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 04:57:10 INFO - PID 1676 | RSS: Main: 260677632 04:57:10 INFO - PID 1676 | 05:00:13 INFO - PID 1676 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 05:00:13 INFO - PID 1676 | RSS: Main: 269983744 05:00:13 INFO - PID 1676 | 05:03:15 INFO - PID 1676 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:03:15 INFO - PID 1676 | RSS: Main: 265302016 05:03:15 INFO - PID 1676 | 05:03:15 INFO - PID 1676 | __start_tp_report 05:03:15 INFO - PID 1676 | _x_x_mozilla_page_load 05:03:15 INFO - PID 1676 | _x_x_mozilla_page_load_details 05:03:15 INFO - PID 1676 | |i|pagename|runs| 05:03:15 INFO - PID 1676 | |0;dojo.html;3555.466679998001;3556.110972256937;3589.1565482111714;3598.6581274778887;3632.164602141507;4847.587955023822;5300.973495132519;6273.749050037999;6354.396332348431;6390.360963903608;6124.8386823524725;6216.875662486747;6253.499720022399;6303.873922521547;6318;5454.618176727621;5508;5560.9712203242325;5603.775848966056;5642.15367694847;4664.97667511662;5406.513413792758;5516.7517461714315;5599.804006859761;5689.4879460848515;5432.592555558309;5553.16702494629;5589.832305030855;5632.239647647577;5663.546916246711;5459;5512.145617429305;5520.613557051008;5554.833354999316;5577.051901176769;5435.456454354572;5439.918401223985;5460.426655201226;5463.590230732711;5471.398146203915;5151.484851514856;6145.139680444697;6225.439710426038;6238;6251.156093927307;6665.93334066658;6750.966245168792;6784.0841486399695;6794.116764820591;6847;6874.725010999554;6885.173779146485;6905.654717264167;6906.205786334585;6930.5148639595245;5744.684042377709;5960.0761881908375;6045.818625441288;6371.076193951943;6371.2991570927625;6814.386705196556;6891.207511136183;6916.930830691628;7020.648967551602;7043.119610048744;6365.777197798055;6442.420182183626;6628.204615446178;6645.568038077509;6704.631245281459;6098.451139397387;6122.326544080148;6634.635095069721;6844.691988860413;6905.240423553405;6786.423154031962;6799.082123913307;6801.693923773442;6808.795736127924;6809.7276108956075;6529.216494020653;6626.834329141713;6724.562903411361;6775.457963363017;6804.863902722017;5342.412334643186;5413.269208656781;5419.458054194549;5427.3215848019;5447.455254474521;4774.30772537987;4788.233882578771;4803.471618122004;4808.519148085234;4818.108649899709;5054.7472626368535;6200;6278.811635650938;6281.309056003836;6295.213098362705;6801.251862295144;6893.931060689329;6894.13823272091;6899.827504312432;6927.965360173167;6267.905981410283;6283.842903927347;6318.8420289492215;6333.461655759312;6357.618542887349;5810.128480727924;6057.242844644419;6083.361247069082;6085.208922840003;6085.908711369333;6803.727850886008;6963.61700106499;7021;7042.647867606702;7047.083879095685;6894.482913781587;6896.172459304916;6897.41371983387;6934.063901373452;6947.3747362737595;6848.280930502226;7015.263397343206;7033.050538177281;7041.155061392666;7061.1173603299585;6521.087047813215;6582.670866456754;6676.83307917306;6715.7985260442265;6740.797776066725;5766.509846663081;6892.655367231719;6926.896096558455;6930.584164950119;6937.826554336182;6376.52176086786;6442.935570644234;6575.013747937847;6669.866602668017;6685.899711504234;6562.409383155539;6653.434458071119;6686.1642294713165;6688.665566721547;6705.2959439258175;6427.035944608159;6434.903476447951;6540.084388185753;6546.83632909162;6582.407583317525;6351.68241587928;6678.23200331968;6691.732330706912;6699.9665001674675;6716.126903502513;6334.113224148531;6358.395952384516;6416.326285740117;6441.774537891151;6480.157579514633 05:03:15 INFO - PID 1676 | |1;ext.html;734.9416839750759;812.4272387966482;836.8117173635933;1302.316283950925;1315.6447759105035;37432.625673743256;38504.614953850454;38526.22947541047;38552.614473855254;38611.61388386119;38513;38840.22319553607;38843.805780971124;38855.805720971424;38891.805540972324;8003.679852805895;8180.550069746161;8490.320774338039;8724.912750872474;8757.25563327118;7376.631168441583;8718.17177368149;8784.472931624092;8788.428752131123;8845.20393164615;8746.650133994632;8781.03408625054;8789.198214366039;8795.868061979076;8804.735857924241;8708.21626053652;8779.122087791233;8786.824263514758;8810;8827.646894124227;8566.742997710078;8618;8619.870701939475;8642.524661143634;8652.480851148952;38349.424758628644;38372.61627383746;38372.80813595942;38404;38520.42219366712;3660.194757153422;3672.081979505124;3715.2198038411966;3723.236736469017;3723.6276372362818;31224.531632025537;31343.686563134306;31430.528542071886;31473.37053258922;31499.212519687193;3159.0522843147196;3174.68253174683;3186.107889790839;3190.266238765074;3196.9360612787614;258527;259332;283760.58119709475;289439.55280223675;289580;48572.271415928786;48606.51393486091;48627.5137248623;48652.5134748648;48693.756531217114;50311.74844125756;50615.746921265156;53682.73158634182;54671;56229.7188514063;14662.926685366505;14863.628409289639;14894.627634309229;14956.626084347978;14962.925185374004;11918.04655627565;11983;11993.280403175837;12001.519939202333;12091.697707557205;11447.828282575769;14095.436182552583;14128.646783830281;14255.429782808571;14344.139351638934;5659.575531835047;5989.712211874468;6255.593386429868;6313.905291420632;6352.745890164434;800.6317094136763;805.4040010392267;807;837.250660658707;849.3587341557085;18754.343597974006;19163.520911977314;20361.694574581394;20818;21986.01062952171;870.3211495033884;882.7748924024332;915.9129882661136;932.5383934952242;945.4185675809327;9262.39794413361;9320.673776417929;9737.367071140354;10709.410982395888;10846.566137354575;320597.3970130181;334088;336497;337125;338747;53888.46111538913;53944.145026947765;54019.72990135024;54055.45944540583;54199.45800542023;1403.249261645015;1500.9399624015136;1528.816542014943;1530.1507663246782;1544.0195475872677;20574.382768516967;20664.07011684508;20666;21069;21210.681839772107;38437;38605.613943861325;38627.80686096552;38734.031649209;38758.80620596879;312224;312585;312844;312883;313130;29232.415351692423;34635.65364346324;35148;35309.823450882584;35349.46975795417;36139;44402.333964989906;44823;44909.775451122536;44962;21997.340079797632;29352;29564.226146431283;29982.4003519924;30780.53829192609;29935.70064299329;30298;30412.84793576018;30479.390412192075;30899;36781.08047298732;36857.07857303589;36862;36900.81549592235;36968.89093327204;26600.8669956649;29302.41395172127;29827.403451931274;30329;31519.21201969969;21638.80986545755;23004.4248893779;24385.14651987172;24395.878020609784;24649.01403943822 05:03:15 INFO - PID 1676 | |2;jquery.html;440.2471773267712;444.428908852125;447.90146167843085;457.3733984441315;466.2423561712218;21396;21577.67633485497;22444.999999999978;23385.649215261743;23505.882470587665;22752.86235688217;23019.42451438715;23133.044427932393;23196.42008949773;23497.177598784045;6128.969355153229;6254.061241015277;6256.468200202966;6265.530085243602;6344.302126766075;6239;6367.6497792621385;6377.617342959414;6379.776707815227;6387.201599800025;5786.913196302059;6004.42957918997;6028.306744724369;6030.246219222598;6052.848678783043;6127.080937859312;6136.23297087864;6139.570230083896;6185.814425567218;6187.628742275456;5478.506934375885;5553.888922221573;5558.471945165203;5563.777448902079;5573.6098473106895;27735.167944961482;27921.86039069812;28488.575571221358;28677.713222867922;28817.991370301937;2163.707899433588;2205.6140175469227;2208.3374987503685;2211.1929145861804;2216.5899308627954;16661.33354665812;17341.39305124327;17474.388396406066;18236.99696516691;18461.538461538436;2149.3874245840016;2204.911803527857;2205.073868975034;2241.6301310283784;2255.154317131076;155242;156642;156654;157855.2107239468;160460;12567;12644.114911956074;12831.807522887164;12910.483580656668;13065.738685226432;13351.73296534064;16390.426335078217;16649.3340266388;16651.084190369646;16867.578310542336;7503.5497870127965;8868.822623547492;9227.907720922705;9230.86153707695;9323.860142097874;7270.7091716331815;8736.588023048447;8743.344249181337;8783.912160878437;8924.973628032729;7656.349210317074;7799.649015794303;7826.295633393022;7828;7845.215478452109;2189.9781002190093;2195.9560808783735;2198.1537108213133;2203.0747086223823;2333.981106343035;781.7693780334702;788.1881661888265;788.6648174525803;791.8930944322443;809.3444310108831;15163;17681.911590441967;17926;17969.371072012418;18251.9048857069;822.3585603229491;833.1709948601181;837.3134030095264;843.8101427178835;847.7707324379675;8605.09946541064;8727.516322225238;9120.315976301805;9159.496227707406;9475.384100033476;537659;568806;570736;584224.0788796028;586650;126853.09720354203;128124;128480.35759821141;129331.35334323456;135882;1151.3897634253858;1152.153167421944;1176.7469993951343;1187.1867770577182;1188.9405529723479;16424.260908259395;16570.420035298706;16579;16632.50102496927;16654.666906661558;57361.426385735605;58458.707706461195;59197;59482.70258648852;59533.702331488064;77460.61269693615;77513.22486775286;77842.6107869457;78331.60834195792;78446.21553784389;8581.871271931052;8603.612837422206;8846.557672116498;8871.955640221757;8930.955345223232;13551.79672304936;13729.588112356645;13750.243736594182;13959.022868399115;14086.15483071019;11701.590444334408;11783.823242651195;11832.053435725293;12017.63947081589;12028.338441385808;10970.177236707439;11104.722381940515;11139.83290250663;11236.83144752813;11260.887391125983;11755.177137600285;12030;12137.878621213675;12166;12245.75508489843;8408.705695300636;8590.957045214735;8613.09562495929;8844.29100121711;8943.284537237136;9411.670591529264;9868.555914983986;11765.352905590275;11973.281603103842;12044.096692748255 05:03:15 INFO - PID 1676 | |3;mootools.html;1272.8472583290004;1468.412634946022;1490.128274959149;1497.3860717105988;1504.2102895979613;9747.22022238221;11342.773144537116;11931.701707457318;12080.335581543022;12263;10590.523426445809;11403.201775875692;11822.581290245183;11854.881451185485;12026.278423294609;2499.525090232859;2525.8231923765343;2526.557852375836;2526.873656317186;2529.2285852814884;2447.412620970963;2484.068474322129;2525.5454018276705;2532.645429639852;2543.9109631162914;2463.790577800889;2508.5735424977797;2518.7355327690602;2524.1670248817845;2527.140772137473;2191.024993877717;2398.7721166489155;2484.291976786625;2498.650188973545;2500.1249562653106;2431.683881095464;2446.388402899275;2450.6446565248116;2462.605983042705;2548.311955771931;11817.586384476588;11956;12064.276143431422;12064.638060858188;12067.094967877445;6536.11762412073;6719.832004199885;6783.3216678332265;6791.252962174157;6800.455963522906;4095.4471146395153;4326.524082350938;4377.212101821671;4395.868123956287;4399.450068741407;1074.6668532754793;1257.7736007518643;1267.026281435505;1273.8980881529549;1275.3623188405797;16122.274497647517;16588.336466541325;16640.50078497647;16729.49811505657;16739.91630041842;5649.378568357477;5717.171010203498;5876.7649294028615;5881.911771323434;5905.350411454737;12254.81617775734;12343.259404435763;12383.885450309515;12401.689957751129;12442.75114497723;6552.803415897531;6605.042268870987;6614.8346291343105;6620.668966551653;6628.138342015507;6043.697815109227;6104.938950610526;6180.412860778219;6237.75048998035;6246.125542424064;4340.978295108504;4403.647708183337;4503.504614492404;4559.658025648089;4560;1315.5132600937714;1338.6519504928594;1339.6583871112805;1349.0152188902157;1353.235421986594;632.583014048528;658.2223018860401;658.9242237142694;658.9933652029581;662.3145044878528;5844.853878653068;5911.615744976562;6004.39956004396;6187.81436556904;6806.965965170142;663.5653646861314;783.6904422752981;802.0936341933577;834.8079941613463;840.6931470013401;3392.6437724039115;3957.1689945111275;4106.67146628269;4308.547602501755;4346.00041990344;14798.334074966653;15133.470328538668;15337.769933451007;15348.23258837076;15367.846321536865;13885.958553108558;14864.628384290263;15085.3211605478;15205.31576079079;15213.6196595086;7507.924920750723;7980.321672657889;8817.603207855662;8830.984436789722;8871.334649901282;5413.323334583177;6442.581232219891;7048.436125110082;7070;7121.145462544528;9942.453165075991;12242.449089790802;12946.09697857931;12994.025448091243;13035.087543871838;13092.410841512345;13122.803157952829;13862.02965792385;13868.959828012737;14010.229437381042;8686.478811271343;8962.596683149144;8968.775780605276;8978.416402933788;9017.188453039258;10773.353598784099;10804.189685773756;10815.56737730482;10840.241183117421;10978;7747.806304842424;8598.699045533376;9236.16874481273;9297.977222505655;9305.627774888928;9035.593398296962;9077.863832042656;9115.498647574446;9177.311701622271;9323.627054917728;8114.797130071795;8231.09457959612;8252.669893204205;8268.214519620626;8269.46248493846;5991.370906054802;5995.46040856325;6082.878342433038;6170.136180934763;6245.843853903689;5320.8935821282585;5605;5838.168488283264;5868.823935281948;5884.617499862496 05:03:15 INFO - PID 1676 | |4;prototype.html;406.81286608160246;407.3502763092869;409.8381139449917;415.7630150814035;420.4429131400893;6085.634861908288;6203.751849926003;6314.463270621997;6330.968345158273;6385.489160867131;5259.500347466985;5925.762969481216;5981.312149102854;6163.243475609453;6176.660283684396;3903.9804800976026;4077.87766367008;4320.503142138663;4493.820247190109;4507.211238033347;3941.3496773032416;4122.8144733486915;4265.381519679645;4495.6628252881;4509.751963641998;3978.820953057105;4341.7177883437635;4484.798184081707;4488.438945131858;4496.280595104784;3329.7835640683397;3674.7795132292013;4350.956490435118;4422.314541246112;4457.509673935864;3835.9232815343817;3839.4432807243074;3845.788481633509;3850.4416859555486;3858.5883822610867;5059.443461219263;5716.771329146829;5972.6715030673295;6024.457798798086;6049.334573196945;5269;5339.679619222859;5376.978374108907;5421.918671219935;5422.945770542323;5484.61607687462;6585.1439312889015;6585.308542603006;6616.834579135512;6625.701843417058;4386.144701783153;4396.868093957187;4415.690901636886;4421.292593185107;4424.225760491933;5819.9418005819825;6709.798706038827;6809.863802723968;6883.181772759089;6998.230194678632;4441.666874984389;4454.866354009385;4473.35136405226;4483.708558943658;4484.8430304939175;4193.496780386373;4547.15877562652;4557.749323787158;4566.337881007302;4580.954190458119;4720.811167553328;4768.833090841873;4781.6891902026255;5311.521963023347;5374.333956473506;6129.570930034944;6266.749330026839;6606.669666516655;6624.536282460278;6642.202935647657;1273.3060482037313;1329.7898911990042;1532.6551525906805;1543.7066957278082;1554.59309325061;964.5225613321311;1023.2990401574945;1026.4457193115784;1033.8317700997825;1042.921780866423;5164;5622.775088996476;5765.261500787176;6245.594036387711;6289.7484100636375;5624;6621.966890165519;6869.519133660596;6872.450203983669;6906.689198985957;5438.265834112344;5947.197128387699;6120.378099803555;6192;6199.876002480015;2941.911742647724;3413.8293085345636;3582.7671201371827;3590.9102272442874;3593.8562457501407;5828.329742079715;6828.9658551706925;6936.098307220029;6989.965050174716;7112.786616401413;6866.141732283465;6884.65576721162;6952.513324067267;6972.267911869282;7021.648917554204;6311.431971122529;6701.698423570951;6952.513324067267;7011.5442496236565;7016.912378581328;5403.162509810985;6794.4904132189295;6850.177978642595;6857.182846545569;6900.896486552806;6433.581817181868;6660.234073081658;6742.595444273359;6748.662566871539;6776.7628133015105;6119.816405507842;6799.456043516408;6815.977603359337;6973.965130174317;7094.871538538315;3932.8820135395986;4459.929616891987;4464.3973063635995;4469.530699276529;4482.75344856036;6620.602763834186;6891.345322194384;6900;6902.8619427612175;6941.75703850383;6650.9667451662435;6652.301508341555;6659.136571274398;6669.6331701754925;6714.455675194635;5815.3603103657715;6354.951433013501;6531.3468653134305;6596.944488881756;6606.174228221473;5412.675239485643;6488.837779055561;6503.439174597967;6514.1531600891585;6541.509386795914;5338.786448542171;6445.742170313135;6620.106285651375;6673.265940746417;6691.832704182434;5805.912911306418;6087.391260873877;6440.67796610177;6444.742210311722;6473.126127972663 05:03:15 INFO - PID 1676 | |5;yui.html;751.2637615137165;842.6797816829604;852.9957350213252;865.0311650950932;873.3668090634291;16394.344226230936;16811.915940420295;16834.663306733873;18050.18774155163;18990;17758.023308718017;18093.638127237446;18174.545636359097;18246.0876956152;18488.907555462236;996.1134590214715;1037.951668814499;1038.2576457832647;1040.7033995311338;1041.9166466682648;1015.1422048369117;1050.4117694091333;1053.7207639975413;1054.1040115901499;1058.7511934695378;1080.5407701726735;1095.1840878545495;1105.3920343810912;1110.0564520157882;1110.9055730262937;1074.12458846041;1094.60047082815;1100.2188446203206;1106.0211712634296;1106.9944650276777;790.5849429049738;807.2936180841764;821.3183058061854;824.9670013199465;825.3314814999869;16261.430849920196;16361.509154725378;16415.17924103802;16441.1779411029;16446.424375146933;17314.307427702875;17473.21370538329;17847.286108555643;17921.283148674036;17978.37075702344;13890.791638125334;14094.154350738989;14101.365438555187;14149.08030977983;14242.359093840698;3504.9474257886154;3563.465480177994;3565.286942611462;3565.607783143852;3568.8572457101945;83565.74651380234;105756;115536;116484.41757791242;116576;13493.865061349261;13510.189388636712;13761.449542018407;13782.310884455937;13785.51750688721;24728.505429891662;25188.496230075296;25817.48365032689;25984.700764962054;25993.610095848577;7930.206979302139;7967.083785364642;7977.321927636216;7988.320992715568;8004.479708818908;3924.6075392460525;3970.741901776433;3997.8800635980965;4001.079751657135;4002.7398219115667;4052.209819085309;4154.459920210354;4166.7708276044505;4172.687048471316;4563.863084107482;958.9808203835884;977.8142152990908;991.9305648604673;994.0556471352244;998.1765043838717;653.183520599251;668.7057694614451;671.3051991189096;676.3608390071433;687.4603436302478;10405.84391234132;11224.775504489864;11706.824397634042;12192.878071219351;12205.877941220475;647.488484097567;653.3825534869598;663.131297999622;663.3416458852868;688.2841844481683;5040.344755181803;5376.704281264568;5388.084025715638;5497.532709719639;5551.916721249185;97706;102557;103895;104117.47941260245;106021;88591;89034.10965890258;89318.55340723385;90056.64915026148;91119.63320550197;74094.25905740981;77371;77477.6126119377;77617.61191194008;78008;9820.950895245764;10442.164626829683;11255.718607034889;11347.035501982424;11451.25566838153;34166;39478.42086316515;41401;41918.37122443227;41964.790176048926;52578;53113.67215819481;53578.732106339216;53680.463195369106;53935.46064539305;13986.44054237819;14123.64690882695;14322.856771432153;14415.639609009859;14489.203093829941;15628.984116032421;15632.218389080273;15658.295376708304;15897.52307430779;15961.840381596036;11959.282443053444;12118.212316199419;14451.27743612794;14599.416023358946;14613.977021608385;14509;14528.055676381424;14661.340239689027;14742.484013059491;14813.25933703289;14303.427862885368;14378.712425751635;14415.044915792028;14470.131792092508;14498.565043048726;9912.008799120318;10580.36517808934;10593.258471906893;10707.143428525855;11076.003159715665;10713.946430267799;12923.806142908052;13966.860331396556;13982.720345592828;14000.229987350385 05:03:15 INFO - PID 1676 | __end_tp_report 05:03:15 INFO - PID 1676 | __start_cc_report 05:03:15 INFO - PID 1676 | _x_x_mozilla_cycle_collect,416 05:03:15 INFO - PID 1676 | __end_cc_report 05:03:15 INFO - PID 1676 | __startTimestamp1492344195627__endTimestamp 05:03:15 INFO - PID 1676 | 05:03:15 INFO - PID 1676 | ------- Summary: start ------- 05:03:15 INFO - PID 1676 | Number of tests: 6 05:03:15 INFO - PID 1676 | 05:03:15 INFO - PID 1676 | [#0] dojo.html Cycles:165 Average:6207.63 Median:6390.36 stddev:764.55 (12.0%) stddev-sans-first:738.04 05:03:15 INFO - PID 1676 | Values: 3555.5 3556.1 3589.2 3598.7 3632.2 4847.6 5301.0 6273.7 6354.4 6390.4 6124.8 6216.9 6253.5 6303.9 6318.0 5454.6 5508.0 5561.0 5603.8 5642.2 4665.0 5406.5 5516.8 5599.8 5689.5 5432.6 5553.2 5589.8 5632.2 5663.5 5459.0 5512.1 5520.6 5554.8 5577.1 5435.5 5439.9 5460.4 5463.6 5471.4 5151.5 6145.1 6225.4 6238.0 6251.2 6665.9 6751.0 6784.1 6794.1 6847.0 6874.7 6885.2 6905.7 6906.2 6930.5 5744.7 5960.1 6045.8 6371.1 6371.3 6814.4 6891.2 6916.9 7020.6 7043.1 6365.8 6442.4 6628.2 6645.6 6704.6 6098.5 6122.3 6634.6 6844.7 6905.2 6786.4 6799.1 6801.7 6808.8 6809.7 6529.2 6626.8 6724.6 6775.5 6804.9 5342.4 5413.3 5419.5 5427.3 5447.5 4774.3 4788.2 4803.5 4808.5 4818.1 5054.7 6200.0 6278.8 6281.3 6295.2 6801.3 6893.9 6894.1 6899.8 6928.0 6267.9 6283.8 6318.8 6333.5 6357.6 5810.1 6057.2 6083.4 6085.2 6085.9 6803.7 6963.6 7021.0 7042.6 7047.1 6894.5 6896.2 6897.4 6934.1 6947.4 6848.3 7015.3 7033.1 7041.2 7061.1 6521.1 6582.7 6676.8 6715.8 6740.8 5766.5 6892.7 6926.9 6930.6 6937.8 6376.5 6442.9 6575.0 6669.9 6685.9 6562.4 6653.4 6686.2 6688.7 6705.3 6427.0 6434.9 6540.1 6546.8 6582.4 6351.7 6678.2 6691.7 6700.0 6716.1 6334.1 6358.4 6416.3 6441.8 6480.2 05:03:15 INFO - PID 1676 | 05:03:15 INFO - PID 1676 | [#1] ext.html Cycles:180 Average:45588.68 Median:36934.85 stddev:81047.53 (219.4%) stddev-sans-first:81204.92 05:03:15 INFO - PID 1676 | Values: 734.9 812.4 836.8 1302.3 1315.6 37432.6 38504.6 38526.2 38552.6 38611.6 38513.0 38840.2 38843.8 38855.8 38891.8 8003.7 8180.6 8490.3 8724.9 8757.3 7376.6 8718.2 8784.5 8788.4 8845.2 8746.7 8781.0 8789.2 8795.9 8804.7 8708.2 8779.1 8786.8 8810.0 8827.6 8566.7 8618.0 8619.9 8642.5 8652.5 38349.4 38372.6 38372.8 38404.0 38520.4 3660.2 3672.1 3715.2 3723.2 3723.6 31224.5 31343.7 31430.5 31473.4 31499.2 3159.1 3174.7 3186.1 3190.3 3196.9 258527.0 259332.0 283760.6 289439.6 289580.0 48572.3 48606.5 48627.5 48652.5 48693.8 50311.7 50615.7 53682.7 54671.0 56229.7 14662.9 14863.6 14894.6 14956.6 14962.9 11918.0 11983.0 11993.3 12001.5 12091.7 11447.8 14095.4 14128.6 14255.4 14344.1 5659.6 5989.7 6255.6 6313.9 6352.7 800.6 805.4 807.0 837.3 849.4 18754.3 19163.5 20361.7 20818.0 21986.0 870.3 882.8 915.9 932.5 945.4 9262.4 9320.7 9737.4 10709.4 10846.6 320597.4 334088.0 336497.0 337125.0 338747.0 53888.5 53944.1 54019.7 54055.5 54199.5 1403.2 1500.9 1528.8 1530.2 1544.0 20574.4 20664.1 20666.0 21069.0 21210.7 38437.0 38605.6 38627.8 38734.0 38758.8 312224.0 312585.0 312844.0 312883.0 313130.0 29232.4 34635.7 35148.0 35309.8 35349.5 36139.0 44402.3 44823.0 44909.8 44962.0 21997.3 29352.0 29564.2 29982.4 30780.5 29935.7 30298.0 30412.8 30479.4 30899.0 36781.1 36857.1 36862.0 36900.8 36968.9 26600.9 29302.4 29827.4 30329.0 31519.2 21638.8 23004.4 24385.1 24395.9 24649.0 05:03:15 INFO - PID 1676 | 05:03:15 INFO - PID 1676 | [#2] jquery.html Cycles:180 Average:36094.59 Median:28583.14 stddev:96521.90 (337.7%) stddev-sans-first:96755.54 05:03:15 INFO - PID 1676 | Values: 440.2 444.4 447.9 457.4 466.2 21396.0 21577.7 22445.0 23385.6 23505.9 22752.9 23019.4 23133.0 23196.4 23497.2 6129.0 6254.1 6256.5 6265.5 6344.3 6239.0 6367.6 6377.6 6379.8 6387.2 5786.9 6004.4 6028.3 6030.2 6052.8 6127.1 6136.2 6139.6 6185.8 6187.6 5478.5 5553.9 5558.5 5563.8 5573.6 27735.2 27921.9 28488.6 28677.7 28818.0 2163.7 2205.6 2208.3 2211.2 2216.6 16661.3 17341.4 17474.4 18237.0 18461.5 2149.4 2204.9 2205.1 2241.6 2255.2 155242.0 156642.0 156654.0 157855.2 160460.0 12567.0 12644.1 12831.8 12910.5 13065.7 13351.7 16390.4 16649.3 16651.1 16867.6 7503.5 8868.8 9227.9 9230.9 9323.9 7270.7 8736.6 8743.3 8783.9 8925.0 7656.3 7799.6 7826.3 7828.0 7845.2 2190.0 2196.0 2198.2 2203.1 2334.0 781.8 788.2 788.7 791.9 809.3 15163.0 17681.9 17926.0 17969.4 18251.9 822.4 833.2 837.3 843.8 847.8 8605.1 8727.5 9120.3 9159.5 9475.4 537659.0 568806.0 570736.0 584224.1 586650.0 126853.1 128124.0 128480.4 129331.4 135882.0 1151.4 1152.2 1176.7 1187.2 1188.9 16424.3 16570.4 16579.0 16632.5 16654.7 57361.4 58458.7 59197.0 59482.7 59533.7 77460.6 77513.2 77842.6 78331.6 78446.2 8581.9 8603.6 8846.6 8872.0 8931.0 13551.8 13729.6 13750.2 13959.0 14086.2 11701.6 11783.8 11832.1 12017.6 12028.3 10970.2 11104.7 11139.8 11236.8 11260.9 11755.2 12030.0 12137.9 12166.0 12245.8 8408.7 8591.0 8613.1 8844.3 8943.3 9411.7 9868.6 11765.4 11973.3 12044.1 05:03:15 INFO - PID 1676 | 05:03:15 INFO - PID 1676 | [#3] mootools.html Cycles:180 Average:7076.20 Median:4101.06 stddev:4499.91 (109.7%) stddev-sans-first:4491.41 05:03:15 INFO - PID 1676 | Values: 1272.8 1468.4 1490.1 1497.4 1504.2 9747.2 11342.8 11931.7 12080.3 12263.0 10590.5 11403.2 11822.6 11854.9 12026.3 2499.5 2525.8 2526.6 2526.9 2529.2 2447.4 2484.1 2525.5 2532.6 2543.9 2463.8 2508.6 2518.7 2524.2 2527.1 2191.0 2398.8 2484.3 2498.7 2500.1 2431.7 2446.4 2450.6 2462.6 2548.3 11817.6 11956.0 12064.3 12064.6 12067.1 6536.1 6719.8 6783.3 6791.3 6800.5 4095.4 4326.5 4377.2 4395.9 4399.5 1074.7 1257.8 1267.0 1273.9 1275.4 16122.3 16588.3 16640.5 16729.5 16739.9 5649.4 5717.2 5876.8 5881.9 5905.4 12254.8 12343.3 12383.9 12401.7 12442.8 6552.8 6605.0 6614.8 6620.7 6628.1 6043.7 6104.9 6180.4 6237.8 6246.1 4341.0 4403.6 4503.5 4559.7 4560.0 1315.5 1338.7 1339.7 1349.0 1353.2 632.6 658.2 658.9 659.0 662.3 5844.9 5911.6 6004.4 6187.8 6807.0 663.6 783.7 802.1 834.8 840.7 3392.6 3957.2 4106.7 4308.5 4346.0 14798.3 15133.5 15337.8 15348.2 15367.8 13886.0 14864.6 15085.3 15205.3 15213.6 7507.9 7980.3 8817.6 8831.0 8871.3 5413.3 6442.6 7048.4 7070.0 7121.1 9942.5 12242.4 12946.1 12994.0 13035.1 13092.4 13122.8 13862.0 13869.0 14010.2 8686.5 8962.6 8968.8 8978.4 9017.2 10773.4 10804.2 10815.6 10840.2 10978.0 7747.8 8598.7 9236.2 9298.0 9305.6 9035.6 9077.9 9115.5 9177.3 9323.6 8114.8 8231.1 8252.7 8268.2 8269.5 5991.4 5995.5 6082.9 6170.1 6245.8 5320.9 5605.0 5838.2 5868.8 5884.6 05:03:15 INFO - PID 1676 | 05:03:15 INFO - PID 1676 | [#4] prototype.html Cycles:180 Average:5283.86 Median:5936.48 stddev:1694.71 (28.5%) stddev-sans-first:1659.45 05:03:15 INFO - PID 1676 | Values: 406.8 407.4 409.8 415.8 420.4 6085.6 6203.8 6314.5 6331.0 6385.5 5259.5 5925.8 5981.3 6163.2 6176.7 3904.0 4077.9 4320.5 4493.8 4507.2 3941.3 4122.8 4265.4 4495.7 4509.8 3978.8 4341.7 4484.8 4488.4 4496.3 3329.8 3674.8 4351.0 4422.3 4457.5 3835.9 3839.4 3845.8 3850.4 3858.6 5059.4 5716.8 5972.7 6024.5 6049.3 5269.0 5339.7 5377.0 5421.9 5422.9 5484.6 6585.1 6585.3 6616.8 6625.7 4386.1 4396.9 4415.7 4421.3 4424.2 5819.9 6709.8 6809.9 6883.2 6998.2 4441.7 4454.9 4473.4 4483.7 4484.8 4193.5 4547.2 4557.7 4566.3 4581.0 4720.8 4768.8 4781.7 5311.5 5374.3 6129.6 6266.7 6606.7 6624.5 6642.2 1273.3 1329.8 1532.7 1543.7 1554.6 964.5 1023.3 1026.4 1033.8 1042.9 5164.0 5622.8 5765.3 6245.6 6289.7 5624.0 6622.0 6869.5 6872.5 6906.7 5438.3 5947.2 6120.4 6192.0 6199.9 2941.9 3413.8 3582.8 3590.9 3593.9 5828.3 6829.0 6936.1 6990.0 7112.8 6866.1 6884.7 6952.5 6972.3 7021.6 6311.4 6701.7 6952.5 7011.5 7016.9 5403.2 6794.5 6850.2 6857.2 6900.9 6433.6 6660.2 6742.6 6748.7 6776.8 6119.8 6799.5 6816.0 6974.0 7094.9 3932.9 4459.9 4464.4 4469.5 4482.8 6620.6 6891.3 6900.0 6902.9 6941.8 6651.0 6652.3 6659.1 6669.6 6714.5 5815.4 6355.0 6531.3 6596.9 6606.2 5412.7 6488.8 6503.4 6514.2 6541.5 5338.8 6445.7 6620.1 6673.3 6691.8 5805.9 6087.4 6440.7 6444.7 6473.1 05:03:15 INFO - PID 1676 | 05:03:15 INFO - PID 1676 | [#5] yui.html Cycles:180 Average:20699.72 Median:17802.65 stddev:28602.17 (160.7%) stddev-sans-first:28643.19 05:03:15 INFO - PID 1676 | Values: 751.3 842.7 853.0 865.0 873.4 16394.3 16811.9 16834.7 18050.2 18990.0 17758.0 18093.6 18174.5 18246.1 18488.9 996.1 1038.0 1038.3 1040.7 1041.9 1015.1 1050.4 1053.7 1054.1 1058.8 1080.5 1095.2 1105.4 1110.1 1110.9 1074.1 1094.6 1100.2 1106.0 1107.0 790.6 807.3 821.3 825.0 825.3 16261.4 16361.5 16415.2 16441.2 16446.4 17314.3 17473.2 17847.3 17921.3 17978.4 13890.8 14094.2 14101.4 14149.1 14242.4 3504.9 3563.5 3565.3 3565.6 3568.9 83565.7 105756.0 115536.0 116484.4 116576.0 13493.9 13510.2 13761.4 13782.3 13785.5 24728.5 25188.5 25817.5 25984.7 25993.6 7930.2 7967.1 7977.3 7988.3 8004.5 3924.6 3970.7 3997.9 4001.1 4002.7 4052.2 4154.5 4166.8 4172.7 4563.9 959.0 977.8 991.9 994.1 998.2 653.2 668.7 671.3 676.4 687.5 10405.8 11224.8 11706.8 12192.9 12205.9 647.5 653.4 663.1 663.3 688.3 5040.3 5376.7 5388.1 5497.5 5551.9 97706.0 102557.0 103895.0 104117.5 106021.0 88591.0 89034.1 89318.6 90056.6 91119.6 74094.3 77371.0 77477.6 77617.6 78008.0 9821.0 10442.2 11255.7 11347.0 11451.3 34166.0 39478.4 41401.0 41918.4 41964.8 52578.0 53113.7 53578.7 53680.5 53935.5 13986.4 14123.6 14322.9 14415.6 14489.2 15629.0 15632.2 15658.3 15897.5 15961.8 11959.3 12118.2 14451.3 14599.4 14614.0 14509.0 14528.1 14661.3 14742.5 14813.3 14303.4 14378.7 14415.0 14470.1 14498.6 9912.0 10580.4 10593.3 10707.1 11076.0 10713.9 12923.8 13966.9 13982.7 14000.2 05:03:15 INFO - PID 1676 | -------- Summary: end -------- 05:03:15 INFO - PID 1676 | 05:03:16 INFO - TEST-INFO | 1676: exit 0 05:03:16 INFO - TEST-OK | dromaeo_css | took 1115639ms 05:03:16 INFO - TEST-START | kraken 05:03:16 INFO - operating with platform_type : mac_ 05:03:16 INFO - Initialising browser for kraken test... 05:03:16 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpq16Mv9/profile http://localhost:49241/getInfo.html) 05:03:19 INFO - PID 1690 | 2017-04-16 05:03:19.262 plugin-container[1691:17957] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454b, name = 'com.apple.tsm.portname' 05:03:19 INFO - PID 1690 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:03:19 INFO - PID 1690 | 2017-04-16 05:03:19.262 plugin-container[1691:17957] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 05:03:19 INFO - PID 1690 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:03:19 INFO - PID 1690 | 2017-04-16 05:03:19.262 plugin-container[1691:17957] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:03:19 INFO - PID 1690 | __metrics Screen width/height:1600/1200 05:03:19 INFO - PID 1690 | colorDepth:24 05:03:19 INFO - PID 1690 | Browser inner width/height: 1024/689 05:03:19 INFO - PID 1690 | __metrics 05:03:19 ERROR - PID 1690 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 05:03:20 INFO - TEST-INFO | 1690: exit 0 05:03:20 INFO - Browser initialized. 05:03:20 INFO - Running cycle 1/1 for kraken test... 05:03:20 INFO - TEST-INFO | started process 1692 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpq16Mv9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:22 INFO - PID 1692 | 2017-04-16 05:03:22.699 plugin-container[1693:18086] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 05:03:22 INFO - PID 1692 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:03:22 INFO - PID 1692 | 2017-04-16 05:03:22.699 plugin-container[1693:18086] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 05:03:22 INFO - PID 1692 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:03:22 INFO - PID 1692 | 2017-04-16 05:03:22.700 plugin-container[1693:18086] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:03:32 INFO - PID 1692 | RSS: Main: 237998080 05:03:32 INFO - PID 1692 | 05:03:35 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:03:36 INFO - PID 1692 | RSS: Main: 249487360 05:03:36 INFO - PID 1692 | 05:03:39 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:03:39 INFO - PID 1692 | RSS: Main: 257908736 05:03:39 INFO - PID 1692 | 05:03:43 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 05:03:43 INFO - PID 1692 | RSS: Main: 260505600 05:03:43 INFO - PID 1692 | 05:03:45 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 05:03:46 INFO - PID 1692 | RSS: Main: 262463488 05:03:46 INFO - PID 1692 | 05:03:48 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:03:49 INFO - PID 1692 | RSS: Main: 263118848 05:03:49 INFO - PID 1692 | 05:03:52 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 05:03:52 INFO - PID 1692 | RSS: Main: 268312576 05:03:52 INFO - PID 1692 | 05:03:55 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 05:03:56 INFO - PID 1692 | RSS: Main: 269303808 05:03:56 INFO - PID 1692 | 05:03:59 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 05:04:00 INFO - PID 1692 | RSS: Main: 269189120 05:04:00 INFO - PID 1692 | 05:04:01 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:04:02 INFO - PID 1692 | RSS: Main: 268963840 05:04:02 INFO - PID 1692 | 05:04:03 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:04:04 INFO - PID 1692 | RSS: Main: 268988416 05:04:04 INFO - PID 1692 | 05:04:06 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:04:07 INFO - PID 1692 | RSS: Main: 268619776 05:04:07 INFO - PID 1692 | 05:04:10 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:04:11 INFO - PID 1692 | RSS: Main: 269074432 05:04:11 INFO - PID 1692 | 05:04:14 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:04:14 INFO - PID 1692 | RSS: Main: 266219520 05:04:14 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 05:04:16 INFO - PID 1692 | RSS: Main: 267862016 05:04:16 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | __start_tp_report 05:04:16 INFO - PID 1692 | _x_x_mozilla_page_load 05:04:16 INFO - PID 1692 | _x_x_mozilla_page_load_details 05:04:16 INFO - PID 1692 | |i|pagename|runs| 05:04:16 INFO - PID 1692 | |0;ai-astar;102;142;165;114;114;119;105;168;158;125 05:04:16 INFO - PID 1692 | |1;audio-beat-detection;143;117;143;149;146;147;145;119;138;114 05:04:16 INFO - PID 1692 | |2;audio-dft;201;203;211;221;206;211;197;197;195;196 05:04:16 INFO - PID 1692 | |3;audio-fft;82;56;58;82;60;64;84;58;87;82 05:04:16 INFO - PID 1692 | |4;audio-oscillator;81;72;86;69;73;71;93;93;57;98 05:04:16 INFO - PID 1692 | |5;imaging-gaussian-blur;88;89;110;89;89;115;134;87;91;89 05:04:16 INFO - PID 1692 | |6;imaging-darkroom;96;98;96;95;96;96;105;95;96;99 05:04:16 INFO - PID 1692 | |7;imaging-desaturate;89;90;90;93;108;138;83;139;143;90 05:04:16 INFO - PID 1692 | |8;json-parse-financial;50;49;51;52;52;50;52;51;50;50 05:04:16 INFO - PID 1692 | |9;json-stringify-tinderbox;57;55;65;67;65;58;58;55;58;58 05:04:16 INFO - PID 1692 | |10;stanford-crypto-aes;81;75;87;90;102;105;107;82;84;84 05:04:16 INFO - PID 1692 | |11;stanford-crypto-ccm;138;138;134;138;142;138;142;145;184;142 05:04:16 INFO - PID 1692 | |12;stanford-crypto-pbkdf2;187;213;187;233;231;194;198;235;210;184 05:04:16 INFO - PID 1692 | |13;stanford-crypto-sha256-iterative;70;69;70;67;69;66;69;68;71;71 05:04:16 INFO - PID 1692 | __end_tp_report 05:04:16 INFO - PID 1692 | __start_cc_report 05:04:16 INFO - PID 1692 | _x_x_mozilla_cycle_collect,990 05:04:16 INFO - PID 1692 | __end_cc_report 05:04:16 INFO - PID 1692 | __startTimestamp1492344256954__endTimestamp 05:04:16 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | ------- Summary: start ------- 05:04:16 INFO - PID 1692 | Number of tests: 14 05:04:16 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | [#0] ai-astar Cycles:10 Average:131.20 Median:133.50 stddev:25.05 (18.8%) stddev-sans-first:24.24 05:04:16 INFO - PID 1692 | Values: 102.0 142.0 165.0 114.0 114.0 119.0 105.0 168.0 158.0 125.0 05:04:16 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:144.00 stddev:13.77 (9.6%) stddev-sans-first:14.38 05:04:16 INFO - PID 1692 | Values: 143.0 117.0 143.0 149.0 146.0 147.0 145.0 119.0 138.0 114.0 05:04:16 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | [#2] audio-dft Cycles:10 Average:203.80 Median:204.50 stddev:8.46 (4.1%) stddev-sans-first:8.91 05:04:16 INFO - PID 1692 | Values: 201.0 203.0 211.0 221.0 206.0 211.0 197.0 197.0 195.0 196.0 05:04:16 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | [#3] audio-fft Cycles:10 Average:71.30 Median:82.00 stddev:13.00 (15.8%) stddev-sans-first:13.20 05:04:16 INFO - PID 1692 | Values: 82.0 56.0 58.0 82.0 60.0 64.0 84.0 58.0 87.0 82.0 05:04:16 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:83.50 stddev:13.07 (15.7%) stddev-sans-first:13.85 05:04:16 INFO - PID 1692 | Values: 81.0 72.0 86.0 69.0 73.0 71.0 93.0 93.0 57.0 98.0 05:04:16 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | [#5] imaging-gaussian-blur Cycles:10 Average:98.10 Median:89.00 stddev:16.07 (18.1%) stddev-sans-first:16.62 05:04:16 INFO - PID 1692 | Values: 88.0 89.0 110.0 89.0 89.0 115.0 134.0 87.0 91.0 89.0 05:04:16 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | [#6] imaging-darkroom Cycles:10 Average:97.20 Median:96.00 stddev:3.01 (3.1%) stddev-sans-first:3.16 05:04:16 INFO - PID 1692 | Values: 96.0 98.0 96.0 95.0 96.0 96.0 105.0 95.0 96.0 99.0 05:04:16 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | [#7] imaging-desaturate Cycles:10 Average:106.30 Median:89.50 stddev:24.13 (27.0%) stddev-sans-first:24.77 05:04:16 INFO - PID 1692 | Values: 89.0 90.0 90.0 93.0 108.0 138.0 83.0 139.0 143.0 90.0 05:04:16 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:51.00 stddev:1.06 (2.1%) stddev-sans-first:1.09 05:04:16 INFO - PID 1692 | Values: 50.0 49.0 51.0 52.0 52.0 50.0 52.0 51.0 50.0 50.0 05:04:16 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:58.00 stddev:4.38 (7.5%) stddev-sans-first:4.54 05:04:16 INFO - PID 1692 | Values: 57.0 55.0 65.0 67.0 65.0 58.0 58.0 55.0 58.0 58.0 05:04:16 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:83.00 stddev:11.10 (13.4%) stddev-sans-first:11.31 05:04:16 INFO - PID 1692 | Values: 81.0 75.0 87.0 90.0 102.0 105.0 107.0 82.0 84.0 84.0 05:04:16 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:142.00 stddev:14.36 (10.1%) stddev-sans-first:15.06 05:04:16 INFO - PID 1692 | Values: 138.0 138.0 134.0 138.0 142.0 138.0 142.0 145.0 184.0 142.0 05:04:16 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:207.20 Median:211.50 stddev:20.16 (9.5%) stddev-sans-first:20.02 05:04:16 INFO - PID 1692 | Values: 187.0 213.0 187.0 233.0 231.0 194.0 198.0 235.0 210.0 184.0 05:04:16 INFO - PID 1692 | 05:04:16 INFO - PID 1692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.63 (2.3%) stddev-sans-first:1.69 05:04:16 INFO - PID 1692 | Values: 70.0 69.0 70.0 67.0 69.0 66.0 69.0 68.0 71.0 71.0 05:04:16 INFO - PID 1692 | -------- Summary: end -------- 05:04:16 INFO - PID 1692 | 05:04:18 INFO - TEST-INFO | 1692: exit 0 05:04:18 INFO - TEST-OK | kraken | took 61693ms 05:04:18 INFO - SUITE-END | took 1177s 05:04:18 INFO - Completed test suite (00:19:37) 05:04:18 INFO - javascript benchmark 05:04:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7807.615397971431, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3555.466679998001, 3556.110972256937, 3589.1565482111714, 3598.6581274778887, 3632.164602141507, 4847.587955023822, 5300.973495132519, 6273.749050037999, 6354.396332348431, 6390.360963903608, 6124.8386823524725, 6216.875662486747, 6253.499720022399, 6303.873922521547, 6318.0, 5454.618176727621, 5508.0, 5560.9712203242325, 5603.775848966056, 5642.15367694847, 4664.97667511662, 5406.513413792758, 5516.7517461714315, 5599.804006859761, 5689.4879460848515, 5432.592555558309, 5553.16702494629, 5589.832305030855, 5632.239647647577, 5663.546916246711, 5459.0, 5512.145617429305, 5520.613557051008, 5554.833354999316, 5577.051901176769, 5435.456454354572, 5439.918401223985, 5460.426655201226, 5463.590230732711, 5471.398146203915, 5151.484851514856, 6145.139680444697, 6225.439710426038, 6238.0, 6251.156093927307, 6665.93334066658, 6750.966245168792, 6784.0841486399695, 6794.116764820591, 6847.0, 6874.725010999554, 6885.173779146485, 6905.654717264167, 6906.205786334585, 6930.5148639595245, 5744.684042377709, 5960.0761881908375, 6045.818625441288, 6371.076193951943, 6371.2991570927625, 6814.386705196556, 6891.207511136183, 6916.930830691628, 7020.648967551602, 7043.119610048744, 6365.777197798055, 6442.420182183626, 6628.204615446178, 6645.568038077509, 6704.631245281459, 6098.451139397387, 6122.326544080148, 6634.635095069721, 6844.691988860413, 6905.240423553405, 6786.423154031962, 6799.082123913307, 6801.693923773442, 6808.795736127924, 6809.7276108956075, 6529.216494020653, 6626.834329141713, 6724.562903411361, 6775.457963363017, 6804.863902722017, 5342.412334643186, 5413.269208656781, 5419.458054194549, 5427.3215848019, 5447.455254474521, 4774.30772537987, 4788.233882578771, 4803.471618122004, 4808.519148085234, 4818.108649899709, 5054.7472626368535, 6200.0, 6278.811635650938, 6281.309056003836, 6295.213098362705, 6801.251862295144, 6893.931060689329, 6894.13823272091, 6899.827504312432, 6927.965360173167, 6267.905981410283, 6283.842903927347, 6318.8420289492215, 6333.461655759312, 6357.618542887349, 5810.128480727924, 6057.242844644419, 6083.361247069082, 6085.208922840003, 6085.908711369333, 6803.727850886008, 6963.61700106499, 7021.0, 7042.647867606702, 7047.083879095685, 6894.482913781587, 6896.172459304916, 6897.41371983387, 6934.063901373452, 6947.3747362737595, 6848.280930502226, 7015.263397343206, 7033.050538177281, 7041.155061392666, 7061.1173603299585, 6521.087047813215, 6582.670866456754, 6676.83307917306, 6715.7985260442265, 6740.797776066725, 5766.509846663081, 6892.655367231719, 6926.896096558455, 6930.584164950119, 6937.826554336182, 6376.52176086786, 6442.935570644234, 6575.013747937847, 6669.866602668017, 6685.899711504234, 6562.409383155539, 6653.434458071119, 6686.1642294713165, 6688.665566721547, 6705.2959439258175, 6427.035944608159, 6434.903476447951, 6540.084388185753, 6546.83632909162, 6582.407583317525, 6351.68241587928, 6678.23200331968, 6691.732330706912, 6699.9665001674675, 6716.126903502513, 6334.113224148531, 6358.395952384516, 6416.326285740117, 6441.774537891151, 6480.157579514633], "value": 6156.913178626661, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.9416839750759, 812.4272387966482, 836.8117173635933, 1302.316283950925, 1315.6447759105035, 37432.625673743256, 38504.614953850454, 38526.22947541047, 38552.614473855254, 38611.61388386119, 38513.0, 38840.22319553607, 38843.805780971124, 38855.805720971424, 38891.805540972324, 8003.679852805895, 8180.550069746161, 8490.320774338039, 8724.912750872474, 8757.25563327118, 7376.631168441583, 8718.17177368149, 8784.472931624092, 8788.428752131123, 8845.20393164615, 8746.650133994632, 8781.03408625054, 8789.198214366039, 8795.868061979076, 8804.735857924241, 8708.21626053652, 8779.122087791233, 8786.824263514758, 8810.0, 8827.646894124227, 8566.742997710078, 8618.0, 8619.870701939475, 8642.524661143634, 8652.480851148952, 38349.424758628644, 38372.61627383746, 38372.80813595942, 38404.0, 38520.42219366712, 3660.194757153422, 3672.081979505124, 3715.2198038411966, 3723.236736469017, 3723.6276372362818, 31224.531632025537, 31343.686563134306, 31430.528542071886, 31473.37053258922, 31499.212519687193, 3159.0522843147196, 3174.68253174683, 3186.107889790839, 3190.266238765074, 3196.9360612787614, 258527.0, 259332.0, 283760.58119709475, 289439.55280223675, 289580.0, 48572.271415928786, 48606.51393486091, 48627.5137248623, 48652.5134748648, 48693.756531217114, 50311.74844125756, 50615.746921265156, 53682.73158634182, 54671.0, 56229.7188514063, 14662.926685366505, 14863.628409289639, 14894.627634309229, 14956.626084347978, 14962.925185374004, 11918.04655627565, 11983.0, 11993.280403175837, 12001.519939202333, 12091.697707557205, 11447.828282575769, 14095.436182552583, 14128.646783830281, 14255.429782808571, 14344.139351638934, 5659.575531835047, 5989.712211874468, 6255.593386429868, 6313.905291420632, 6352.745890164434, 800.6317094136763, 805.4040010392267, 807.0, 837.250660658707, 849.3587341557085, 18754.343597974006, 19163.520911977314, 20361.694574581394, 20818.0, 21986.01062952171, 870.3211495033884, 882.7748924024332, 915.9129882661136, 932.5383934952242, 945.4185675809327, 9262.39794413361, 9320.673776417929, 9737.367071140354, 10709.410982395888, 10846.566137354575, 320597.3970130181, 334088.0, 336497.0, 337125.0, 338747.0, 53888.46111538913, 53944.145026947765, 54019.72990135024, 54055.45944540583, 54199.45800542023, 1403.249261645015, 1500.9399624015136, 1528.816542014943, 1530.1507663246782, 1544.0195475872677, 20574.382768516967, 20664.07011684508, 20666.0, 21069.0, 21210.681839772107, 38437.0, 38605.613943861325, 38627.80686096552, 38734.031649209, 38758.80620596879, 312224.0, 312585.0, 312844.0, 312883.0, 313130.0, 29232.415351692423, 34635.65364346324, 35148.0, 35309.823450882584, 35349.46975795417, 36139.0, 44402.333964989906, 44823.0, 44909.775451122536, 44962.0, 21997.340079797632, 29352.0, 29564.226146431283, 29982.4003519924, 30780.53829192609, 29935.70064299329, 30298.0, 30412.84793576018, 30479.390412192075, 30899.0, 36781.08047298732, 36857.07857303589, 36862.0, 36900.81549592235, 36968.89093327204, 26600.8669956649, 29302.41395172127, 29827.403451931274, 30329.0, 31519.21201969969, 21638.80986545755, 23004.4248893779, 24385.14651987172, 24395.878020609784, 24649.01403943822], "value": 17278.691905443404, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.2471773267712, 444.428908852125, 447.90146167843085, 457.3733984441315, 466.2423561712218, 21396.0, 21577.67633485497, 22444.999999999978, 23385.649215261743, 23505.882470587665, 22752.86235688217, 23019.42451438715, 23133.044427932393, 23196.42008949773, 23497.177598784045, 6128.969355153229, 6254.061241015277, 6256.468200202966, 6265.530085243602, 6344.302126766075, 6239.0, 6367.6497792621385, 6377.617342959414, 6379.776707815227, 6387.201599800025, 5786.913196302059, 6004.42957918997, 6028.306744724369, 6030.246219222598, 6052.848678783043, 6127.080937859312, 6136.23297087864, 6139.570230083896, 6185.814425567218, 6187.628742275456, 5478.506934375885, 5553.888922221573, 5558.471945165203, 5563.777448902079, 5573.6098473106895, 27735.167944961482, 27921.86039069812, 28488.575571221358, 28677.713222867922, 28817.991370301937, 2163.707899433588, 2205.6140175469227, 2208.3374987503685, 2211.1929145861804, 2216.5899308627954, 16661.33354665812, 17341.39305124327, 17474.388396406066, 18236.99696516691, 18461.538461538436, 2149.3874245840016, 2204.911803527857, 2205.073868975034, 2241.6301310283784, 2255.154317131076, 155242.0, 156642.0, 156654.0, 157855.2107239468, 160460.0, 12567.0, 12644.114911956074, 12831.807522887164, 12910.483580656668, 13065.738685226432, 13351.73296534064, 16390.426335078217, 16649.3340266388, 16651.084190369646, 16867.578310542336, 7503.5497870127965, 8868.822623547492, 9227.907720922705, 9230.86153707695, 9323.860142097874, 7270.7091716331815, 8736.588023048447, 8743.344249181337, 8783.912160878437, 8924.973628032729, 7656.349210317074, 7799.649015794303, 7826.295633393022, 7828.0, 7845.215478452109, 2189.9781002190093, 2195.9560808783735, 2198.1537108213133, 2203.0747086223823, 2333.981106343035, 781.7693780334702, 788.1881661888265, 788.6648174525803, 791.8930944322443, 809.3444310108831, 15163.0, 17681.911590441967, 17926.0, 17969.371072012418, 18251.9048857069, 822.3585603229491, 833.1709948601181, 837.3134030095264, 843.8101427178835, 847.7707324379675, 8605.09946541064, 8727.516322225238, 9120.315976301805, 9159.496227707406, 9475.384100033476, 537659.0, 568806.0, 570736.0, 584224.0788796028, 586650.0, 126853.09720354203, 128124.0, 128480.35759821141, 129331.35334323456, 135882.0, 1151.3897634253858, 1152.153167421944, 1176.7469993951343, 1187.1867770577182, 1188.9405529723479, 16424.260908259395, 16570.420035298706, 16579.0, 16632.50102496927, 16654.666906661558, 57361.426385735605, 58458.707706461195, 59197.0, 59482.70258648852, 59533.702331488064, 77460.61269693615, 77513.22486775286, 77842.6107869457, 78331.60834195792, 78446.21553784389, 8581.871271931052, 8603.612837422206, 8846.557672116498, 8871.955640221757, 8930.955345223232, 13551.79672304936, 13729.588112356645, 13750.243736594182, 13959.022868399115, 14086.15483071019, 11701.590444334408, 11783.823242651195, 11832.053435725293, 12017.63947081589, 12028.338441385808, 10970.177236707439, 11104.722381940515, 11139.83290250663, 11236.83144752813, 11260.887391125983, 11755.177137600285, 12030.0, 12137.878621213675, 12166.0, 12245.75508489843, 8408.705695300636, 8590.957045214735, 8613.09562495929, 8844.29100121711, 8943.284537237136, 9411.670591529264, 9868.555914983986, 11765.352905590275, 11973.281603103842, 12044.096692748255], "value": 10252.580589744808, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.8472583290004, 1468.412634946022, 1490.128274959149, 1497.3860717105988, 1504.2102895979613, 9747.22022238221, 11342.773144537116, 11931.701707457318, 12080.335581543022, 12263.0, 10590.523426445809, 11403.201775875692, 11822.581290245183, 11854.881451185485, 12026.278423294609, 2499.525090232859, 2525.8231923765343, 2526.557852375836, 2526.873656317186, 2529.2285852814884, 2447.412620970963, 2484.068474322129, 2525.5454018276705, 2532.645429639852, 2543.9109631162914, 2463.790577800889, 2508.5735424977797, 2518.7355327690602, 2524.1670248817845, 2527.140772137473, 2191.024993877717, 2398.7721166489155, 2484.291976786625, 2498.650188973545, 2500.1249562653106, 2431.683881095464, 2446.388402899275, 2450.6446565248116, 2462.605983042705, 2548.311955771931, 11817.586384476588, 11956.0, 12064.276143431422, 12064.638060858188, 12067.094967877445, 6536.11762412073, 6719.832004199885, 6783.3216678332265, 6791.252962174157, 6800.455963522906, 4095.4471146395153, 4326.524082350938, 4377.212101821671, 4395.868123956287, 4399.450068741407, 1074.6668532754793, 1257.7736007518643, 1267.026281435505, 1273.8980881529549, 1275.3623188405797, 16122.274497647517, 16588.336466541325, 16640.50078497647, 16729.49811505657, 16739.91630041842, 5649.378568357477, 5717.171010203498, 5876.7649294028615, 5881.911771323434, 5905.350411454737, 12254.81617775734, 12343.259404435763, 12383.885450309515, 12401.689957751129, 12442.75114497723, 6552.803415897531, 6605.042268870987, 6614.8346291343105, 6620.668966551653, 6628.138342015507, 6043.697815109227, 6104.938950610526, 6180.412860778219, 6237.75048998035, 6246.125542424064, 4340.978295108504, 4403.647708183337, 4503.504614492404, 4559.658025648089, 4560.0, 1315.5132600937714, 1338.6519504928594, 1339.6583871112805, 1349.0152188902157, 1353.235421986594, 632.583014048528, 658.2223018860401, 658.9242237142694, 658.9933652029581, 662.3145044878528, 5844.853878653068, 5911.615744976562, 6004.39956004396, 6187.81436556904, 6806.965965170142, 663.5653646861314, 783.6904422752981, 802.0936341933577, 834.8079941613463, 840.6931470013401, 3392.6437724039115, 3957.1689945111275, 4106.67146628269, 4308.547602501755, 4346.00041990344, 14798.334074966653, 15133.470328538668, 15337.769933451007, 15348.23258837076, 15367.846321536865, 13885.958553108558, 14864.628384290263, 15085.3211605478, 15205.31576079079, 15213.6196595086, 7507.924920750723, 7980.321672657889, 8817.603207855662, 8830.984436789722, 8871.334649901282, 5413.323334583177, 6442.581232219891, 7048.436125110082, 7070.0, 7121.145462544528, 9942.453165075991, 12242.449089790802, 12946.09697857931, 12994.025448091243, 13035.087543871838, 13092.410841512345, 13122.803157952829, 13862.02965792385, 13868.959828012737, 14010.229437381042, 8686.478811271343, 8962.596683149144, 8968.775780605276, 8978.416402933788, 9017.188453039258, 10773.353598784099, 10804.189685773756, 10815.56737730482, 10840.241183117421, 10978.0, 7747.806304842424, 8598.699045533376, 9236.16874481273, 9297.977222505655, 9305.627774888928, 9035.593398296962, 9077.863832042656, 9115.498647574446, 9177.311701622271, 9323.627054917728, 8114.797130071795, 8231.09457959612, 8252.669893204205, 8268.214519620626, 8269.46248493846, 5991.370906054802, 5995.46040856325, 6082.878342433038, 6170.136180934763, 6245.843853903689, 5320.8935821282585, 5605.0, 5838.168488283264, 5868.823935281948, 5884.617499862496], "value": 5317.86347243312, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.81286608160246, 407.3502763092869, 409.8381139449917, 415.7630150814035, 420.4429131400893, 6085.634861908288, 6203.751849926003, 6314.463270621997, 6330.968345158273, 6385.489160867131, 5259.500347466985, 5925.762969481216, 5981.312149102854, 6163.243475609453, 6176.660283684396, 3903.9804800976026, 4077.87766367008, 4320.503142138663, 4493.820247190109, 4507.211238033347, 3941.3496773032416, 4122.8144733486915, 4265.381519679645, 4495.6628252881, 4509.751963641998, 3978.820953057105, 4341.7177883437635, 4484.798184081707, 4488.438945131858, 4496.280595104784, 3329.7835640683397, 3674.7795132292013, 4350.956490435118, 4422.314541246112, 4457.509673935864, 3835.9232815343817, 3839.4432807243074, 3845.788481633509, 3850.4416859555486, 3858.5883822610867, 5059.443461219263, 5716.771329146829, 5972.6715030673295, 6024.457798798086, 6049.334573196945, 5269.0, 5339.679619222859, 5376.978374108907, 5421.918671219935, 5422.945770542323, 5484.61607687462, 6585.1439312889015, 6585.308542603006, 6616.834579135512, 6625.701843417058, 4386.144701783153, 4396.868093957187, 4415.690901636886, 4421.292593185107, 4424.225760491933, 5819.9418005819825, 6709.798706038827, 6809.863802723968, 6883.181772759089, 6998.230194678632, 4441.666874984389, 4454.866354009385, 4473.35136405226, 4483.708558943658, 4484.8430304939175, 4193.496780386373, 4547.15877562652, 4557.749323787158, 4566.337881007302, 4580.954190458119, 4720.811167553328, 4768.833090841873, 4781.6891902026255, 5311.521963023347, 5374.333956473506, 6129.570930034944, 6266.749330026839, 6606.669666516655, 6624.536282460278, 6642.202935647657, 1273.3060482037313, 1329.7898911990042, 1532.6551525906805, 1543.7066957278082, 1554.59309325061, 964.5225613321311, 1023.2990401574945, 1026.4457193115784, 1033.8317700997825, 1042.921780866423, 5164.0, 5622.775088996476, 5765.261500787176, 6245.594036387711, 6289.7484100636375, 5624.0, 6621.966890165519, 6869.519133660596, 6872.450203983669, 6906.689198985957, 5438.265834112344, 5947.197128387699, 6120.378099803555, 6192.0, 6199.876002480015, 2941.911742647724, 3413.8293085345636, 3582.7671201371827, 3590.9102272442874, 3593.8562457501407, 5828.329742079715, 6828.9658551706925, 6936.098307220029, 6989.965050174716, 7112.786616401413, 6866.141732283465, 6884.65576721162, 6952.513324067267, 6972.267911869282, 7021.648917554204, 6311.431971122529, 6701.698423570951, 6952.513324067267, 7011.5442496236565, 7016.912378581328, 5403.162509810985, 6794.4904132189295, 6850.177978642595, 6857.182846545569, 6900.896486552806, 6433.581817181868, 6660.234073081658, 6742.595444273359, 6748.662566871539, 6776.7628133015105, 6119.816405507842, 6799.456043516408, 6815.977603359337, 6973.965130174317, 7094.871538538315, 3932.8820135395986, 4459.929616891987, 4464.3973063635995, 4469.530699276529, 4482.75344856036, 6620.602763834186, 6891.345322194384, 6900.0, 6902.8619427612175, 6941.75703850383, 6650.9667451662435, 6652.301508341555, 6659.136571274398, 6669.6331701754925, 6714.455675194635, 5815.3603103657715, 6354.951433013501, 6531.3468653134305, 6596.944488881756, 6606.174228221473, 5412.675239485643, 6488.837779055561, 6503.439174597967, 6514.1531600891585, 6541.509386795914, 5338.786448542171, 6445.742170313135, 6620.106285651375, 6673.265940746417, 6691.832704182434, 5805.912911306418, 6087.391260873877, 6440.67796610177, 6444.742210311722, 6473.126127972663], "value": 4757.4283053294885, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.2637615137165, 842.6797816829604, 852.9957350213252, 865.0311650950932, 873.3668090634291, 16394.344226230936, 16811.915940420295, 16834.663306733873, 18050.18774155163, 18990.0, 17758.023308718017, 18093.638127237446, 18174.545636359097, 18246.0876956152, 18488.907555462236, 996.1134590214715, 1037.951668814499, 1038.2576457832647, 1040.7033995311338, 1041.9166466682648, 1015.1422048369117, 1050.4117694091333, 1053.7207639975413, 1054.1040115901499, 1058.7511934695378, 1080.5407701726735, 1095.1840878545495, 1105.3920343810912, 1110.0564520157882, 1110.9055730262937, 1074.12458846041, 1094.60047082815, 1100.2188446203206, 1106.0211712634296, 1106.9944650276777, 790.5849429049738, 807.2936180841764, 821.3183058061854, 824.9670013199465, 825.3314814999869, 16261.430849920196, 16361.509154725378, 16415.17924103802, 16441.1779411029, 16446.424375146933, 17314.307427702875, 17473.21370538329, 17847.286108555643, 17921.283148674036, 17978.37075702344, 13890.791638125334, 14094.154350738989, 14101.365438555187, 14149.08030977983, 14242.359093840698, 3504.9474257886154, 3563.465480177994, 3565.286942611462, 3565.607783143852, 3568.8572457101945, 83565.74651380234, 105756.0, 115536.0, 116484.41757791242, 116576.0, 13493.865061349261, 13510.189388636712, 13761.449542018407, 13782.310884455937, 13785.51750688721, 24728.505429891662, 25188.496230075296, 25817.48365032689, 25984.700764962054, 25993.610095848577, 7930.206979302139, 7967.083785364642, 7977.321927636216, 7988.320992715568, 8004.479708818908, 3924.6075392460525, 3970.741901776433, 3997.8800635980965, 4001.079751657135, 4002.7398219115667, 4052.209819085309, 4154.459920210354, 4166.7708276044505, 4172.687048471316, 4563.863084107482, 958.9808203835884, 977.8142152990908, 991.9305648604673, 994.0556471352244, 998.1765043838717, 653.183520599251, 668.7057694614451, 671.3051991189096, 676.3608390071433, 687.4603436302478, 10405.84391234132, 11224.775504489864, 11706.824397634042, 12192.878071219351, 12205.877941220475, 647.488484097567, 653.3825534869598, 663.131297999622, 663.3416458852868, 688.2841844481683, 5040.344755181803, 5376.704281264568, 5388.084025715638, 5497.532709719639, 5551.916721249185, 97706.0, 102557.0, 103895.0, 104117.47941260245, 106021.0, 88591.0, 89034.10965890258, 89318.55340723385, 90056.64915026148, 91119.63320550197, 74094.25905740981, 77371.0, 77477.6126119377, 77617.61191194008, 78008.0, 9820.950895245764, 10442.164626829683, 11255.718607034889, 11347.035501982424, 11451.25566838153, 34166.0, 39478.42086316515, 41401.0, 41918.37122443227, 41964.790176048926, 52578.0, 53113.67215819481, 53578.732106339216, 53680.463195369106, 53935.46064539305, 13986.44054237819, 14123.64690882695, 14322.856771432153, 14415.639609009859, 14489.203093829941, 15628.984116032421, 15632.218389080273, 15658.295376708304, 15897.52307430779, 15961.840381596036, 11959.282443053444, 12118.212316199419, 14451.27743612794, 14599.416023358946, 14613.977021608385, 14509.0, 14528.055676381424, 14661.340239689027, 14742.484013059491, 14813.25933703289, 14303.427862885368, 14378.712425751635, 14415.044915792028, 14470.131792092508, 14498.565043048726, 9912.008799120318, 10580.36517808934, 10593.258471906893, 10707.143428525855, 11076.003159715665, 10713.946430267799, 12923.806142908052, 13966.860331396556, 13982.720345592828, 14000.229987350385], "value": 8208.500213182342, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 142.0, 165.0, 114.0, 114.0, 119.0, 105.0, 168.0, 158.0, 125.0], "value": 131.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 143.0, 149.0, 146.0, 147.0, 145.0, 119.0, 138.0, 114.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 203.0, 211.0, 221.0, 206.0, 211.0, 197.0, 197.0, 195.0, 196.0], "value": 203.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 56.0, 58.0, 82.0, 60.0, 64.0, 84.0, 58.0, 87.0, 82.0], "value": 71.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 72.0, 86.0, 69.0, 73.0, 71.0, 93.0, 93.0, 57.0, 98.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 110.0, 89.0, 89.0, 115.0, 134.0, 87.0, 91.0, 89.0], "value": 98.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 95.0, 96.0, 96.0, 105.0, 95.0, 96.0, 99.0], "value": 97.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 90.0, 93.0, 108.0, 138.0, 83.0, 139.0, 143.0, 90.0], "value": 106.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 51.0, 52.0, 52.0, 50.0, 52.0, 51.0, 50.0, 50.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 65.0, 67.0, 65.0, 58.0, 58.0, 55.0, 58.0, 58.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 87.0, 90.0, 102.0, 105.0, 107.0, 82.0, 84.0, 84.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 134.0, 138.0, 142.0, 138.0, 142.0, 145.0, 184.0, 142.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 213.0, 187.0, 233.0, 231.0, 194.0, 198.0, 235.0, 210.0, 184.0], "value": 207.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 67.0, 69.0, 66.0, 69.0, 68.0, 71.0, 71.0], "value": 69.0, "unit": "score"}]}]} 05:04:18 INFO - Return code: 0 05:04:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:04:18 ERROR - # TBPL SUCCESS # 05:04:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:04:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:04:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:04:18 INFO - 2017-04-16 05:04:18.268 screenresolution[1698:18488] starting screenresolution argv=screenresolution get 05:04:18 INFO - 2017-04-16 05:04:18.271 screenresolution[1698:18488] Display 0: 1600x1200x32@60 05:04:18 INFO - 2017-04-16 05:04:18.277 screenresolution[1699:18491] starting screenresolution argv=screenresolution list 05:04:18 INFO - Available Modes on Display 0 05:04:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:04:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:04:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:04:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:04:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:04:18 INFO - Intel Iris: 05:04:18 INFO - Chipset Model: Intel Iris 05:04:18 INFO - Type: GPU 05:04:18 INFO - Bus: Built-In 05:04:18 INFO - VRAM (Dynamic, Max): 1536 MB 05:04:18 INFO - Vendor: Intel (0x8086) 05:04:18 INFO - Device ID: 0x0a2e 05:04:18 INFO - Revision ID: 0x0009 05:04:18 INFO - Displays: 05:04:18 INFO - Display: 05:04:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:04:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:04:18 INFO - Display Serial Number: 1600x1200 60 05:04:18 INFO - Main Display: Yes 05:04:18 INFO - Mirror: Off 05:04:18 INFO - Online: Yes 05:04:18 INFO - Rotation: Supported 05:04:18 INFO - Return code: 0 05:04:18 INFO - Running post-action listener: _resource_record_post_action 05:04:18 INFO - [mozharness: 2017-04-16 12:04:18.529724Z] Finished run-tests step (success) 05:04:18 INFO - Running post-run listener: _resource_record_post_run 05:04:18 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 34357760; Write bytes: 517771264; Read time: 221; Write time: 1686 05:04:18 INFO - TinderboxPrint: CPU usage
54.1% 05:04:18 INFO - TinderboxPrint: I/O read bytes / time
34,357,760 / 221 05:04:18 INFO - TinderboxPrint: I/O write bytes / time
517,771,264 / 1,686 05:04:18 INFO - TinderboxPrint: CPU idle
2,198.4 (45.9%) 05:04:18 INFO - TinderboxPrint: CPU system
961.5 (20.1%) 05:04:18 INFO - TinderboxPrint: CPU user
1,630.0 (34.0%) 05:04:18 INFO - TinderboxPrint: Swap in / out
238,854,144 / 0 05:04:18 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 194904576; Write bytes: 192548864; Read time: 14970; Write time: 414 05:04:18 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 33423872; Write bytes: 308379648; Read time: 210; Write time: 1220 05:04:19 INFO - Running post-run listener: _upload_blobber_files 05:04:19 INFO - Blob upload gear active. 05:04:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:04:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:04:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:04:19 INFO - (blobuploader) - INFO - Open directory for files ... 05:04:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:04:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:04:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:20 INFO - (blobuploader) - INFO - Done attempting. 05:04:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:04:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:04:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:21 INFO - (blobuploader) - INFO - Done attempting. 05:04:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:04:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:04:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:22 INFO - (blobuploader) - INFO - Done attempting. 05:04:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:04:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:04:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:24 INFO - (blobuploader) - INFO - Done attempting. 05:04:24 INFO - (blobuploader) - INFO - Iteration through files over. 05:04:24 INFO - Return code: 0 05:04:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:04:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:04:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1b08c334f174b463b51bde95031063bfe242d791ffc58f3848a1b98d386cf10ff86cfb585b599e803cf3fbfefc8cdbd431777bfcbb3990286368712b308331", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2685177da45b979c99ab70e206bc3ab80e9a35075e14d143a2146415b1ee75096fb4cfb3ce1125e1546a2fe4c3524ffffb3118e0484de9bfc583956049f2a25b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/970b6c82bcc692eb3f2643d677a1f1641bb5533ee84033bbfa7d44113aa5fcde5bd90ed269831d50015d32e217e094fd071ba792193f95f4728d9ef2f308c001", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/960685aa9da35e4e1a1aa161c33329d1cc383ca5164daab654b4ed33582c107e19194272ad5f338af4ad09736d8a38a96e45b6d4484adb593615de7c5310b80d"} 05:04:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:04:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:04:24 INFO - Contents: 05:04:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1b08c334f174b463b51bde95031063bfe242d791ffc58f3848a1b98d386cf10ff86cfb585b599e803cf3fbfefc8cdbd431777bfcbb3990286368712b308331", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2685177da45b979c99ab70e206bc3ab80e9a35075e14d143a2146415b1ee75096fb4cfb3ce1125e1546a2fe4c3524ffffb3118e0484de9bfc583956049f2a25b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/970b6c82bcc692eb3f2643d677a1f1641bb5533ee84033bbfa7d44113aa5fcde5bd90ed269831d50015d32e217e094fd071ba792193f95f4728d9ef2f308c001", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/960685aa9da35e4e1a1aa161c33329d1cc383ca5164daab654b4ed33582c107e19194272ad5f338af4ad09736d8a38a96e45b6d4484adb593615de7c5310b80d"} 05:04:24 INFO - Running post-run listener: copy_logs_to_upload_dir 05:04:24 INFO - Copying logs to upload dir... 05:04:24 INFO - mkdir: /builds/slave/test/build/upload/logs 05:04:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.373417 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-16 05:04:24.807095) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-16 05:04:24.810845) ========= 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.glgzxr1qIL/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.ifsKwhdxrV/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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/7a1b08c334f174b463b51bde95031063bfe242d791ffc58f3848a1b98d386cf10ff86cfb585b599e803cf3fbfefc8cdbd431777bfcbb3990286368712b308331", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2685177da45b979c99ab70e206bc3ab80e9a35075e14d143a2146415b1ee75096fb4cfb3ce1125e1546a2fe4c3524ffffb3118e0484de9bfc583956049f2a25b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/970b6c82bcc692eb3f2643d677a1f1641bb5533ee84033bbfa7d44113aa5fcde5bd90ed269831d50015d32e217e094fd071ba792193f95f4728d9ef2f308c001", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/960685aa9da35e4e1a1aa161c33329d1cc383ca5164daab654b4ed33582c107e19194272ad5f338af4ad09736d8a38a96e45b6d4484adb593615de7c5310b80d"} build_url:https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/AqEllv-qSDOHjlD_lGU64Q/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/7a1b08c334f174b463b51bde95031063bfe242d791ffc58f3848a1b98d386cf10ff86cfb585b599e803cf3fbfefc8cdbd431777bfcbb3990286368712b308331", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2685177da45b979c99ab70e206bc3ab80e9a35075e14d143a2146415b1ee75096fb4cfb3ce1125e1546a2fe4c3524ffffb3118e0484de9bfc583956049f2a25b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/970b6c82bcc692eb3f2643d677a1f1641bb5533ee84033bbfa7d44113aa5fcde5bd90ed269831d50015d32e217e094fd071ba792193f95f4728d9ef2f308c001", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/960685aa9da35e4e1a1aa161c33329d1cc383ca5164daab654b4ed33582c107e19194272ad5f338af4ad09736d8a38a96e45b6d4484adb593615de7c5310b80d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-16 05:04:24.846110) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 05:04:24.846490) ========= 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.glgzxr1qIL/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.ifsKwhdxrV/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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.005302 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 05:04:24.895527) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-16 05:04:24.895884) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-16 05:04:24.896333) ========= ========= Total master_lag: 0.18 =========