builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0238 starttime: 1494001354.69 results: success (0) buildid: 20170505080759 builduid: a39b009add9c4f009b469d018c47ddd7 revision: 23fe0b76a018a5077a0f7234cff91c41e4b6af64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 09:22:34.686245) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 09:22:34.686707) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 09:22:34.687014) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 09:22:34.749256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 09:22:34.749700) ========= 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.KPNlouIT63/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.1OzCEjt1du/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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-05-05 09:22:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.20M=0.001s 2017-05-05 09:22:34 (8.20 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129842 ========= master_lag: 1.44 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 09:22:36.321973) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 09:22:36.322309) ========= 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.KPNlouIT63/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.1OzCEjt1du/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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.022424 ========= master_lag: 0.20 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 09:22:36.545614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 09:22:36.546006) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 23fe0b76a018a5077a0f7234cff91c41e4b6af64 --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 23fe0b76a018a5077a0f7234cff91c41e4b6af64 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KPNlouIT63/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.1OzCEjt1du/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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-05-05 09:22:36,638 truncating revision to first 12 chars 2017-05-05 09:22:36,638 Setting DEBUG logging. 2017-05-05 09:22:36,638 attempt 1/10 2017-05-05 09:22:36,638 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/23fe0b76a018?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 09:22:37,273 unpacking tar archive at: mozilla-central-23fe0b76a018/testing/mozharness/ program finished with exit code 0 elapsedTime=0.924105 ========= master_lag: 0.34 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 09:22:37.809030) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 09:22:37.809670) ========= script_repo_revision: 23fe0b76a018a5077a0f7234cff91c41e4b6af64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 09:22:37.810402) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2017-05-05 09:22:37.813897) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2017-05-05 09:22:39.685389) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-05-05 09:22:39.688790) ========= /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.KPNlouIT63/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.1OzCEjt1du/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:22:39 INFO - MultiFileLogger online at 20170505 09:22:39 in /builds/slave/test 09:22:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:22:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:22:39 INFO - {'append_to_log': False, 09:22:39 INFO - 'base_work_dir': '/builds/slave/test', 09:22:39 INFO - 'blob_upload_branch': 'Firefox', 09:22:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:22:39 INFO - 'branch': 'Firefox', 09:22:39 INFO - 'buildbot_json_path': 'buildprops.json', 09:22:39 INFO - 'config_files': ('talos/mac_config.py',), 09:22:39 INFO - 'default_actions': ('clobber', 09:22:39 INFO - 'read-buildbot-config', 09:22:39 INFO - 'download-and-extract', 09:22:39 INFO - 'populate-webroot', 09:22:39 INFO - 'create-virtualenv', 09:22:39 INFO - 'install', 09:22:39 INFO - 'run-tests'), 09:22:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:22:39 INFO - 'download_minidump_stackwalk': True, 09:22:39 INFO - 'download_symbols': 'ondemand', 09:22:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:22:39 INFO - 'tooltool.py': '/tools/tooltool.py', 09:22:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:22:39 INFO - '/tools/misc-python/virtualenv.py')}, 09:22:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:22:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:22:39 INFO - 'gecko_profile': False, 09:22:39 INFO - 'gecko_profile_interval': 0, 09:22:39 INFO - 'installer_path': 'installer.exe', 09:22:39 INFO - 'log_level': 'info', 09:22:39 INFO - 'log_name': 'talos', 09:22:39 INFO - 'log_to_console': True, 09:22:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:22:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:22:39 INFO - 'opt_config_files': (), 09:22:39 INFO - 'pip_index': False, 09:22:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:22:39 INFO - 'cmd': ('bash', 09:22:39 INFO - '-c', 09:22:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:22:39 INFO - 'enabled': True, 09:22:39 INFO - 'halt_on_failure': False, 09:22:39 INFO - 'name': 'check_screen_resolution'},), 09:22:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:22:39 INFO - 'cmd': ('bash', 09:22:39 INFO - '-c', 09:22:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:22:39 INFO - 'enabled': True, 09:22:39 INFO - 'halt_on_failure': False, 09:22:39 INFO - 'name': 'check_screen_resolution'},), 09:22:39 INFO - 'run_cmd_checks_enabled': True, 09:22:39 INFO - 'suite': 'dromaeojs-e10s', 09:22:39 INFO - 'system_bits': '32', 09:22:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:22:39 INFO - 'title': 't-yosemite-r7-0238', 09:22:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:22:39 INFO - 'use_talos_json': True, 09:22:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:22:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:22:39 INFO - 'work_dir': 'build'} 09:22:39 INFO - [mozharness: 2017-05-05 16:22:39.899188Z] Running clobber step. 09:22:39 INFO - Running pre-action listener: _resource_record_pre_action 09:22:39 INFO - Running main action method: clobber 09:22:39 INFO - rmtree: /builds/slave/test/build 09:22:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:22:40 INFO - Running post-action listener: _resource_record_post_action 09:22:40 INFO - [mozharness: 2017-05-05 16:22:40.058039Z] Finished clobber step (success) 09:22:40 INFO - [mozharness: 2017-05-05 16:22:40.058174Z] Running read-buildbot-config step. 09:22:40 INFO - Running pre-action listener: _resource_record_pre_action 09:22:40 INFO - Running main action method: read_buildbot_config 09:22:40 INFO - Using buildbot properties: 09:22:40 INFO - { 09:22:40 INFO - "project": "", 09:22:40 INFO - "product": "firefox", 09:22:40 INFO - "script_repo_revision": "production", 09:22:40 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:22:40 INFO - "repository": "", 09:22:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:22:40 INFO - "buildid": "20170505080759", 09:22:40 INFO - "pgo_build": "False", 09:22:40 INFO - "basedir": "/builds/slave/test", 09:22:40 INFO - "buildnumber": 139, 09:22:40 INFO - "slavename": "t-yosemite-r7-0238", 09:22:40 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:22:40 INFO - "platform": "yosemite_r7", 09:22:40 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:22:40 INFO - "branch": "mozilla-central", 09:22:40 INFO - "repo_path": "mozilla-central", 09:22:40 INFO - "revision": "23fe0b76a018a5077a0f7234cff91c41e4b6af64", 09:22:40 INFO - "stage_platform": "macosx64", 09:22:40 INFO - "builduid": "a39b009add9c4f009b469d018c47ddd7", 09:22:40 INFO - "slavebuilddir": "test" 09:22:40 INFO - } 09:22:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:22:40 INFO - Running post-action listener: _resource_record_post_action 09:22:40 INFO - [mozharness: 2017-05-05 16:22:40.061610Z] Finished read-buildbot-config step (success) 09:22:40 INFO - [mozharness: 2017-05-05 16:22:40.061701Z] Running download-and-extract step. 09:22:40 INFO - Running pre-action listener: _resource_record_pre_action 09:22:40 INFO - Running main action method: download_and_extract 09:22:40 INFO - mkdir: /builds/slave/test/build/tests 09:22: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')]} 09:22:40 INFO - trying https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:22:40 INFO - Downloading https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 09:22:41 INFO - Downloaded 1325 bytes. 09:22:41 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:22:41 INFO - Using the following test package requirements: 09:22:41 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:22:41 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:22:41 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:22:41 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:22:41 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:22:41 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:22:41 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:22:41 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:22:41 INFO - u'jsshell-mac.zip'], 09:22:41 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:22:41 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:22:41 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:22:41 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:22:41 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:22:41 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:22:41 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:22:41 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:22:41 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:22:41 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:22:41 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:22:41 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:22:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:22:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:22:41 INFO - Fetch https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:22:43 INFO - Content-Length response header: 52711877 09:22:43 INFO - Bytes received: 52711877 09:22:59 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:22:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:22:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:22:59 INFO - Fetch https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:23:01 INFO - Content-Length response header: 52711877 09:23:01 INFO - Bytes received: 52711877 09:23:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:23:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:23:17 INFO - Fetch https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:23:17 INFO - Content-Length response header: 14408697 09:23:17 INFO - Bytes received: 14408697 09:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:18 INFO - trying https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:23:18 INFO - Downloading https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:23:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 09:23:20 INFO - Downloaded 70886158 bytes. 09:23:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:23:20 INFO - mkdir: /builds/slave/test/properties 09:23:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:23:20 INFO - Writing to file /builds/slave/test/properties/build_url 09:23:20 INFO - Contents: 09:23:20 INFO - build_url:https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:23:20 INFO - Running post-action listener: _resource_record_post_action 09:23:20 INFO - Running post-action listener: set_extra_try_arguments 09:23:20 INFO - [mozharness: 2017-05-05 16:23:20.897603Z] Finished download-and-extract step (success) 09:23:20 INFO - [mozharness: 2017-05-05 16:23:20.897701Z] Running populate-webroot step. 09:23:20 INFO - Running pre-action listener: _resource_record_pre_action 09:23:20 INFO - Running main action method: populate_webroot 09:23:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:23:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:23:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:23:20 INFO - '--tppagecycles', 09:23:20 INFO - '7'], 09:23:20 INFO - 'tests': ['tsvgm']}}, 09:23:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:23:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:23:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:23:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:23:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:23:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:23:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:23:20 INFO - 'talos_options': ['--disable-e10s'], 09:23:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:23:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:23:20 INFO - 'talos_options': ['--disable-e10s'], 09:23:20 INFO - 'tests': ['damp', 'tps']}, 09:23:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:23:20 INFO - 'tests': ['damp', 'tps']}, 09:23:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:23:20 INFO - 'tests': ['dromaeo_dom']}, 09:23:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:23:20 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:23:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:23:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:23:20 INFO - 'tests': ['a11yr', 09:23:20 INFO - 'ts_paint', 09:23:20 INFO - 'tpaint', 09:23:20 INFO - 'sessionrestore', 09:23:20 INFO - 'sessionrestore_no_auto_restore', 09:23:20 INFO - 'tabpaint']}, 09:23:20 INFO - 'other-e10s': {'tests': ['a11yr', 09:23:20 INFO - 'ts_paint', 09:23:20 INFO - 'tpaint', 09:23:20 INFO - 'sessionrestore', 09:23:20 INFO - 'sessionrestore_no_auto_restore', 09:23:20 INFO - 'tabpaint']}, 09:23:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:23:20 INFO - 'ts_paint', 09:23:20 INFO - 'tpaint', 09:23:20 INFO - 'sessionrestore', 09:23:20 INFO - 'sessionrestore_no_auto_restore', 09:23:20 INFO - 'tabpaint']}, 09:23:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:23:20 INFO - 'ts_paint', 09:23:20 INFO - 'tpaint', 09:23:20 INFO - 'sessionrestore', 09:23:20 INFO - 'sessionrestore_no_auto_restore', 09:23:20 INFO - 'tabpaint']}, 09:23:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:23:20 INFO - 'tests': ['a11yr', 09:23:20 INFO - 'ts_paint', 09:23:20 INFO - 'tpaint', 09:23:20 INFO - 'sessionrestore', 09:23:20 INFO - 'sessionrestore_no_auto_restore', 09:23:20 INFO - 'tabpaint']}, 09:23:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:23:20 INFO - 'tests': ['a11yr', 09:23:20 INFO - 'ts_paint', 09:23:20 INFO - 'tpaint', 09:23:20 INFO - 'sessionrestore', 09:23:20 INFO - 'sessionrestore_no_auto_restore', 09:23:20 INFO - 'tabpaint']}, 09:23:20 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:23:20 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:23:20 INFO - 'bloom_basic_ref']}, 09:23:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:23:20 INFO - 'tests': ['tsvgx', 09:23:20 INFO - 'tsvgr_opacity', 09:23:20 INFO - 'tart', 09:23:20 INFO - 'tscrollx', 09:23:20 INFO - 'cart', 09:23:20 INFO - 'tsvg_static']}, 09:23:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:23:20 INFO - 'tsvgr_opacity', 09:23:20 INFO - 'tart', 09:23:20 INFO - 'tscrollx', 09:23:20 INFO - 'cart', 09:23:20 INFO - 'tsvg_static']}, 09:23:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:23:20 INFO - 'talos_options': ['--disable-e10s'], 09:23:20 INFO - 'tests': ['tp5o']}, 09:23:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:23:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:23:20 INFO - 'talos_options': ['--disable-e10s', 09:23:20 INFO - '--xperf_path', 09:23:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:20 INFO - 'tests': ['tp5n']}, 09:23:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:23:20 INFO - 'talos_options': ['--xperf_path', 09:23:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:20 INFO - 'tests': ['tp5n']}}, 09:23:20 INFO - 'talos.zip': {'path': '', 09:23:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:23:20 INFO - Running post-action listener: _resource_record_post_action 09:23:20 INFO - [mozharness: 2017-05-05 16:23:20.917069Z] Finished populate-webroot step (success) 09:23:20 INFO - [mozharness: 2017-05-05 16:23:20.917172Z] Running create-virtualenv step. 09:23:20 INFO - Running pre-action listener: _resource_record_pre_action 09:23:20 INFO - Running main action method: create_virtualenv 09:23:20 INFO - Creating virtualenv /builds/slave/test/build/venv 09:23:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:23:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:23:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:21 INFO - Using real prefix '/tools/python27' 09:23:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:21 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:24 INFO - Installing pip.................done. 09:23:24 INFO - Return code: 0 09:23:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:23:24 INFO - Reading from file tmpfile_stdout 09:23:24 INFO - Output received: 09:23:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:23:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:25 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 0x108477b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd43460ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108255d30>, '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 0x10817bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824abe8>, '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.KPNlouIT63/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.1OzCEjt1du/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:23:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:23:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KPNlouIT63/Render', 09:23:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:25 INFO - 'HOME': '/Users/cltbld', 09:23:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:25 INFO - 'LOGNAME': 'cltbld', 09:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:25 INFO - 'MOZ_NO_REMOTE': '1', 09:23:25 INFO - 'NO_EM_RESTART': '1', 09:23:25 INFO - 'PAGER': '/bin/cat', 09:23:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:25 INFO - 'PWD': '/builds/slave/test', 09:23:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:25 INFO - 'SHELL': '/bin/bash', 09:23:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1OzCEjt1du/Listeners', 09:23:25 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 09:23:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:25 INFO - 'USER': 'cltbld', 09:23:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:25 INFO - 'XPC_FLAGS': '0x0', 09:23:25 INFO - 'XPC_SERVICE_NAME': '0', 09:23:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:23:26 INFO - Cleaning up... 09:23:26 INFO - Return code: 0 09:23:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:26 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 0x108477b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd43460ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108255d30>, '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 0x10817bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824abe8>, '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.KPNlouIT63/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.1OzCEjt1du/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:23:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:23:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KPNlouIT63/Render', 09:23:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:26 INFO - 'HOME': '/Users/cltbld', 09:23:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:26 INFO - 'LOGNAME': 'cltbld', 09:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:26 INFO - 'MOZ_NO_REMOTE': '1', 09:23:26 INFO - 'NO_EM_RESTART': '1', 09:23:26 INFO - 'PAGER': '/bin/cat', 09:23:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:26 INFO - 'PWD': '/builds/slave/test', 09:23:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:26 INFO - 'SHELL': '/bin/bash', 09:23:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1OzCEjt1du/Listeners', 09:23:26 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 09:23:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:26 INFO - 'USER': 'cltbld', 09:23:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:26 INFO - 'XPC_FLAGS': '0x0', 09:23:26 INFO - 'XPC_SERVICE_NAME': '0', 09:23:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:26 INFO - Downloading/unpacking psutil>=3.1.1 09:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:23:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:30 INFO - Installing collected packages: psutil 09:23:30 INFO - Running setup.py install for psutil 09:23:30 INFO - building 'psutil._psutil_osx' extension 09:23:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:23:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:23:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:23:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:23:31 INFO - building 'psutil._psutil_posix' extension 09:23:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:23:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:23:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:23:31 INFO - ^ 09:23:31 INFO - 1 warning generated. 09:23:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:23:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:31 INFO - Successfully installed psutil 09:23:31 INFO - Cleaning up... 09:23:31 INFO - Return code: 0 09:23:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:31 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 0x108477b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd43460ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108255d30>, '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 0x10817bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824abe8>, '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.KPNlouIT63/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.1OzCEjt1du/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:23:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:23:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KPNlouIT63/Render', 09:23:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:31 INFO - 'HOME': '/Users/cltbld', 09:23:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:31 INFO - 'LOGNAME': 'cltbld', 09:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:31 INFO - 'MOZ_NO_REMOTE': '1', 09:23:31 INFO - 'NO_EM_RESTART': '1', 09:23:31 INFO - 'PAGER': '/bin/cat', 09:23:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:31 INFO - 'PWD': '/builds/slave/test', 09:23:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:31 INFO - 'SHELL': '/bin/bash', 09:23:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1OzCEjt1du/Listeners', 09:23:31 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 09:23:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:31 INFO - 'USER': 'cltbld', 09:23:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:31 INFO - 'XPC_FLAGS': '0x0', 09:23:31 INFO - 'XPC_SERVICE_NAME': '0', 09:23:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:23:33 INFO - Installing collected packages: mozsystemmonitor 09:23:33 INFO - Running setup.py install for mozsystemmonitor 09:23:33 INFO - Successfully installed mozsystemmonitor 09:23:33 INFO - Cleaning up... 09:23:33 INFO - Return code: 0 09:23:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108477b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd43460ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108255d30>, '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 0x10817bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824abe8>, '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.KPNlouIT63/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.1OzCEjt1du/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:23:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KPNlouIT63/Render', 09:23:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:33 INFO - 'HOME': '/Users/cltbld', 09:23:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:33 INFO - 'LOGNAME': 'cltbld', 09:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:33 INFO - 'MOZ_NO_REMOTE': '1', 09:23:33 INFO - 'NO_EM_RESTART': '1', 09:23:33 INFO - 'PAGER': '/bin/cat', 09:23:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:33 INFO - 'PWD': '/builds/slave/test', 09:23:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:33 INFO - 'SHELL': '/bin/bash', 09:23:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1OzCEjt1du/Listeners', 09:23:33 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 09:23:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:33 INFO - 'USER': 'cltbld', 09:23:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:33 INFO - 'XPC_FLAGS': '0x0', 09:23:33 INFO - 'XPC_SERVICE_NAME': '0', 09:23:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:33 INFO - Downloading/unpacking jsonschema==2.5.1 09:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:23:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:35 INFO - Downloading functools32-3.2.3-2.tar.gz 09:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:23:35 INFO - warning: no files found matching '*.txt' 09:23:35 INFO - no previously-included directories found matching 'build' 09:23:35 INFO - no previously-included directories found matching 'dist' 09:23:35 INFO - no previously-included directories found matching '.git*' 09:23:35 INFO - Installing collected packages: jsonschema, functools32 09:23:35 INFO - Running setup.py install for functools32 09:23:35 INFO - warning: no files found matching '*.txt' 09:23:35 INFO - no previously-included directories found matching 'build' 09:23:35 INFO - no previously-included directories found matching 'dist' 09:23:35 INFO - no previously-included directories found matching '.git*' 09:23:35 INFO - Successfully installed jsonschema functools32 09:23:35 INFO - Cleaning up... 09:23:35 INFO - Return code: 0 09:23:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:35 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 0x108477b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd43460ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108255d30>, '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 0x10817bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824abe8>, '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.KPNlouIT63/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.1OzCEjt1du/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:23:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:23:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KPNlouIT63/Render', 09:23:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:35 INFO - 'HOME': '/Users/cltbld', 09:23:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:35 INFO - 'LOGNAME': 'cltbld', 09:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:35 INFO - 'MOZ_NO_REMOTE': '1', 09:23:35 INFO - 'NO_EM_RESTART': '1', 09:23:35 INFO - 'PAGER': '/bin/cat', 09:23:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:35 INFO - 'PWD': '/builds/slave/test', 09:23:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:35 INFO - 'SHELL': '/bin/bash', 09:23:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1OzCEjt1du/Listeners', 09:23:35 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 09:23:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:35 INFO - 'USER': 'cltbld', 09:23:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:35 INFO - 'XPC_FLAGS': '0x0', 09:23:35 INFO - 'XPC_SERVICE_NAME': '0', 09:23:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:23:35 INFO - Cleaning up... 09:23:35 INFO - Return code: 0 09:23:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:35 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 0x108477b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd43460ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108255d30>, '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 0x10817bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824abe8>, '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.KPNlouIT63/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.1OzCEjt1du/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:23:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:23:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KPNlouIT63/Render', 09:23:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:35 INFO - 'HOME': '/Users/cltbld', 09:23:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:35 INFO - 'LOGNAME': 'cltbld', 09:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:35 INFO - 'MOZ_NO_REMOTE': '1', 09:23:35 INFO - 'NO_EM_RESTART': '1', 09:23:35 INFO - 'PAGER': '/bin/cat', 09:23:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:35 INFO - 'PWD': '/builds/slave/test', 09:23:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:35 INFO - 'SHELL': '/bin/bash', 09:23:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1OzCEjt1du/Listeners', 09:23:35 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 09:23:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:35 INFO - 'USER': 'cltbld', 09:23:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:35 INFO - 'XPC_FLAGS': '0x0', 09:23:35 INFO - 'XPC_SERVICE_NAME': '0', 09:23:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:36 INFO - Downloading/unpacking blobuploader==1.2.4 09:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:37 INFO - Downloading blobuploader-1.2.4.tar.gz 09:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:23:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:23:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:38 INFO - Downloading docopt-0.6.1.tar.gz 09:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:23:38 INFO - Installing collected packages: blobuploader, requests, docopt 09:23:38 INFO - Running setup.py install for blobuploader 09:23:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:23:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:23:38 INFO - Running setup.py install for requests 09:23:39 INFO - Running setup.py install for docopt 09:23:39 INFO - Successfully installed blobuploader requests docopt 09:23:39 INFO - Cleaning up... 09:23:39 INFO - Return code: 0 09:23:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:39 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 0x108477b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd43460ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108255d30>, '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 0x10817bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824abe8>, '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.KPNlouIT63/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.1OzCEjt1du/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:23:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:23:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:23:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KPNlouIT63/Render', 09:23:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:39 INFO - 'HOME': '/Users/cltbld', 09:23:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:39 INFO - 'LOGNAME': 'cltbld', 09:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:39 INFO - 'MOZ_NO_REMOTE': '1', 09:23:39 INFO - 'NO_EM_RESTART': '1', 09:23:39 INFO - 'PAGER': '/bin/cat', 09:23:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:39 INFO - 'PWD': '/builds/slave/test', 09:23:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:39 INFO - 'SHELL': '/bin/bash', 09:23:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1OzCEjt1du/Listeners', 09:23:39 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 09:23:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:39 INFO - 'USER': 'cltbld', 09:23:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:39 INFO - 'XPC_FLAGS': '0x0', 09:23:39 INFO - 'XPC_SERVICE_NAME': '0', 09:23:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:39 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-GUlfrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:39 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-2nyJYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:39 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-XGRvET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:39 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-NEa0iW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:39 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-INwWjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-MzEWEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-sy6xj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-JyLUOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-2Oq5Ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-sevRUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-BiwYOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-w9wNCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-oW2_kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Z5EsOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-GYj5PH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-AWHi95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-yvqzC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:23:41 INFO - Running setup.py install for manifestparser 09:23:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:23:41 INFO - Running setup.py install for mozcrash 09:23:41 INFO - Running setup.py install for mozdebug 09:23:41 INFO - Running setup.py install for mozdevice 09:23:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:23:41 INFO - Running setup.py install for mozfile 09:23:41 INFO - Running setup.py install for mozhttpd 09:23:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:23:42 INFO - Running setup.py install for mozinfo 09:23:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:23:42 INFO - Running setup.py install for mozInstall 09:23:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:23:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:23:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:23:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:23:42 INFO - Running setup.py install for mozleak 09:23:42 INFO - Running setup.py install for mozlog 09:23:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:23:42 INFO - Running setup.py install for moznetwork 09:23:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:23:42 INFO - Running setup.py install for mozprocess 09:23:43 INFO - Running setup.py install for mozprofile 09:23:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:23:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:23:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:23:43 INFO - Running setup.py install for mozrunner 09:23:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:23:43 INFO - Running setup.py install for mozscreenshot 09:23:43 INFO - Running setup.py install for moztest 09:23:43 INFO - Running setup.py install for mozversion 09:23:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:23:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:23:43 INFO - Cleaning up... 09:23:43 INFO - Return code: 0 09:23:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:43 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 0x108477b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd43460ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108255d30>, '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 0x10817bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824abe8>, '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.KPNlouIT63/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.1OzCEjt1du/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:23:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KPNlouIT63/Render', 09:23:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:43 INFO - 'HOME': '/Users/cltbld', 09:23:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:43 INFO - 'LOGNAME': 'cltbld', 09:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:43 INFO - 'MOZ_NO_REMOTE': '1', 09:23:43 INFO - 'NO_EM_RESTART': '1', 09:23:43 INFO - 'PAGER': '/bin/cat', 09:23:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:43 INFO - 'PWD': '/builds/slave/test', 09:23:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:43 INFO - 'SHELL': '/bin/bash', 09:23:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1OzCEjt1du/Listeners', 09:23:43 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 09:23:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:43 INFO - 'USER': 'cltbld', 09:23:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:43 INFO - 'XPC_FLAGS': '0x0', 09:23:43 INFO - 'XPC_SERVICE_NAME': '0', 09:23:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:44 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-vgNQtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:44 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-hK8r5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:44 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-f9bdTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:44 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-yZbjPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:44 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-dyebZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:44 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Eeh93b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:44 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-bJWKTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:44 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-UnvyZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:44 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-6UeyJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-E0Shau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-zGj1wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-wdrV_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-1yBvFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-B9_2ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-025A6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-oQXpk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Mu5ETq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:23:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:47 INFO - Downloading blessings-1.6.tar.gz 09:23:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:23:47 INFO - Installing collected packages: blessings 09:23:47 INFO - Running setup.py install for blessings 09:23:47 INFO - Successfully installed blessings 09:23:47 INFO - Cleaning up... 09:23:47 INFO - Return code: 0 09:23:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:23:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:47 INFO - Reading from file tmpfile_stdout 09:23:47 INFO - Current package versions: 09:23:47 INFO - blessings == 1.6 09:23:47 INFO - blobuploader == 1.2.4 09:23:47 INFO - docopt == 0.6.1 09:23:47 INFO - functools32 == 3.2.3-2 09:23:47 INFO - jsonschema == 2.5.1 09:23:47 INFO - manifestparser == 1.1 09:23:47 INFO - mozInstall == 1.12 09:23:47 INFO - mozcrash == 1.0 09:23:47 INFO - mozdebug == 0.1 09:23:47 INFO - mozdevice == 0.50 09:23:47 INFO - mozfile == 1.2 09:23:47 INFO - mozhttpd == 0.7 09:23:47 INFO - mozinfo == 0.9 09:23:47 INFO - mozleak == 0.1 09:23:47 INFO - mozlog == 3.4 09:23:47 INFO - moznetwork == 0.27 09:23:47 INFO - mozprocess == 0.25 09:23:47 INFO - mozprofile == 0.28 09:23:47 INFO - mozrunner == 6.13 09:23:47 INFO - mozscreenshot == 0.1 09:23:47 INFO - mozsystemmonitor == 0.3 09:23:47 INFO - moztest == 0.8 09:23:47 INFO - mozversion == 1.4 09:23:47 INFO - psutil == 3.1.1 09:23:47 INFO - requests == 1.2.3 09:23:47 INFO - wsgiref == 0.1.2 09:23:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:47 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 0x108477b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd43460ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108255d30>, '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 0x10817bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824abe8>, '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.KPNlouIT63/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.1OzCEjt1du/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:23:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KPNlouIT63/Render', 09:23:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:47 INFO - 'HOME': '/Users/cltbld', 09:23:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:47 INFO - 'LOGNAME': 'cltbld', 09:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:47 INFO - 'MOZ_NO_REMOTE': '1', 09:23:47 INFO - 'NO_EM_RESTART': '1', 09:23:47 INFO - 'PAGER': '/bin/cat', 09:23:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:47 INFO - 'PWD': '/builds/slave/test', 09:23:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:47 INFO - 'SHELL': '/bin/bash', 09:23:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1OzCEjt1du/Listeners', 09:23:47 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 09:23:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:47 INFO - 'USER': 'cltbld', 09:23:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:47 INFO - 'XPC_FLAGS': '0x0', 09:23:47 INFO - 'XPC_SERVICE_NAME': '0', 09:23:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:23:48 INFO - Cleaning up... 09:23:48 INFO - Return code: 0 09:23:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108477b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10847a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd43460ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108255d30>, '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 0x10817bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824abe8>, '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.KPNlouIT63/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.1OzCEjt1du/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:23:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:23:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KPNlouIT63/Render', 09:23:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:48 INFO - 'HOME': '/Users/cltbld', 09:23:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:48 INFO - 'LOGNAME': 'cltbld', 09:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:48 INFO - 'MOZ_NO_REMOTE': '1', 09:23:48 INFO - 'NO_EM_RESTART': '1', 09:23:48 INFO - 'PAGER': '/bin/cat', 09:23:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:48 INFO - 'PWD': '/builds/slave/test', 09:23:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:48 INFO - 'SHELL': '/bin/bash', 09:23:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1OzCEjt1du/Listeners', 09:23:48 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 09:23:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:48 INFO - 'USER': 'cltbld', 09:23:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:48 INFO - 'XPC_FLAGS': '0x0', 09:23:48 INFO - 'XPC_SERVICE_NAME': '0', 09:23:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:23:48 INFO - Cleaning up... 09:23:48 INFO - Return code: 0 09:23:48 INFO - Running post-action listener: _resource_record_post_action 09:23:48 INFO - Running post-action listener: _start_resource_monitoring 09:23:48 INFO - Starting resource monitoring. 09:23:48 INFO - [mozharness: 2017-05-05 16:23:48.396922Z] Finished create-virtualenv step (success) 09:23:48 INFO - [mozharness: 2017-05-05 16:23:48.397822Z] Running install step. 09:23:48 INFO - Running pre-action listener: _resource_record_pre_action 09:23:48 INFO - Running main action method: install 09:23:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:48 INFO - Reading from file tmpfile_stdout 09:23:48 INFO - Detecting whether we're running mozinstall >=1.0... 09:23:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:23:48 INFO - Reading from file tmpfile_stdout 09:23:48 INFO - Output received: 09:23:48 INFO - Usage: mozinstall [options] installer 09:23:48 INFO - Options: 09:23:48 INFO - -h, --help show this help message and exit 09:23:48 INFO - -d DEST, --destination=DEST 09:23:48 INFO - Directory to install application into. [default: 09:23:48 INFO - "/builds/slave/test"] 09:23:48 INFO - --app=APP Application being installed. [default: firefox] 09:23:48 INFO - mkdir: /builds/slave/test/build/application 09:23:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:24:08 INFO - Reading from file tmpfile_stdout 09:24:08 INFO - Output received: 09:24:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:24:08 INFO - Running post-action listener: _resource_record_post_action 09:24:08 INFO - [mozharness: 2017-05-05 16:24:08.445467Z] Finished install step (success) 09:24:08 INFO - [mozharness: 2017-05-05 16:24:08.445602Z] Running run-tests step. 09:24:08 INFO - Running pre-action listener: _resource_record_pre_action 09:24:08 INFO - Running main action method: run_tests 09:24:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:24:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:24:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:24:08 INFO - 2017-05-05 09:24:08.460 screenresolution[1881:9037] starting screenresolution argv=screenresolution get 09:24:08 INFO - 2017-05-05 09:24:08.463 screenresolution[1881:9037] Display 0: 1600x1200x32@60 09:24:08 INFO - 2017-05-05 09:24:08.468 screenresolution[1882:9039] starting screenresolution argv=screenresolution list 09:24:08 INFO - Available Modes on Display 0 09:24:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:24:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:24:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:24:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:24:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:24:08 INFO - Intel Iris: 09:24:08 INFO - Chipset Model: Intel Iris 09:24:08 INFO - Type: GPU 09:24:08 INFO - Bus: Built-In 09:24:08 INFO - VRAM (Dynamic, Max): 1536 MB 09:24:08 INFO - Vendor: Intel (0x8086) 09:24:08 INFO - Device ID: 0x0a2e 09:24:08 INFO - Revision ID: 0x0009 09:24:08 INFO - Displays: 09:24:08 INFO - Display: 09:24:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:24:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:24:08 INFO - Display Serial Number: 1600x1200 60 09:24:08 INFO - Main Display: Yes 09:24:08 INFO - Mirror: Off 09:24:08 INFO - Online: Yes 09:24:08 INFO - Rotation: Supported 09:24:08 INFO - Return code: 0 09:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:24:08 INFO - Python 2.7.3 09:24:08 INFO - Return code: 0 09:24:08 INFO - grabbing minidump binary from tooltool 09:24: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')]} 09:24:08 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 0x108255d30>, '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 0x10817bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10824abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:24:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:24:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:24:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:24:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:24:08 INFO - Return code: 0 09:24:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:24:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:24:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:24:08 INFO - ENV: RUST_BACKTRACE is now 1 09:24:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:24:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0238', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0238 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:24:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KPNlouIT63/Render', 09:24:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:08 INFO - 'HOME': '/Users/cltbld', 09:24:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:08 INFO - 'LOGNAME': 'cltbld', 09:24:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:24:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:08 INFO - 'MOZ_NO_REMOTE': '1', 09:24:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:24:08 INFO - 'NO_EM_RESTART': '1', 09:24:08 INFO - 'PAGER': '/bin/cat', 09:24:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:08 INFO - 'PWD': '/builds/slave/test', 09:24:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:24:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:08 INFO - 'RUST_BACKTRACE': '1', 09:24:08 INFO - 'SHELL': '/bin/bash', 09:24:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1OzCEjt1du/Listeners', 09:24:08 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 09:24:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:08 INFO - 'USER': 'cltbld', 09:24:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:08 INFO - 'XPC_FLAGS': '0x0', 09:24:08 INFO - 'XPC_SERVICE_NAME': '0', 09:24:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0238', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:24:09 INFO - mozversion application_buildid: 20170505080759 09:24:09 INFO - mozversion application_changeset: 23fe0b76a018a5077a0f7234cff91c41e4b6af64 09:24:09 INFO - mozversion application_display_name: Nightly 09:24:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:24:09 INFO - mozversion application_name: Firefox 09:24:09 INFO - mozversion application_remotingname: firefox 09:24:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:24:09 INFO - mozversion application_vendor: Mozilla 09:24:09 INFO - mozversion application_version: 55.0a1 09:24:09 INFO - mozversion platform_buildid: 20170505080759 09:24:09 INFO - mozversion platform_changeset: 23fe0b76a018a5077a0f7234cff91c41e4b6af64 09:24:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:24:09 INFO - mozversion platform_version: 55.0a1 09:24:09 INFO - using testdate: 1494001449 09:24:09 INFO - actual date: 1494001449 09:24:09 INFO - starting webserver on 'localhost:49386' 09:24:09 INFO - SUITE-START | Running 2 tests 09:24:09 INFO - TEST-START | dromaeo_css 09:24:09 INFO - operating with platform_type : mac_ 09:24:09 INFO - Initialising browser for dromaeo_css test... 09:24:09 INFO - TEST-INFO | started process 1892 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpx0dfZB/profile http://localhost:49386/getInfo.html) 09:24:11 INFO - PID 1892 | 2017-05-05 09:24:11.644 plugin-container[1894:9198] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9b4b, name = 'com.apple.tsm.portname' 09:24:11 INFO - PID 1892 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:24:11 INFO - PID 1892 | 2017-05-05 09:24:11.648 plugin-container[1894:9198] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x480f, name = 'com.apple.CFPasteboardClient' 09:24:11 INFO - PID 1892 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:24:11 INFO - PID 1892 | 2017-05-05 09:24:11.648 plugin-container[1894:9198] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:24:11 INFO - PID 1892 | __metrics Screen width/height:1600/1200 09:24:11 INFO - PID 1892 | colorDepth:24 09:24:11 INFO - PID 1892 | Browser inner width/height: 1024/691 09:24:11 INFO - PID 1892 | __metrics 09:24:12 INFO - TEST-INFO | 1892: exit 0 09:24:12 INFO - Browser initialized. 09:24:12 INFO - Running cycle 1/1 for dromaeo_css test... 09:24:12 INFO - TEST-INFO | started process 1895 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpx0dfZB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:15 INFO - PID 1895 | 2017-05-05 09:24:15.258 plugin-container[1896:9332] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9243, name = 'com.apple.tsm.portname' 09:24:15 INFO - PID 1895 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:24:15 INFO - PID 1895 | 2017-05-05 09:24:15.259 plugin-container[1896:9332] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9917, name = 'com.apple.CFPasteboardClient' 09:24:15 INFO - PID 1895 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:24:15 INFO - PID 1895 | 2017-05-05 09:24:15.259 plugin-container[1896:9332] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:24:15 INFO - PID 1895 | 2017-05-05 09:24:15.656 plugin-container[1897:9378] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 09:24:15 INFO - PID 1895 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:24:15 INFO - PID 1895 | 2017-05-05 09:24:15.656 plugin-container[1897:9378] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9903, name = 'com.apple.CFPasteboardClient' 09:24:15 INFO - PID 1895 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:24:15 INFO - PID 1895 | 2017-05-05 09:24:15.656 plugin-container[1897:9378] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:24:25 INFO - PID 1895 | RSS: Main: 250048512 09:24:25 INFO - PID 1895 | 09:27:28 INFO - PID 1895 | Cycle 1(1): loaded http://localhost:49386/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49386/tests/dromaeo/cssquery-ext.html) 09:27:30 INFO - PID 1895 | RSS: Main: 252895232 09:27:30 INFO - PID 1895 | 09:30:32 INFO - PID 1895 | Cycle 1(1): loaded http://localhost:49386/tests/dromaeo/cssquery-ext.html (next: http://localhost:49386/tests/dromaeo/cssquery-jquery.html) 09:30:33 INFO - PID 1895 | RSS: Main: 256360448 09:30:33 INFO - PID 1895 | 09:33:35 INFO - PID 1895 | Cycle 1(1): loaded http://localhost:49386/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49386/tests/dromaeo/cssquery-mootools.html) 09:33:36 INFO - PID 1895 | RSS: Main: 266289152 09:33:36 INFO - PID 1895 | 09:36:37 INFO - PID 1895 | Cycle 1(1): loaded http://localhost:49386/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49386/tests/dromaeo/cssquery-prototype.html) 09:36:38 INFO - PID 1895 | RSS: Main: 260845568 09:36:38 INFO - PID 1895 | 09:39:41 INFO - PID 1895 | Cycle 1(1): loaded http://localhost:49386/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49386/tests/dromaeo/cssquery-yui.html) 09:39:41 INFO - PID 1895 | RSS: Main: 265953280 09:39:41 INFO - PID 1895 | 09:42:43 INFO - PID 1895 | Cycle 1(1): loaded http://localhost:49386/tests/dromaeo/cssquery-yui.html (next: http://localhost:49386/tests/dromaeo/cssquery-dojo.html) 09:42:43 INFO - PID 1895 | RSS: Main: 270684160 09:42:43 INFO - PID 1895 | 09:42:43 INFO - PID 1895 | __start_tp_report 09:42:43 INFO - PID 1895 | _x_x_mozilla_page_load 09:42:43 INFO - PID 1895 | _x_x_mozilla_page_load_details 09:42:43 INFO - PID 1895 | |i|pagename|runs| 09:42:43 INFO - PID 1895 | |0;dojo.html;3327.4343361628535;3557.772568463879;3619.89593174082;3660.4875317455553;3702.2040261343805;5434.212039254306;5721.542276617871;5924.407559244079;6216.502679785618;6350.491960643149;6229.252489701231;6284.685765711708;6304.71628776705;6352.333005034474;6394.360563943604;5529.060059789826;5547;5574.888502229953;5577.386487486373;5665.631733937302;5606.439356064402;5742.253507044078;5747.741351639165;5756.194132821408;5764.106563482667;5462.426445223234;5534.446555344473;5583.246261754652;5614.466625670555;5714.771409143629;5534.778608855681;5541.085720856054;5546.4453554644215;5553.028220061473;5612.102063669793;5558.722063896789;5584.190292407578;5603.019471592495;5616.859578510529;5626.212330273765;6126.17296664949;6363.668011080196;6400.007998760199;6421.261554921197;6442.838929026765;6578.243501997236;6789.796306110825;6863.794086177422;6864.656767161622;6888.380045795902;6748.392644662004;6833.487488438337;6903.275156108637;6915.51591388603;6928.72285108595;6426.742930282736;6456.870862582722;6476.579022363531;6492.935070649328;6494.642794646245;7057.294270573005;7086.822829429202;7130.073090498202;7130.821729456805;7173.318534739192;5747.540196784331;6450.645214513153;6569.507286953498;6727.226368967631;6759.5606285591275;5224.50367215114;5722.37053924068;5787.681677507778;6924.792256232321;6942.826429339206;6769.22153952292;6781.423578995742;6853.965730171417;6857.5199736018;6880.174379074543;6580.078788969548;6636.303188165173;6708.731650734014;6803.965980170067;6849.2465828758795;5413.593980451482;5421.674699518042;5433.9947109784025;5435.755391007414;5471.945280547223;4750.857474275708;4839.41926968759;4841.2496063110275;4865.197242454955;4873;5637.3235211774845;6030.48740857032;6198;6355.555111142268;6383.329750376237;5818.301803783573;6916.23921368649;6924.099867017256;6948.965255173793;6983;6421.3578642136345;6439.935600643934;6450.6774661266745;6453.806385808433;6487.870242595121;5836.854078648068;5945.672987985702;6036.15493830864;6082.787102451482;6121.938780612226;6935.375816176568;6954.895676564855;7034.964825175842;7037.26108758573;7119.2168861426235;6673.799786006428;6928.203256625351;6931.549449285781;6945.444364450731;6966;6883.862322753617;6959.26927672587;7048.8590228194125;7153.964230178815;7166.820829479305;5143.71709555978;5730.799422020209;6847.48643851723;6851.314868513109;6868.278830722902;6583.901241481477;6647.169103862017;6773.6951837168435;6986.720531178899;6999.230084690782;6642.6014439133805;6643.335666433318;6685.699143538455;6693.698783554849;6725.125733654593;5584.329880414376;6737.528373014038;6737.966310168418;6741.764038258638;6760.560563563353;5618.381977982501;5664.008798460335;6489;6589.0116482528;6626.304238054935;6466.773662921775;6566.343365663395;6589.505787065893;6662.467002639681;6688.799336019927;6577.671116444063;6588.209414870246;6588.374104460068;6602.471802255904;6615.040819081302 09:42:43 INFO - PID 1895 | |1;ext.html;732.136079426277;827.8427098851217;1037.6264544763878;1103.9227254092216;1261.5647601577452;36419.08952276195;37375.06562335943;37507.24985500292;37522.06194845127;37634;37224.441633375456;37505.81247093768;37584.62415375846;37748.2814648169;37803;7841.803954901116;7995.600219989006;8343.249107580317;8609.698660546883;8611.224989750921;8578.270846978014;8635.913640863573;8697.260732837716;8713.259372953275;8731.738047858575;8671.869921951176;8721.171488708595;8741.650333986632;8742.082081381459;8768.824623507558;8658;8660.00409952854;8704.434211776246;8726.301895848317;8729.956350218272;8487.830243395098;8493.872591911126;8544.61549230286;8548.358873084544;8559.229669329728;37756;38003.23993520114;38033.62613299478;38096;38250.61749382498;3698.8705395311304;3701.907452313687;3713.1830997180577;3718.7954662493553;3734.290484807878;30631.621577029087;30991.22521936947;31143;31209;31352.21619459509;3162.6362968258713;3191.952120718191;3200.9199770005703;3204.150900011499;3206.7113959743733;249369;251506;252170.73914630493;252260.38698065022;253170;46778.06443871104;49121.50878491241;49355;49464.25803612949;49611;51272;51419.45741627757;51482.742586287575;51544.48455515472;51722;14529.927350363181;14536.781948270784;14586.416543338148;14627.488037918622;14628.19544925018;11466.54133834654;11714.297142171497;11718.88281117178;11719.12106592009;11838.230515016496;13401.659834016715;13523.729525409437;13553.661158471117;13555.525556605471;13638.454461821417;5230.267762513251;5642.689652069175;5840.2991641003355;5887.852803679943;5912.23140991677;1061.3419679798574;1076.9299995500423;1079.09895237476;1081.194510089988;1111.5276007696696;20856.79143208579;21252.681209781866;21712.674309885366;24933.50132997366;24994.500109997698;1156.525824411987;1163.4182908545727;1204.987950120505;1205.3611585859333;1206.77071356442;9939.55272012761;11032.889671103347;11383.804700506493;11852.525898964117;12009.459574319177;288660;326620;331483.3425832855;337155;337632;54989;55271.72364138234;55383.169252461244;55441.44558554443;55526.16710749342;1547.6904619076004;1554.0753251815152;1584.6038490377405;1586.9841301587066;1610.4041504643124;20341.898290508452;24136.517269654156;24486;24770.50458990846;24811.627825582993;33955.49066763951;37244.25511489809;39216.21567568689;39261.62584309535;39314.60685393224;270649;271075;271447;271861;273443;35178.00986916141;35635.46546801852;35878;36791.26417471689;36835;44925.55074449344;45673.086538269716;46470.53529464662;46540.7672961633;46764.29853552132;28950.42099158047;31021;31025.534616980312;31593.684063159075;32062.35875282528;30690.539641904943;31091.689083109784;31230.843845780626;31256.499480041086;31666.525002125447;37175.442368363954;37456.81271593625;37714.811425942695;38009.80995095007;38166.80916595399;24106;29895;31070;31826.045218643478;32259;23248.535029298982;24142.517149656556;24494.877525612257;25080.247592571523;25295.747042530074 09:42:43 INFO - PID 1895 | |2;jquery.html;417.9728317659352;439.8768344863439;441.05933890880124;449.58862640683765;471.69811320754724;19888.502787430305;21543.784562154375;22225;22361.55276894461;22397.888010559964;22533.774662253374;23505.76494235057;23603.29190124299;23665.645015324782;23691.881540592272;6141.355157708432;6344.587601805891;6356.650384228866;6357.427831495164;6615.272320044791;6659.900101498457;6865.10753602031;6917.0661960635425;6936.618485983269;6945.548539344926;6686;6850.588964662136;6917.031615573824;6919.169699636051;6924.653767311639;6747.021681856103;6768.627725475097;6845.965770171142;6864.519483636147;6903.482238832108;6700.731970721165;6725.293844146343;6747.257801641816;6751;6792.320767923168;24661.50676986468;30041.098767037023;30179.396412071856;30652;30809.537856932166;2219.522802597433;2346.4720437901337;2389.307100940725;2395.0419832067137;2404.338806828136;18604.34884779026;18671.346502872333;19116.617667646708;19191.424257272305;19277.710834337497;2282.4864405508793;2358.386819426961;2378.5124049569795;2388.940276493084;2404.254681048863;168383;168986.15506922387;170547.99999999875;170870;173423.99999999875;25436.982520699334;25742.613860792102;25757.484850302888;25789.4553714775;25896.245044468447;42593.57406425896;43126;43348;43353.56646433495;43518.56481435208;11056.060234879964;11185.993260606421;11341.092712582973;11384.544618215179;11515.884841151481;8784.78038049054;8876.689315873913;8878.378513504122;9048.819023619491;9075.636974520945;9827.803443931225;11544.249623774427;11944.283342999448;12020.579279725343;12232.755344893052;4416.9779151104685;4519.694955572616;4541.977290113528;4592.311153327028;4614.792334344896;907.5054095517959;951.7144856543009;972.9443553744267;973.9172170365457;1042.9895701042892;20497.692534611993;21495.140194392363;21549.49153559267;21688.674669879965;21747.021384037438;1025.7383418395416;1030.5311083457009;1053.2837670384213;1055.3087727538475;1063.106990128296;11175.217734758651;11343.943280283545;11378.772424551462;11379.43102844871;11387.715307117389;523238;533799;553108;558851;563077;133246.33376833054;137139;138499;141240;142790;1213;1245.975080498403;1282.6280378690076;1287.0668765145383;1288.375138058041;17691.38080167188;22267.665985009913;22402;22442.887785560968;22646.773532264466;54591;54755;55405.44594554164;56197.94267452377;56494;72275;72448;72454.63772681102;72663.63668181625;72830.63584682043;8791.164839340252;8852.778680532781;8871.979722332015;8873.556322183736;8943.418677785923;11899.821502677294;13628.182309061489;13854.238016908763;13941.163530188222;14158;10190;11738;11816.82274765862;11878.524859005543;12009.459574319351;10944.39805810688;10981.341119532854;11216.83174752363;11304.830427543759;11393.886061139614;10693.14454843595;11442.713932151762;11788.764224715285;12186.756264874475;12188.573399931314;9046.819063618823;9051.094890510896;9127.497987610745;9201.217896478875;9585.808283834423;10043.4476103815;10359.63741269052;11274.549018039186;11379.487923043649;12015.158938874194 09:42:43 INFO - PID 1895 | |3;mootools.html;1271.9427625756844;1462.963425914352;1481.2297605245267;1485.2425263115815;1488.9702205955882;11490.425478726072;11552.133589980744;12107;12178.451969661364;12240.020798336134;11919.523219071227;12121.272723636588;12154.453049612766;12155.690418820417;12166.756664866698;2544.6055861341474;2567.0501914291644;2585.5346037713202;2587.780038696713;2592.5592649249675;2493.227099599121;2545.16009716793;2545.1600971679395;2549.490101979602;2551.4259291659414;2506.8245222834407;2526.103233352161;2547.0703193334484;2554.0167035691206;2554.9872250638723;2485.1674688979215;2517.811164162695;2537.8857951392233;2551.9744802551922;2560.244727805302;1995.2418081129078;2050.3131450963947;2518.382996165951;2526.0401047601977;2582.760275067959;11973.46119424628;11991.580294689644;12059.698507537294;12088.576899808553;12101.878981210164;6603.085105319499;6836.179658441019;6841.247462779091;6872.140982377203;6879.6560171991705;3819.3316169670197;4080.326746086922;4452.866414007585;4477.477657596432;4562.817487300537;1252.7369252456995;1260.117917457774;1328.9601311960657;1333.646583655332;1336.265054220175;16292.755608665879;16461.83538164615;16683.499495015047;16836.915815420845;16895.15524223796;5503.697296648643;5643.7707105693025;5764.855878603068;5784.739686714108;5835.708214589254;11628.592999244986;11998.820017699742;12029.939850300692;12033.217840840318;12033.458494367775;6528.314526974695;6600.438962688129;6620.503462240351;6625.933740662628;6628.07206991012;6003.489703375262;6149.108379285068;6215.782447614311;6253.6560489173535;6310.4636105930595;4289.785510724451;4420.801063952065;4427.22523558376;4463.352813841975;4469.7988590513505;1275.355945247644;1283.7881749511225;1295.520657356784;1301.9414126364336;1307.0589175793605;774.6397924964919;796.4544287163196;799.2087833045359;802.3661307566957;802.3741481644327;6780.627065511444;6985.825354366181;7070.681819318143;7125.928740712527;7147.964260178665;859.3297228162044;973.4597298499259;977.7897751983357;980.3627642032736;1009.4548943570536;3978.6021397860563;4025.1748391579654;4100.671946244293;4104.261232978033;4313.158934007838;10316.48417579118;15105.848941510445;15140.772888406682;15159.772603410958;15166.24168791556;15039.548813535612;15059.644631983174;15065.548033559011;15068.246587670572;15068.698626027637;7550.3582195514;8163.959180204061;8749.868751968726;8919.598618062073;8933.687320943865;6689.397954184147;6783;7138.107736532934;7309;7346.11846578414;10407.531661075422;11528.423578820857;12244.265344079384;13288.136271142344;13511.864881351454;13639.386227619583;13715.588532344045;13799.310034498436;13820.585382438543;13869.306534673024;9402.670906518239;9449.055094490495;9519.333646644669;9527;9548.42709437436;10660.84008739885;10722.24944253926;10847.566097356334;10851.945740271249;10860.565577377132;8174.100848906734;8338.66645334204;9225.72322830316;9253.907460925304;9332.95333523328;7512.699492020258;8931.374803763674;9018.5941632628;9046.140616641409;9056.909430905871;8304.709335173482;8325.417220794487;8326.084130745734;8380.120087390736;8394.412391132562;5069.112905241642;6089.391060893875;6193.4425901669065;6202.100695399052;6266.905996409966;5241.9737901310245;5656.434356564475;6003.309619393825;6282.183316168869;6283.654399008098 09:42:43 INFO - PID 1895 | |4;prototype.html;385.1814893351628;392.952845658521;403.9676825853932;408.8562419874572;416.46276303568396;5425.077736784746;5484.862878428036;6521.967390163042;6559.442447391977;6578.539502234846;5102.77037533311;6074.817755467332;6241.531885108612;6333.778317758879;6374.310807635969;4650.767461626922;4689.788959496814;4692.272697731857;4708.717476951377;4737.66836321456;4605.907881842361;4713.528647135293;4719.43366795985;4721.244600863863;4747.003129342842;4606.60843828275;4607.239805432099;4609.262517997121;4633.4208223972;4678.508756580561;3745.831437585288;4536.616332018733;4601.608863246628;4627;4636.26140197426;3346.3474622448634;3654.2326111516613;3973.7615743055508;3978.9602103978877;3979.920401591981;5680.744366503476;6333.271673757485;6354.2025770543405;6365.713542890581;6390.744370225186;4625.629949604057;5542;5568.721563921828;5569.944300556983;5572.718274796779;6117.635300584705;6360.2367715873925;6698.296678848748;6883.793486195422;6927.376536111774;3971.98014009931;4131.669466442678;4498.0104377037;4515.661325400608;4544.840930567414;6394.904076438857;7090.858182836366;7286.781396558112;7365.373943214833;7376;3809.790461524643;4531.84138555149;4566.840160594364;4568.926302318952;4580.427446569179;4653.162430762495;4657.254839225775;4664.906701865943;4667.556582124693;4680.110778951988;5368.516833485005;5505.834824955257;5556.666600004012;5557.194206839986;5588.736561692521;5991.610545314627;6336.20797400325;6512.41388275048;6853.040574319599;6921.446284297244;1575.7715131306127;1580.865626421744;1586.6350739330019;1596.9520914372588;1599.5201439568316;1029.8867124616286;1032.3444612670858;1033.34382667007;1039.8856125826153;1042.6142327338932;5770.88458230833;6016.518678505709;6575.80272591823;6581.440577550866;6584.473242140617;6668.433183179484;7037.19072306681;7126.821829454201;7219.267375829763;7223.313785190504;5483.725813709299;5718.456016875503;6516.380943810331;6528.771492997817;6556.8360790980605;2865.899693510759;3124.2970331675647;3164.493681011073;3301.4552598820924;3608.8376023079027;5569.516539185914;6812.829679258059;7456.1798202197715;7468.738594149178;7479.214682458372;6126.6017708848785;7246.202917679051;7356.96321518389;7423.369013633794;7459.762071378674;7256.8911466328045;7422.294881986203;7430.219826918204;7436.405087593088;7438.033055702832;5603.747831347518;6263.874722505616;6309.652969086745;6777.423918966943;7244;6172.814815555541;6796.9753459709955;6943.153307144249;7103.289671032855;7113.822154445973;6109.144719739329;6138.877222455437;6497.960326347951;7513.347063645989;7537.585432801248;4580.679352445297;4592.0815836833435;4597.42532183477;4597.908041839078;4602.102589994919;6160.260768707783;6541.2477565078725;7217.24218957002;7262.656408564432;7319.817004574928;6282.403171698864;6914.51598388108;7030.894536582057;7047.736119647539;7058.753003591755;5667.2349232854685;6635.469162467088;6926.341997510229;7003.404710599656;7010.754623588354;6352.237731472253;6715.951634751447;6799.572089861184;6837;6917.308269173042;6800.693968771516;6922.238553758982;6966.965165174344;6999.930000699927;7040.718371265092;6333.556651034383;6749.898751518829;6793.4565234782085;6838.076859624086;6870.965645171742 09:42:43 INFO - PID 1895 | |5;yui.html;752.8005078654157;826.520618041536;838.9244967952883;860.7648025084003;862.1034124510505;16467.341306347746;17105.14474276286;17106.572335691613;18124.728129078074;19471.026448677545;17984.190711417985;18311.084445777724;18381.98899060551;18546.721799173025;18684.719729204073;986.2011770465909;996.9003099690027;1006.1950439648289;1011.7521207304221;1012.1750773119884;755.395683453238;987.6049580167919;1011.6661501704457;1018.2108865629123;1021.2646894236138;1041.182671602792;1051.4007016000883;1052.9262951593391;1053.4048262731571;1053.978920421595;1039.77644806367;1042.2860340666668;1047.282611411182;1047.4657924458581;1048.6015314180602;771.4291424346;773.2113244490645;774.9690012399498;777.0054330456968;777.2848978939389;14205.431782728678;16695.332186712516;16974.575635609086;17098.658026839392;17376.304947802073;17045.23296451663;17497.650046998988;17504.64990700179;17708.91145544277;17849.553761155945;14006.509772157926;14108.647283817883;14163.179916317951;14163.929180354033;14299.428022879072;3508.6842184203288;3535.8939231823088;3536.29274145172;3539.8761043363615;3541.2740388220354;102124;119866.80133198731;122138.16792748116;130591;135260.32369838087;13220.735585288241;13314;13318.600441986757;13388.598342049754;13567.660808479866;23692.289231323088;25677.229683109163;25719.742802571735;25944.481110378063;26116.73883261143;7905.01187351581;8044.637991290406;8062.274395304334;8121.228483294078;8133.227343402367;3917.5298964123917;3992.640662340403;4046.2918989177365;4073.7555746655294;4083.387491876242;3940.6847452203756;4226.408302837605;4290.635295999875;4325.697201195949;4333.349997500337;724.644923987253;948.5399581203111;949.0746522140857;950.1496160935924;950.3680052764972;622.7104396455579;649.9577527460794;662.9469642428594;681.0193321616856;681.2914568848342;10853.782924341469;11425.771484570261;11477.426128693698;11899.286042837457;12231.69420764488;569.2741754263348;627.4071002902214;633.8637193003526;659.9274079851212;663.2869665110026;4093.5292441369625;4563.429571303587;4931.3589233399425;5251.474852514794;5408.78364865401;93066;106076.40885386725;108163;109284;111522;77490;81993.18006819974;90286;90426;91418.7145321359;84064;84522;85742;86296.56851715827;87110;10672.83990740155;10730.517126729472;10851.294665846695;10893.128549716163;11073.612423565459;36040;38019.80990095032;41587.376189356575;43119.56880431156;43460.56539434565;54557;68078.65960670165;71474;74272.42956778155;76164;13594.592162235149;16471.25879335409;17071.573210669834;17324.913375433043;17335.739963900298;17937;17975.37086202029;18373.056943502223;18786.6242675143;19018.52453688669;16139.838601614303;16994.980301181968;17299;17313.307467701656;17361.30554777795;16593.75109373336;17348.132593370534;17373.21820518105;17380.652386952443;17506.73739893928;16200.687477516936;16497.257623407215;16823.579410514834;17150.313987440863;17175.65648687044;11796.94101529487;11829.881701182878;12055.336956467478;12107.84975427333;12517.374131293582;12840.743185136433;13945.233012184428;14074.78887816704;14149.36327865228;14204.28978551089 09:42:43 INFO - PID 1895 | __end_tp_report 09:42:43 INFO - PID 1895 | __start_cc_report 09:42:43 INFO - PID 1895 | _x_x_mozilla_cycle_collect,403 09:42:43 INFO - PID 1895 | __end_cc_report 09:42:43 INFO - PID 1895 | __startTimestamp1494002563858__endTimestamp 09:42:43 INFO - PID 1895 | 09:42:43 INFO - PID 1895 | ------- Summary: start ------- 09:42:43 INFO - PID 1895 | Number of tests: 6 09:42:43 INFO - PID 1895 | 09:42:43 INFO - PID 1895 | [#0] dojo.html Cycles:165 Average:6234.69 Median:6466.77 stddev:760.30 (11.8%) stddev-sans-first:727.63 09:42:43 INFO - PID 1895 | Values: 3327.4 3557.8 3619.9 3660.5 3702.2 5434.2 5721.5 5924.4 6216.5 6350.5 6229.3 6284.7 6304.7 6352.3 6394.4 5529.1 5547.0 5574.9 5577.4 5665.6 5606.4 5742.3 5747.7 5756.2 5764.1 5462.4 5534.4 5583.2 5614.5 5714.8 5534.8 5541.1 5546.4 5553.0 5612.1 5558.7 5584.2 5603.0 5616.9 5626.2 6126.2 6363.7 6400.0 6421.3 6442.8 6578.2 6789.8 6863.8 6864.7 6888.4 6748.4 6833.5 6903.3 6915.5 6928.7 6426.7 6456.9 6476.6 6492.9 6494.6 7057.3 7086.8 7130.1 7130.8 7173.3 5747.5 6450.6 6569.5 6727.2 6759.6 5224.5 5722.4 5787.7 6924.8 6942.8 6769.2 6781.4 6854.0 6857.5 6880.2 6580.1 6636.3 6708.7 6804.0 6849.2 5413.6 5421.7 5434.0 5435.8 5471.9 4750.9 4839.4 4841.2 4865.2 4873.0 5637.3 6030.5 6198.0 6355.6 6383.3 5818.3 6916.2 6924.1 6949.0 6983.0 6421.4 6439.9 6450.7 6453.8 6487.9 5836.9 5945.7 6036.2 6082.8 6121.9 6935.4 6954.9 7035.0 7037.3 7119.2 6673.8 6928.2 6931.5 6945.4 6966.0 6883.9 6959.3 7048.9 7154.0 7166.8 5143.7 5730.8 6847.5 6851.3 6868.3 6583.9 6647.2 6773.7 6986.7 6999.2 6642.6 6643.3 6685.7 6693.7 6725.1 5584.3 6737.5 6738.0 6741.8 6760.6 5618.4 5664.0 6489.0 6589.0 6626.3 6466.8 6566.3 6589.5 6662.5 6688.8 6577.7 6588.2 6588.4 6602.5 6615.0 09:42:43 INFO - PID 1895 | 09:42:43 INFO - PID 1895 | [#1] ext.html Cycles:180 Average:43867.77 Median:337393.50 stddev:74481.91 (22.1%) stddev-sans-first:74620.44 09:42:43 INFO - PID 1895 | Values: 732.1 827.8 1037.6 1103.9 1261.6 36419.1 37375.1 37507.2 37522.1 37634.0 37224.4 37505.8 37584.6 37748.3 37803.0 7841.8 7995.6 8343.2 8609.7 8611.2 8578.3 8635.9 8697.3 8713.3 8731.7 8671.9 8721.2 8741.7 8742.1 8768.8 8658.0 8660.0 8704.4 8726.3 8730.0 8487.8 8493.9 8544.6 8548.4 8559.2 37756.0 38003.2 38033.6 38096.0 38250.6 3698.9 3701.9 3713.2 3718.8 3734.3 30631.6 30991.2 31143.0 31209.0 31352.2 3162.6 3192.0 3200.9 3204.2 3206.7 249369.0 251506.0 252170.7 252260.4 253170.0 46778.1 49121.5 49355.0 49464.3 49611.0 51272.0 51419.5 51482.7 51544.5 51722.0 14529.9 14536.8 14586.4 14627.5 14628.2 11466.5 11714.3 11718.9 11719.1 11838.2 13401.7 13523.7 13553.7 13555.5 13638.5 5230.3 5642.7 5840.3 5887.9 5912.2 1061.3 1076.9 1079.1 1081.2 1111.5 20856.8 21252.7 21712.7 24933.5 24994.5 1156.5 1163.4 1205.0 1205.4 1206.8 9939.6 11032.9 11383.8 11852.5 12009.5 288660.0 326620.0 331483.3 337155.0 337632.0 54989.0 55271.7 55383.2 55441.4 55526.2 1547.7 1554.1 1584.6 1587.0 1610.4 20341.9 24136.5 24486.0 24770.5 24811.6 33955.5 37244.3 39216.2 39261.6 39314.6 270649.0 271075.0 271447.0 271861.0 273443.0 35178.0 35635.5 35878.0 36791.3 36835.0 44925.6 45673.1 46470.5 46540.8 46764.3 28950.4 31021.0 31025.5 31593.7 32062.4 30690.5 31091.7 31230.8 31256.5 31666.5 37175.4 37456.8 37714.8 38009.8 38166.8 24106.0 29895.0 31070.0 31826.0 32259.0 23248.5 24142.5 24494.9 25080.2 25295.7 09:42:43 INFO - PID 1895 | 09:42:43 INFO - PID 1895 | [#2] jquery.html Cycles:180 Average:37645.18 Median:2389.12 stddev:93307.01 (3905.5%) stddev-sans-first:93526.89 09:42:43 INFO - PID 1895 | Values: 418.0 439.9 441.1 449.6 471.7 19888.5 21543.8 22225.0 22361.6 22397.9 22533.8 23505.8 23603.3 23665.6 23691.9 6141.4 6344.6 6356.7 6357.4 6615.3 6659.9 6865.1 6917.1 6936.6 6945.5 6686.0 6850.6 6917.0 6919.2 6924.7 6747.0 6768.6 6846.0 6864.5 6903.5 6700.7 6725.3 6747.3 6751.0 6792.3 24661.5 30041.1 30179.4 30652.0 30809.5 2219.5 2346.5 2389.3 2395.0 2404.3 18604.3 18671.3 19116.6 19191.4 19277.7 2282.5 2358.4 2378.5 2388.9 2404.3 168383.0 168986.2 170548.0 170870.0 173424.0 25437.0 25742.6 25757.5 25789.5 25896.2 42593.6 43126.0 43348.0 43353.6 43518.6 11056.1 11186.0 11341.1 11384.5 11515.9 8784.8 8876.7 8878.4 9048.8 9075.6 9827.8 11544.2 11944.3 12020.6 12232.8 4417.0 4519.7 4542.0 4592.3 4614.8 907.5 951.7 972.9 973.9 1043.0 20497.7 21495.1 21549.5 21688.7 21747.0 1025.7 1030.5 1053.3 1055.3 1063.1 11175.2 11343.9 11378.8 11379.4 11387.7 523238.0 533799.0 553108.0 558851.0 563077.0 133246.3 137139.0 138499.0 141240.0 142790.0 1213.0 1246.0 1282.6 1287.1 1288.4 17691.4 22267.7 22402.0 22442.9 22646.8 54591.0 54755.0 55405.4 56197.9 56494.0 72275.0 72448.0 72454.6 72663.6 72830.6 8791.2 8852.8 8872.0 8873.6 8943.4 11899.8 13628.2 13854.2 13941.2 14158.0 10190.0 11738.0 11816.8 11878.5 12009.5 10944.4 10981.3 11216.8 11304.8 11393.9 10693.1 11442.7 11788.8 12186.8 12188.6 9046.8 9051.1 9127.5 9201.2 9585.8 10043.4 10359.6 11274.5 11379.5 12015.2 09:42:43 INFO - PID 1895 | 09:42:43 INFO - PID 1895 | [#3] mootools.html Cycles:180 Average:7134.49 Median:3205.95 stddev:4480.53 (139.8%) stddev-sans-first:4471.44 09:42:43 INFO - PID 1895 | Values: 1271.9 1463.0 1481.2 1485.2 1489.0 11490.4 11552.1 12107.0 12178.5 12240.0 11919.5 12121.3 12154.5 12155.7 12166.8 2544.6 2567.1 2585.5 2587.8 2592.6 2493.2 2545.2 2545.2 2549.5 2551.4 2506.8 2526.1 2547.1 2554.0 2555.0 2485.2 2517.8 2537.9 2552.0 2560.2 1995.2 2050.3 2518.4 2526.0 2582.8 11973.5 11991.6 12059.7 12088.6 12101.9 6603.1 6836.2 6841.2 6872.1 6879.7 3819.3 4080.3 4452.9 4477.5 4562.8 1252.7 1260.1 1329.0 1333.6 1336.3 16292.8 16461.8 16683.5 16836.9 16895.2 5503.7 5643.8 5764.9 5784.7 5835.7 11628.6 11998.8 12029.9 12033.2 12033.5 6528.3 6600.4 6620.5 6625.9 6628.1 6003.5 6149.1 6215.8 6253.7 6310.5 4289.8 4420.8 4427.2 4463.4 4469.8 1275.4 1283.8 1295.5 1301.9 1307.1 774.6 796.5 799.2 802.4 802.4 6780.6 6985.8 7070.7 7125.9 7148.0 859.3 973.5 977.8 980.4 1009.5 3978.6 4025.2 4100.7 4104.3 4313.2 10316.5 15105.8 15140.8 15159.8 15166.2 15039.5 15059.6 15065.5 15068.2 15068.7 7550.4 8164.0 8749.9 8919.6 8933.7 6689.4 6783.0 7138.1 7309.0 7346.1 10407.5 11528.4 12244.3 13288.1 13511.9 13639.4 13715.6 13799.3 13820.6 13869.3 9402.7 9449.1 9519.3 9527.0 9548.4 10660.8 10722.2 10847.6 10851.9 10860.6 8174.1 8338.7 9225.7 9253.9 9333.0 7512.7 8931.4 9018.6 9046.1 9056.9 8304.7 8325.4 8326.1 8380.1 8394.4 5069.1 6089.4 6193.4 6202.1 6266.9 5242.0 5656.4 6003.3 6282.2 6283.7 09:42:43 INFO - PID 1895 | 09:42:43 INFO - PID 1895 | [#4] prototype.html Cycles:180 Average:5494.08 Median:6132.74 stddev:1777.50 (29.0%) stddev-sans-first:1740.64 09:42:43 INFO - PID 1895 | Values: 385.2 393.0 404.0 408.9 416.5 5425.1 5484.9 6522.0 6559.4 6578.5 5102.8 6074.8 6241.5 6333.8 6374.3 4650.8 4689.8 4692.3 4708.7 4737.7 4605.9 4713.5 4719.4 4721.2 4747.0 4606.6 4607.2 4609.3 4633.4 4678.5 3745.8 4536.6 4601.6 4627.0 4636.3 3346.3 3654.2 3973.8 3979.0 3979.9 5680.7 6333.3 6354.2 6365.7 6390.7 4625.6 5542.0 5568.7 5569.9 5572.7 6117.6 6360.2 6698.3 6883.8 6927.4 3972.0 4131.7 4498.0 4515.7 4544.8 6394.9 7090.9 7286.8 7365.4 7376.0 3809.8 4531.8 4566.8 4568.9 4580.4 4653.2 4657.3 4664.9 4667.6 4680.1 5368.5 5505.8 5556.7 5557.2 5588.7 5991.6 6336.2 6512.4 6853.0 6921.4 1575.8 1580.9 1586.6 1597.0 1599.5 1029.9 1032.3 1033.3 1039.9 1042.6 5770.9 6016.5 6575.8 6581.4 6584.5 6668.4 7037.2 7126.8 7219.3 7223.3 5483.7 5718.5 6516.4 6528.8 6556.8 2865.9 3124.3 3164.5 3301.5 3608.8 5569.5 6812.8 7456.2 7468.7 7479.2 6126.6 7246.2 7357.0 7423.4 7459.8 7256.9 7422.3 7430.2 7436.4 7438.0 5603.7 6263.9 6309.7 6777.4 7244.0 6172.8 6797.0 6943.2 7103.3 7113.8 6109.1 6138.9 6498.0 7513.3 7537.6 4580.7 4592.1 4597.4 4597.9 4602.1 6160.3 6541.2 7217.2 7262.7 7319.8 6282.4 6914.5 7030.9 7047.7 7058.8 5667.2 6635.5 6926.3 7003.4 7010.8 6352.2 6716.0 6799.6 6837.0 6917.3 6800.7 6922.2 6967.0 6999.9 7040.7 6333.6 6749.9 6793.5 6838.1 6871.0 09:42:43 INFO - PID 1895 | 09:42:43 INFO - PID 1895 | [#5] yui.html Cycles:180 Average:22180.09 Median:18054.46 stddev:30917.49 (171.2%) stddev-sans-first:30962.36 09:42:43 INFO - PID 1895 | Values: 752.8 826.5 838.9 860.8 862.1 16467.3 17105.1 17106.6 18124.7 19471.0 17984.2 18311.1 18382.0 18546.7 18684.7 986.2 996.9 1006.2 1011.8 1012.2 755.4 987.6 1011.7 1018.2 1021.3 1041.2 1051.4 1052.9 1053.4 1054.0 1039.8 1042.3 1047.3 1047.5 1048.6 771.4 773.2 775.0 777.0 777.3 14205.4 16695.3 16974.6 17098.7 17376.3 17045.2 17497.7 17504.6 17708.9 17849.6 14006.5 14108.6 14163.2 14163.9 14299.4 3508.7 3535.9 3536.3 3539.9 3541.3 102124.0 119866.8 122138.2 130591.0 135260.3 13220.7 13314.0 13318.6 13388.6 13567.7 23692.3 25677.2 25719.7 25944.5 26116.7 7905.0 8044.6 8062.3 8121.2 8133.2 3917.5 3992.6 4046.3 4073.8 4083.4 3940.7 4226.4 4290.6 4325.7 4333.3 724.6 948.5 949.1 950.1 950.4 622.7 650.0 662.9 681.0 681.3 10853.8 11425.8 11477.4 11899.3 12231.7 569.3 627.4 633.9 659.9 663.3 4093.5 4563.4 4931.4 5251.5 5408.8 93066.0 106076.4 108163.0 109284.0 111522.0 77490.0 81993.2 90286.0 90426.0 91418.7 84064.0 84522.0 85742.0 86296.6 87110.0 10672.8 10730.5 10851.3 10893.1 11073.6 36040.0 38019.8 41587.4 43119.6 43460.6 54557.0 68078.7 71474.0 74272.4 76164.0 13594.6 16471.3 17071.6 17324.9 17335.7 17937.0 17975.4 18373.1 18786.6 19018.5 16139.8 16995.0 17299.0 17313.3 17361.3 16593.8 17348.1 17373.2 17380.7 17506.7 16200.7 16497.3 16823.6 17150.3 17175.7 11796.9 11829.9 12055.3 12107.8 12517.4 12840.7 13945.2 14074.8 14149.4 14204.3 09:42:43 INFO - PID 1895 | -------- Summary: end -------- 09:42:43 INFO - PID 1895 | 09:42:44 INFO - TEST-INFO | 1895: exit 0 09:42:44 INFO - TEST-OK | dromaeo_css | took 1115519ms 09:42:44 INFO - TEST-START | kraken 09:42:44 INFO - operating with platform_type : mac_ 09:42:44 INFO - Initialising browser for kraken test... 09:42:44 INFO - TEST-INFO | started process 1905 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpL_sWEN/profile http://localhost:49386/getInfo.html) 09:42:47 INFO - PID 1905 | 2017-05-05 09:42:47.304 plugin-container[1906:11534] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 09:42:47 INFO - PID 1905 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:42:47 INFO - PID 1905 | 2017-05-05 09:42:47.307 plugin-container[1906:11534] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9b0b, name = 'com.apple.CFPasteboardClient' 09:42:47 INFO - PID 1905 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:42:47 INFO - PID 1905 | 2017-05-05 09:42:47.307 plugin-container[1906:11534] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:42:47 INFO - PID 1905 | __metrics Screen width/height:1600/1200 09:42:47 INFO - PID 1905 | colorDepth:24 09:42:47 INFO - PID 1905 | Browser inner width/height: 1024/691 09:42:47 INFO - PID 1905 | __metrics 09:42:48 INFO - TEST-INFO | 1905: exit 0 09:42:48 INFO - Browser initialized. 09:42:48 INFO - Running cycle 1/1 for kraken test... 09:42:48 INFO - TEST-INFO | started process 1908 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpL_sWEN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:42:51 INFO - PID 1908 | 2017-05-05 09:42:51.003 plugin-container[1909:11691] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 09:42:51 INFO - PID 1908 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:42:51 INFO - PID 1908 | 2017-05-05 09:42:51.003 plugin-container[1909:11691] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 09:42:51 INFO - PID 1908 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:42:51 INFO - PID 1908 | 2017-05-05 09:42:51.003 plugin-container[1909:11691] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:42:51 INFO - PID 1908 | 2017-05-05 09:42:51.548 plugin-container[1910:11734] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 09:42:51 INFO - PID 1908 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:42:51 INFO - PID 1908 | 2017-05-05 09:42:51.549 plugin-container[1910:11734] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9413, name = 'com.apple.CFPasteboardClient' 09:42:51 INFO - PID 1908 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:42:51 INFO - PID 1908 | 2017-05-05 09:42:51.549 plugin-container[1910:11734] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:43:00 INFO - PID 1908 | RSS: Main: 233607168 09:43:00 INFO - PID 1908 | 09:43:03 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49386/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49386/tests/kraken/driver.html?testName=audio-beat-detection) 09:43:04 INFO - PID 1908 | RSS: Main: 246370304 09:43:04 INFO - PID 1908 | 09:43:07 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49386/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49386/tests/kraken/driver.html?testName=audio-dft) 09:43:07 INFO - PID 1908 | RSS: Main: 255344640 09:43:07 INFO - PID 1908 | 09:43:11 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49386/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49386/tests/kraken/driver.html?testName=audio-fft) 09:43:12 INFO - PID 1908 | RSS: Main: 257323008 09:43:12 INFO - PID 1908 | 09:43:13 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49386/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49386/tests/kraken/driver.html?testName=audio-oscillator) 09:43:14 INFO - PID 1908 | RSS: Main: 259309568 09:43:14 INFO - PID 1908 | 09:43:16 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49386/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49386/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:43:17 INFO - PID 1908 | RSS: Main: 259690496 09:43:17 INFO - PID 1908 | 09:43:19 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49386/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49386/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:20 INFO - PID 1908 | RSS: Main: 265650176 09:43:20 INFO - PID 1908 | 09:43:23 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49386/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49386/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:24 INFO - PID 1908 | RSS: Main: 267673600 09:43:24 INFO - PID 1908 | 09:43:27 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49386/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49386/tests/kraken/driver.html?testName=json-parse-financial) 09:43:27 INFO - PID 1908 | RSS: Main: 266891264 09:43:27 INFO - PID 1908 | 09:43:29 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49386/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49386/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:43:29 INFO - PID 1908 | RSS: Main: 266670080 09:43:29 INFO - PID 1908 | 09:43:31 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49386/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49386/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:43:32 INFO - PID 1908 | RSS: Main: 267161600 09:43:32 INFO - PID 1908 | 09:43:34 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49386/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49386/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:43:35 INFO - PID 1908 | RSS: Main: 266543104 09:43:35 INFO - PID 1908 | 09:43:38 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49386/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49386/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:43:38 INFO - PID 1908 | RSS: Main: 266346496 09:43:38 INFO - PID 1908 | 09:43:41 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49386/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49386/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:43:42 INFO - PID 1908 | RSS: Main: 266711040 09:43:42 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49386/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49386/tests/kraken/driver.html?testName=ai-astar) 09:43:44 INFO - PID 1908 | RSS: Main: 268288000 09:43:44 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | __start_tp_report 09:43:44 INFO - PID 1908 | _x_x_mozilla_page_load 09:43:44 INFO - PID 1908 | _x_x_mozilla_page_load_details 09:43:44 INFO - PID 1908 | |i|pagename|runs| 09:43:44 INFO - PID 1908 | |0;ai-astar;106;117;111;99;135;95;169;171;166;114 09:43:44 INFO - PID 1908 | |1;audio-beat-detection;148;113;113;172;140;103;115;131;149;139 09:43:44 INFO - PID 1908 | |2;audio-dft;203;196;205;215;191;252;211;281;241;197 09:43:44 INFO - PID 1908 | |3;audio-fft;79;56;60;81;56;62;60;58;77;59 09:43:44 INFO - PID 1908 | |4;audio-oscillator;86;70;81;71;68;71;81;92;96;78 09:43:44 INFO - PID 1908 | |5;imaging-gaussian-blur;94;89;90;90;90;114;93;89;92;89 09:43:44 INFO - PID 1908 | |6;imaging-darkroom;97;98;96;96;107;114;97;98;96;98 09:43:44 INFO - PID 1908 | |7;imaging-desaturate;92;99;93;92;90;91;91;84;149;150 09:43:44 INFO - PID 1908 | |8;json-parse-financial;51;50;48;51;51;54;51;52;52;51 09:43:44 INFO - PID 1908 | |9;json-stringify-tinderbox;60;54;60;56;72;60;59;77;83;83 09:43:44 INFO - PID 1908 | |10;stanford-crypto-aes;85;84;84;84;85;83;81;84;85;83 09:43:44 INFO - PID 1908 | |11;stanford-crypto-ccm;149;150;148;149;153;144;154;127;200;154 09:43:44 INFO - PID 1908 | |12;stanford-crypto-pbkdf2;185;187;185;186;222;182;219;231;197;182 09:43:44 INFO - PID 1908 | |13;stanford-crypto-sha256-iterative;70;66;70;70;70;70;68;65;71;69 09:43:44 INFO - PID 1908 | __end_tp_report 09:43:44 INFO - PID 1908 | __start_cc_report 09:43:44 INFO - PID 1908 | _x_x_mozilla_cycle_collect,955 09:43:44 INFO - PID 1908 | __end_cc_report 09:43:44 INFO - PID 1908 | __startTimestamp1494002624554__endTimestamp 09:43:44 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | ------- Summary: start ------- 09:43:44 INFO - PID 1908 | Number of tests: 14 09:43:44 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | [#0] ai-astar Cycles:10 Average:128.30 Median:167.50 stddev:29.89 (17.8%) stddev-sans-first:30.60 09:43:44 INFO - PID 1908 | Values: 106.0 117.0 111.0 99.0 135.0 95.0 169.0 171.0 166.0 114.0 09:43:44 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:139.50 stddev:21.37 (15.3%) stddev-sans-first:21.90 09:43:44 INFO - PID 1908 | Values: 148.0 113.0 113.0 172.0 140.0 103.0 115.0 131.0 149.0 139.0 09:43:44 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | [#2] audio-dft Cycles:10 Average:219.20 Median:213.00 stddev:29.34 (13.8%) stddev-sans-first:30.52 09:43:44 INFO - PID 1908 | Values: 203.0 196.0 205.0 215.0 191.0 252.0 211.0 281.0 241.0 197.0 09:43:44 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | [#3] audio-fft Cycles:10 Average:64.80 Median:61.00 stddev:10.01 (16.4%) stddev-sans-first:9.20 09:43:44 INFO - PID 1908 | Values: 79.0 56.0 60.0 81.0 56.0 62.0 60.0 58.0 77.0 59.0 09:43:44 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:81.00 stddev:9.69 (12.0%) stddev-sans-first:9.97 09:43:44 INFO - PID 1908 | Values: 86.0 70.0 81.0 71.0 68.0 71.0 81.0 92.0 96.0 78.0 09:43:44 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | [#5] imaging-gaussian-blur Cycles:10 Average:93.00 Median:90.00 stddev:7.59 (8.4%) stddev-sans-first:8.04 09:43:44 INFO - PID 1908 | Values: 94.0 89.0 90.0 90.0 90.0 114.0 93.0 89.0 92.0 89.0 09:43:44 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | [#6] imaging-darkroom Cycles:10 Average:99.70 Median:97.00 stddev:5.98 (6.2%) stddev-sans-first:6.26 09:43:44 INFO - PID 1908 | Values: 97.0 98.0 96.0 96.0 107.0 114.0 97.0 98.0 96.0 98.0 09:43:44 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | [#7] imaging-desaturate Cycles:10 Average:103.10 Median:91.50 stddev:24.72 (27.0%) stddev-sans-first:25.89 09:43:44 INFO - PID 1908 | Values: 92.0 99.0 93.0 92.0 90.0 91.0 91.0 84.0 149.0 150.0 09:43:44 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.00 stddev:1.52 (3.0%) stddev-sans-first:1.62 09:43:44 INFO - PID 1908 | Values: 51.0 50.0 48.0 51.0 51.0 54.0 51.0 52.0 52.0 51.0 09:43:44 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:11.23 (17.0%) stddev-sans-first:11.67 09:43:44 INFO - PID 1908 | Values: 60.0 54.0 60.0 56.0 72.0 60.0 59.0 77.0 83.0 83.0 09:43:44 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:1.23 (1.5%) stddev-sans-first:1.22 09:43:44 INFO - PID 1908 | Values: 85.0 84.0 84.0 84.0 85.0 83.0 81.0 84.0 85.0 83.0 09:43:44 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | [#11] stanford-crypto-ccm Cycles:10 Average:152.80 Median:151.50 stddev:18.36 (12.1%) stddev-sans-first:19.42 09:43:44 INFO - PID 1908 | Values: 149.0 150.0 148.0 149.0 153.0 144.0 154.0 127.0 200.0 154.0 09:43:44 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.60 Median:192.00 stddev:18.92 (9.9%) stddev-sans-first:19.51 09:43:44 INFO - PID 1908 | Values: 185.0 187.0 185.0 186.0 222.0 182.0 219.0 231.0 197.0 182.0 09:43:44 INFO - PID 1908 | 09:43:44 INFO - PID 1908 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:70.00 stddev:1.97 (2.8%) stddev-sans-first:2.05 09:43:44 INFO - PID 1908 | Values: 70.0 66.0 70.0 70.0 70.0 70.0 68.0 65.0 71.0 69.0 09:43:44 INFO - PID 1908 | -------- Summary: end -------- 09:43:44 INFO - PID 1908 | 09:43:45 INFO - TEST-INFO | 1908: exit 0 09:43:45 INFO - TEST-OK | kraken | took 61069ms 09:43:45 INFO - SUITE-END | took 1176s 09:43:45 INFO - Completed test suite (00:19:36) 09:43:45 INFO - javascript benchmark 09:43:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8137.167072440708, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3327.4343361628535, 3557.772568463879, 3619.89593174082, 3660.4875317455553, 3702.2040261343805, 5434.212039254306, 5721.542276617871, 5924.407559244079, 6216.502679785618, 6350.491960643149, 6229.252489701231, 6284.685765711708, 6304.71628776705, 6352.333005034474, 6394.360563943604, 5529.060059789826, 5547.0, 5574.888502229953, 5577.386487486373, 5665.631733937302, 5606.439356064402, 5742.253507044078, 5747.741351639165, 5756.194132821408, 5764.106563482667, 5462.426445223234, 5534.446555344473, 5583.246261754652, 5614.466625670555, 5714.771409143629, 5534.778608855681, 5541.085720856054, 5546.4453554644215, 5553.028220061473, 5612.102063669793, 5558.722063896789, 5584.190292407578, 5603.019471592495, 5616.859578510529, 5626.212330273765, 6126.17296664949, 6363.668011080196, 6400.007998760199, 6421.261554921197, 6442.838929026765, 6578.243501997236, 6789.796306110825, 6863.794086177422, 6864.656767161622, 6888.380045795902, 6748.392644662004, 6833.487488438337, 6903.275156108637, 6915.51591388603, 6928.72285108595, 6426.742930282736, 6456.870862582722, 6476.579022363531, 6492.935070649328, 6494.642794646245, 7057.294270573005, 7086.822829429202, 7130.073090498202, 7130.821729456805, 7173.318534739192, 5747.540196784331, 6450.645214513153, 6569.507286953498, 6727.226368967631, 6759.5606285591275, 5224.50367215114, 5722.37053924068, 5787.681677507778, 6924.792256232321, 6942.826429339206, 6769.22153952292, 6781.423578995742, 6853.965730171417, 6857.5199736018, 6880.174379074543, 6580.078788969548, 6636.303188165173, 6708.731650734014, 6803.965980170067, 6849.2465828758795, 5413.593980451482, 5421.674699518042, 5433.9947109784025, 5435.755391007414, 5471.945280547223, 4750.857474275708, 4839.41926968759, 4841.2496063110275, 4865.197242454955, 4873.0, 5637.3235211774845, 6030.48740857032, 6198.0, 6355.555111142268, 6383.329750376237, 5818.301803783573, 6916.23921368649, 6924.099867017256, 6948.965255173793, 6983.0, 6421.3578642136345, 6439.935600643934, 6450.6774661266745, 6453.806385808433, 6487.870242595121, 5836.854078648068, 5945.672987985702, 6036.15493830864, 6082.787102451482, 6121.938780612226, 6935.375816176568, 6954.895676564855, 7034.964825175842, 7037.26108758573, 7119.2168861426235, 6673.799786006428, 6928.203256625351, 6931.549449285781, 6945.444364450731, 6966.0, 6883.862322753617, 6959.26927672587, 7048.8590228194125, 7153.964230178815, 7166.820829479305, 5143.71709555978, 5730.799422020209, 6847.48643851723, 6851.314868513109, 6868.278830722902, 6583.901241481477, 6647.169103862017, 6773.6951837168435, 6986.720531178899, 6999.230084690782, 6642.6014439133805, 6643.335666433318, 6685.699143538455, 6693.698783554849, 6725.125733654593, 5584.329880414376, 6737.528373014038, 6737.966310168418, 6741.764038258638, 6760.560563563353, 5618.381977982501, 5664.008798460335, 6489.0, 6589.0116482528, 6626.304238054935, 6466.773662921775, 6566.343365663395, 6589.505787065893, 6662.467002639681, 6688.799336019927, 6577.671116444063, 6588.209414870246, 6588.374104460068, 6602.471802255904, 6615.040819081302], "value": 6186.022503472728, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.136079426277, 827.8427098851217, 1037.6264544763878, 1103.9227254092216, 1261.5647601577452, 36419.08952276195, 37375.06562335943, 37507.24985500292, 37522.06194845127, 37634.0, 37224.441633375456, 37505.81247093768, 37584.62415375846, 37748.2814648169, 37803.0, 7841.803954901116, 7995.600219989006, 8343.249107580317, 8609.698660546883, 8611.224989750921, 8578.270846978014, 8635.913640863573, 8697.260732837716, 8713.259372953275, 8731.738047858575, 8671.869921951176, 8721.171488708595, 8741.650333986632, 8742.082081381459, 8768.824623507558, 8658.0, 8660.00409952854, 8704.434211776246, 8726.301895848317, 8729.956350218272, 8487.830243395098, 8493.872591911126, 8544.61549230286, 8548.358873084544, 8559.229669329728, 37756.0, 38003.23993520114, 38033.62613299478, 38096.0, 38250.61749382498, 3698.8705395311304, 3701.907452313687, 3713.1830997180577, 3718.7954662493553, 3734.290484807878, 30631.621577029087, 30991.22521936947, 31143.0, 31209.0, 31352.21619459509, 3162.6362968258713, 3191.952120718191, 3200.9199770005703, 3204.150900011499, 3206.7113959743733, 249369.0, 251506.0, 252170.73914630493, 252260.38698065022, 253170.0, 46778.06443871104, 49121.50878491241, 49355.0, 49464.25803612949, 49611.0, 51272.0, 51419.45741627757, 51482.742586287575, 51544.48455515472, 51722.0, 14529.927350363181, 14536.781948270784, 14586.416543338148, 14627.488037918622, 14628.19544925018, 11466.54133834654, 11714.297142171497, 11718.88281117178, 11719.12106592009, 11838.230515016496, 13401.659834016715, 13523.729525409437, 13553.661158471117, 13555.525556605471, 13638.454461821417, 5230.267762513251, 5642.689652069175, 5840.2991641003355, 5887.852803679943, 5912.23140991677, 1061.3419679798574, 1076.9299995500423, 1079.09895237476, 1081.194510089988, 1111.5276007696696, 20856.79143208579, 21252.681209781866, 21712.674309885366, 24933.50132997366, 24994.500109997698, 1156.525824411987, 1163.4182908545727, 1204.987950120505, 1205.3611585859333, 1206.77071356442, 9939.55272012761, 11032.889671103347, 11383.804700506493, 11852.525898964117, 12009.459574319177, 288660.0, 326620.0, 331483.3425832855, 337155.0, 337632.0, 54989.0, 55271.72364138234, 55383.169252461244, 55441.44558554443, 55526.16710749342, 1547.6904619076004, 1554.0753251815152, 1584.6038490377405, 1586.9841301587066, 1610.4041504643124, 20341.898290508452, 24136.517269654156, 24486.0, 24770.50458990846, 24811.627825582993, 33955.49066763951, 37244.25511489809, 39216.21567568689, 39261.62584309535, 39314.60685393224, 270649.0, 271075.0, 271447.0, 271861.0, 273443.0, 35178.00986916141, 35635.46546801852, 35878.0, 36791.26417471689, 36835.0, 44925.55074449344, 45673.086538269716, 46470.53529464662, 46540.7672961633, 46764.29853552132, 28950.42099158047, 31021.0, 31025.534616980312, 31593.684063159075, 32062.35875282528, 30690.539641904943, 31091.689083109784, 31230.843845780626, 31256.499480041086, 31666.525002125447, 37175.442368363954, 37456.81271593625, 37714.811425942695, 38009.80995095007, 38166.80916595399, 24106.0, 29895.0, 31070.0, 31826.045218643478, 32259.0, 23248.535029298982, 24142.517149656556, 24494.877525612257, 25080.247592571523, 25295.747042530074], "value": 17644.89224541607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.9728317659352, 439.8768344863439, 441.05933890880124, 449.58862640683765, 471.69811320754724, 19888.502787430305, 21543.784562154375, 22225.0, 22361.55276894461, 22397.888010559964, 22533.774662253374, 23505.76494235057, 23603.29190124299, 23665.645015324782, 23691.881540592272, 6141.355157708432, 6344.587601805891, 6356.650384228866, 6357.427831495164, 6615.272320044791, 6659.900101498457, 6865.10753602031, 6917.0661960635425, 6936.618485983269, 6945.548539344926, 6686.0, 6850.588964662136, 6917.031615573824, 6919.169699636051, 6924.653767311639, 6747.021681856103, 6768.627725475097, 6845.965770171142, 6864.519483636147, 6903.482238832108, 6700.731970721165, 6725.293844146343, 6747.257801641816, 6751.0, 6792.320767923168, 24661.50676986468, 30041.098767037023, 30179.396412071856, 30652.0, 30809.537856932166, 2219.522802597433, 2346.4720437901337, 2389.307100940725, 2395.0419832067137, 2404.338806828136, 18604.34884779026, 18671.346502872333, 19116.617667646708, 19191.424257272305, 19277.710834337497, 2282.4864405508793, 2358.386819426961, 2378.5124049569795, 2388.940276493084, 2404.254681048863, 168383.0, 168986.15506922387, 170547.99999999875, 170870.0, 173423.99999999875, 25436.982520699334, 25742.613860792102, 25757.484850302888, 25789.4553714775, 25896.245044468447, 42593.57406425896, 43126.0, 43348.0, 43353.56646433495, 43518.56481435208, 11056.060234879964, 11185.993260606421, 11341.092712582973, 11384.544618215179, 11515.884841151481, 8784.78038049054, 8876.689315873913, 8878.378513504122, 9048.819023619491, 9075.636974520945, 9827.803443931225, 11544.249623774427, 11944.283342999448, 12020.579279725343, 12232.755344893052, 4416.9779151104685, 4519.694955572616, 4541.977290113528, 4592.311153327028, 4614.792334344896, 907.5054095517959, 951.7144856543009, 972.9443553744267, 973.9172170365457, 1042.9895701042892, 20497.692534611993, 21495.140194392363, 21549.49153559267, 21688.674669879965, 21747.021384037438, 1025.7383418395416, 1030.5311083457009, 1053.2837670384213, 1055.3087727538475, 1063.106990128296, 11175.217734758651, 11343.943280283545, 11378.772424551462, 11379.43102844871, 11387.715307117389, 523238.0, 533799.0, 553108.0, 558851.0, 563077.0, 133246.33376833054, 137139.0, 138499.0, 141240.0, 142790.0, 1213.0, 1245.975080498403, 1282.6280378690076, 1287.0668765145383, 1288.375138058041, 17691.38080167188, 22267.665985009913, 22402.0, 22442.887785560968, 22646.773532264466, 54591.0, 54755.0, 55405.44594554164, 56197.94267452377, 56494.0, 72275.0, 72448.0, 72454.63772681102, 72663.63668181625, 72830.63584682043, 8791.164839340252, 8852.778680532781, 8871.979722332015, 8873.556322183736, 8943.418677785923, 11899.821502677294, 13628.182309061489, 13854.238016908763, 13941.163530188222, 14158.0, 10190.0, 11738.0, 11816.82274765862, 11878.524859005543, 12009.459574319351, 10944.39805810688, 10981.341119532854, 11216.83174752363, 11304.830427543759, 11393.886061139614, 10693.14454843595, 11442.713932151762, 11788.764224715285, 12186.756264874475, 12188.573399931314, 9046.819063618823, 9051.094890510896, 9127.497987610745, 9201.217896478875, 9585.808283834423, 10043.4476103815, 10359.63741269052, 11274.549018039186, 11379.487923043649, 12015.158938874194], "value": 11772.838610368053, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1271.9427625756844, 1462.963425914352, 1481.2297605245267, 1485.2425263115815, 1488.9702205955882, 11490.425478726072, 11552.133589980744, 12107.0, 12178.451969661364, 12240.020798336134, 11919.523219071227, 12121.272723636588, 12154.453049612766, 12155.690418820417, 12166.756664866698, 2544.6055861341474, 2567.0501914291644, 2585.5346037713202, 2587.780038696713, 2592.5592649249675, 2493.227099599121, 2545.16009716793, 2545.1600971679395, 2549.490101979602, 2551.4259291659414, 2506.8245222834407, 2526.103233352161, 2547.0703193334484, 2554.0167035691206, 2554.9872250638723, 2485.1674688979215, 2517.811164162695, 2537.8857951392233, 2551.9744802551922, 2560.244727805302, 1995.2418081129078, 2050.3131450963947, 2518.382996165951, 2526.0401047601977, 2582.760275067959, 11973.46119424628, 11991.580294689644, 12059.698507537294, 12088.576899808553, 12101.878981210164, 6603.085105319499, 6836.179658441019, 6841.247462779091, 6872.140982377203, 6879.6560171991705, 3819.3316169670197, 4080.326746086922, 4452.866414007585, 4477.477657596432, 4562.817487300537, 1252.7369252456995, 1260.117917457774, 1328.9601311960657, 1333.646583655332, 1336.265054220175, 16292.755608665879, 16461.83538164615, 16683.499495015047, 16836.915815420845, 16895.15524223796, 5503.697296648643, 5643.7707105693025, 5764.855878603068, 5784.739686714108, 5835.708214589254, 11628.592999244986, 11998.820017699742, 12029.939850300692, 12033.217840840318, 12033.458494367775, 6528.314526974695, 6600.438962688129, 6620.503462240351, 6625.933740662628, 6628.07206991012, 6003.489703375262, 6149.108379285068, 6215.782447614311, 6253.6560489173535, 6310.4636105930595, 4289.785510724451, 4420.801063952065, 4427.22523558376, 4463.352813841975, 4469.7988590513505, 1275.355945247644, 1283.7881749511225, 1295.520657356784, 1301.9414126364336, 1307.0589175793605, 774.6397924964919, 796.4544287163196, 799.2087833045359, 802.3661307566957, 802.3741481644327, 6780.627065511444, 6985.825354366181, 7070.681819318143, 7125.928740712527, 7147.964260178665, 859.3297228162044, 973.4597298499259, 977.7897751983357, 980.3627642032736, 1009.4548943570536, 3978.6021397860563, 4025.1748391579654, 4100.671946244293, 4104.261232978033, 4313.158934007838, 10316.48417579118, 15105.848941510445, 15140.772888406682, 15159.772603410958, 15166.24168791556, 15039.548813535612, 15059.644631983174, 15065.548033559011, 15068.246587670572, 15068.698626027637, 7550.3582195514, 8163.959180204061, 8749.868751968726, 8919.598618062073, 8933.687320943865, 6689.397954184147, 6783.0, 7138.107736532934, 7309.0, 7346.11846578414, 10407.531661075422, 11528.423578820857, 12244.265344079384, 13288.136271142344, 13511.864881351454, 13639.386227619583, 13715.588532344045, 13799.310034498436, 13820.585382438543, 13869.306534673024, 9402.670906518239, 9449.055094490495, 9519.333646644669, 9527.0, 9548.42709437436, 10660.84008739885, 10722.24944253926, 10847.566097356334, 10851.945740271249, 10860.565577377132, 8174.100848906734, 8338.66645334204, 9225.72322830316, 9253.907460925304, 9332.95333523328, 7512.699492020258, 8931.374803763674, 9018.5941632628, 9046.140616641409, 9056.909430905871, 8304.709335173482, 8325.417220794487, 8326.084130745734, 8380.120087390736, 8394.412391132562, 5069.112905241642, 6089.391060893875, 6193.4425901669065, 6202.100695399052, 6266.905996409966, 5241.9737901310245, 5656.434356564475, 6003.309619393825, 6282.183316168869, 6283.654399008098], "value": 5421.798999087256, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.1814893351628, 392.952845658521, 403.9676825853932, 408.8562419874572, 416.46276303568396, 5425.077736784746, 5484.862878428036, 6521.967390163042, 6559.442447391977, 6578.539502234846, 5102.77037533311, 6074.817755467332, 6241.531885108612, 6333.778317758879, 6374.310807635969, 4650.767461626922, 4689.788959496814, 4692.272697731857, 4708.717476951377, 4737.66836321456, 4605.907881842361, 4713.528647135293, 4719.43366795985, 4721.244600863863, 4747.003129342842, 4606.60843828275, 4607.239805432099, 4609.262517997121, 4633.4208223972, 4678.508756580561, 3745.831437585288, 4536.616332018733, 4601.608863246628, 4627.0, 4636.26140197426, 3346.3474622448634, 3654.2326111516613, 3973.7615743055508, 3978.9602103978877, 3979.920401591981, 5680.744366503476, 6333.271673757485, 6354.2025770543405, 6365.713542890581, 6390.744370225186, 4625.629949604057, 5542.0, 5568.721563921828, 5569.944300556983, 5572.718274796779, 6117.635300584705, 6360.2367715873925, 6698.296678848748, 6883.793486195422, 6927.376536111774, 3971.98014009931, 4131.669466442678, 4498.0104377037, 4515.661325400608, 4544.840930567414, 6394.904076438857, 7090.858182836366, 7286.781396558112, 7365.373943214833, 7376.0, 3809.790461524643, 4531.84138555149, 4566.840160594364, 4568.926302318952, 4580.427446569179, 4653.162430762495, 4657.254839225775, 4664.906701865943, 4667.556582124693, 4680.110778951988, 5368.516833485005, 5505.834824955257, 5556.666600004012, 5557.194206839986, 5588.736561692521, 5991.610545314627, 6336.20797400325, 6512.41388275048, 6853.040574319599, 6921.446284297244, 1575.7715131306127, 1580.865626421744, 1586.6350739330019, 1596.9520914372588, 1599.5201439568316, 1029.8867124616286, 1032.3444612670858, 1033.34382667007, 1039.8856125826153, 1042.6142327338932, 5770.88458230833, 6016.518678505709, 6575.80272591823, 6581.440577550866, 6584.473242140617, 6668.433183179484, 7037.19072306681, 7126.821829454201, 7219.267375829763, 7223.313785190504, 5483.725813709299, 5718.456016875503, 6516.380943810331, 6528.771492997817, 6556.8360790980605, 2865.899693510759, 3124.2970331675647, 3164.493681011073, 3301.4552598820924, 3608.8376023079027, 5569.516539185914, 6812.829679258059, 7456.1798202197715, 7468.738594149178, 7479.214682458372, 6126.6017708848785, 7246.202917679051, 7356.96321518389, 7423.369013633794, 7459.762071378674, 7256.8911466328045, 7422.294881986203, 7430.219826918204, 7436.405087593088, 7438.033055702832, 5603.747831347518, 6263.874722505616, 6309.652969086745, 6777.423918966943, 7244.0, 6172.814815555541, 6796.9753459709955, 6943.153307144249, 7103.289671032855, 7113.822154445973, 6109.144719739329, 6138.877222455437, 6497.960326347951, 7513.347063645989, 7537.585432801248, 4580.679352445297, 4592.0815836833435, 4597.42532183477, 4597.908041839078, 4602.102589994919, 6160.260768707783, 6541.2477565078725, 7217.24218957002, 7262.656408564432, 7319.817004574928, 6282.403171698864, 6914.51598388108, 7030.894536582057, 7047.736119647539, 7058.753003591755, 5667.2349232854685, 6635.469162467088, 6926.341997510229, 7003.404710599656, 7010.754623588354, 6352.237731472253, 6715.951634751447, 6799.572089861184, 6837.0, 6917.308269173042, 6800.693968771516, 6922.238553758982, 6966.965165174344, 6999.930000699927, 7040.718371265092, 6333.556651034383, 6749.898751518829, 6793.4565234782085, 6838.076859624086, 6870.965645171742], "value": 4936.0105691026665, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.8005078654157, 826.520618041536, 838.9244967952883, 860.7648025084003, 862.1034124510505, 16467.341306347746, 17105.14474276286, 17106.572335691613, 18124.728129078074, 19471.026448677545, 17984.190711417985, 18311.084445777724, 18381.98899060551, 18546.721799173025, 18684.719729204073, 986.2011770465909, 996.9003099690027, 1006.1950439648289, 1011.7521207304221, 1012.1750773119884, 755.395683453238, 987.6049580167919, 1011.6661501704457, 1018.2108865629123, 1021.2646894236138, 1041.182671602792, 1051.4007016000883, 1052.9262951593391, 1053.4048262731571, 1053.978920421595, 1039.77644806367, 1042.2860340666668, 1047.282611411182, 1047.4657924458581, 1048.6015314180602, 771.4291424346, 773.2113244490645, 774.9690012399498, 777.0054330456968, 777.2848978939389, 14205.431782728678, 16695.332186712516, 16974.575635609086, 17098.658026839392, 17376.304947802073, 17045.23296451663, 17497.650046998988, 17504.64990700179, 17708.91145544277, 17849.553761155945, 14006.509772157926, 14108.647283817883, 14163.179916317951, 14163.929180354033, 14299.428022879072, 3508.6842184203288, 3535.8939231823088, 3536.29274145172, 3539.8761043363615, 3541.2740388220354, 102124.0, 119866.80133198731, 122138.16792748116, 130591.0, 135260.32369838087, 13220.735585288241, 13314.0, 13318.600441986757, 13388.598342049754, 13567.660808479866, 23692.289231323088, 25677.229683109163, 25719.742802571735, 25944.481110378063, 26116.73883261143, 7905.01187351581, 8044.637991290406, 8062.274395304334, 8121.228483294078, 8133.227343402367, 3917.5298964123917, 3992.640662340403, 4046.2918989177365, 4073.7555746655294, 4083.387491876242, 3940.6847452203756, 4226.408302837605, 4290.635295999875, 4325.697201195949, 4333.349997500337, 724.644923987253, 948.5399581203111, 949.0746522140857, 950.1496160935924, 950.3680052764972, 622.7104396455579, 649.9577527460794, 662.9469642428594, 681.0193321616856, 681.2914568848342, 10853.782924341469, 11425.771484570261, 11477.426128693698, 11899.286042837457, 12231.69420764488, 569.2741754263348, 627.4071002902214, 633.8637193003526, 659.9274079851212, 663.2869665110026, 4093.5292441369625, 4563.429571303587, 4931.3589233399425, 5251.474852514794, 5408.78364865401, 93066.0, 106076.40885386725, 108163.0, 109284.0, 111522.0, 77490.0, 81993.18006819974, 90286.0, 90426.0, 91418.7145321359, 84064.0, 84522.0, 85742.0, 86296.56851715827, 87110.0, 10672.83990740155, 10730.517126729472, 10851.294665846695, 10893.128549716163, 11073.612423565459, 36040.0, 38019.80990095032, 41587.376189356575, 43119.56880431156, 43460.56539434565, 54557.0, 68078.65960670165, 71474.0, 74272.42956778155, 76164.0, 13594.592162235149, 16471.25879335409, 17071.573210669834, 17324.913375433043, 17335.739963900298, 17937.0, 17975.37086202029, 18373.056943502223, 18786.6242675143, 19018.52453688669, 16139.838601614303, 16994.980301181968, 17299.0, 17313.307467701656, 17361.30554777795, 16593.75109373336, 17348.132593370534, 17373.21820518105, 17380.652386952443, 17506.73739893928, 16200.687477516936, 16497.257623407215, 16823.579410514834, 17150.313987440863, 17175.65648687044, 11796.94101529487, 11829.881701182878, 12055.336956467478, 12107.84975427333, 12517.374131293582, 12840.743185136433, 13945.233012184428, 14074.78887816704, 14149.36327865228, 14204.28978551089], "value": 8440.675380228746, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 111.0, 99.0, 135.0, 95.0, 169.0, 171.0, 166.0, 114.0], "value": 128.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 113.0, 113.0, 172.0, 140.0, 103.0, 115.0, 131.0, 149.0, 139.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 196.0, 205.0, 215.0, 191.0, 252.0, 211.0, 281.0, 241.0, 197.0], "value": 219.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 56.0, 60.0, 81.0, 56.0, 62.0, 60.0, 58.0, 77.0, 59.0], "value": 64.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 81.0, 71.0, 68.0, 71.0, 81.0, 92.0, 96.0, 78.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 89.0, 90.0, 90.0, 90.0, 114.0, 93.0, 89.0, 92.0, 89.0], "value": 93.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 96.0, 96.0, 107.0, 114.0, 97.0, 98.0, 96.0, 98.0], "value": 99.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 99.0, 93.0, 92.0, 90.0, 91.0, 91.0, 84.0, 149.0, 150.0], "value": 103.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 48.0, 51.0, 51.0, 54.0, 51.0, 52.0, 52.0, 51.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 54.0, 60.0, 56.0, 72.0, 60.0, 59.0, 77.0, 83.0, 83.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 85.0, 83.0, 81.0, 84.0, 85.0, 83.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 148.0, 149.0, 153.0, 144.0, 154.0, 127.0, 200.0, 154.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 185.0, 186.0, 222.0, 182.0, 219.0, 231.0, 197.0, 182.0], "value": 197.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 70.0, 70.0, 70.0, 70.0, 68.0, 65.0, 71.0, 69.0], "value": 68.9, "unit": "score"}]}]} 09:43:45 INFO - Return code: 0 09:43:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:43:45 INFO - # TBPL SUCCESS # 09:43:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:43:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:43:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:43:45 INFO - 2017-05-05 09:43:45.890 screenresolution[1915:12112] starting screenresolution argv=screenresolution get 09:43:45 INFO - 2017-05-05 09:43:45.893 screenresolution[1915:12112] Display 0: 1600x1200x32@60 09:43:45 INFO - 2017-05-05 09:43:45.899 screenresolution[1916:12115] starting screenresolution argv=screenresolution list 09:43:45 INFO - Available Modes on Display 0 09:43:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:43:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:43:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:43:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:43:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:43:46 INFO - Intel Iris: 09:43:46 INFO - Chipset Model: Intel Iris 09:43:46 INFO - Type: GPU 09:43:46 INFO - Bus: Built-In 09:43:46 INFO - VRAM (Dynamic, Max): 1536 MB 09:43:46 INFO - Vendor: Intel (0x8086) 09:43:46 INFO - Device ID: 0x0a2e 09:43:46 INFO - Revision ID: 0x0009 09:43:46 INFO - Displays: 09:43:46 INFO - Display: 09:43:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:43:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:43:46 INFO - Display Serial Number: 1600x1200 60 09:43:46 INFO - Main Display: Yes 09:43:46 INFO - Mirror: Off 09:43:46 INFO - Online: Yes 09:43:46 INFO - Rotation: Supported 09:43:46 INFO - Return code: 0 09:43:46 INFO - Running post-action listener: _resource_record_post_action 09:43:46 INFO - [mozharness: 2017-05-05 16:43:46.142408Z] Finished run-tests step (success) 09:43:46 INFO - Running post-run listener: _resource_record_post_run 09:43:46 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 3090432; Write bytes: 512468992; Read time: 25; Write time: 1605 09:43:46 INFO - TinderboxPrint: CPU usage
54.1% 09:43:46 INFO - TinderboxPrint: I/O read bytes / time
3,090,432 / 25 09:43:46 INFO - TinderboxPrint: I/O write bytes / time
512,468,992 / 1,605 09:43:46 INFO - TinderboxPrint: CPU idle
2,196.5 (45.9%) 09:43:46 INFO - TinderboxPrint: CPU system
962.1 (20.1%) 09:43:46 INFO - TinderboxPrint: CPU user
1,631.0 (34.1%) 09:43:46 INFO - TinderboxPrint: Swap in / out
212,189,184 / 0 09:43:46 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209293824; Write bytes: 212359168; Read time: 16206; Write time: 448 09:43:46 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 2189312; Write bytes: 298532864; Read time: 22; Write time: 1145 09:43:46 INFO - Running post-run listener: _upload_blobber_files 09:43:46 INFO - Blob upload gear active. 09:43:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:43:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:43:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:43:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:43:47 INFO - (blobuploader) - INFO - Open directory for files ... 09:43:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:43:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:43:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:47 INFO - (blobuploader) - INFO - Done attempting. 09:43:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:43:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:43:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:48 INFO - (blobuploader) - INFO - Done attempting. 09:43:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:43:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:43:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:49 INFO - (blobuploader) - INFO - Done attempting. 09:43:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:43:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:43:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:51 INFO - (blobuploader) - INFO - Done attempting. 09:43:51 INFO - (blobuploader) - INFO - Iteration through files over. 09:43:51 INFO - Return code: 0 09:43:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:43:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:43:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f493771221cb22a187a0f88512c9be4496144e6f1164c8b3ce40c57684087c4b9bfcd031ee3601d0bf5419cbb54cb7cbbdaa38fc0d95a267ab19ac69f150fa1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c883f0b2419dbe88de96b833df9397b41b4a04560b8dffffa3bf976f196f439fc5fa6677c1ce801fae2cc836af29303f9a0335e4d1faa4d620e7de7220cd16ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4299616b45d2c55aa31146e1e96abfd1207128821deefa78c8efeaf5a50e9911db07ff36a500f4a504b76dbff62604edeada221049b01ae016696e229a6c888f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/304391af73ca29c026935eb5785bd746bdea472550874c506dd728d21d346fe579003fb88124c3e4ee5ffdf7429affdc21de643404cdfa5394fad5a8874aa7fb"} 09:43:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:43:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:43:51 INFO - Contents: 09:43:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f493771221cb22a187a0f88512c9be4496144e6f1164c8b3ce40c57684087c4b9bfcd031ee3601d0bf5419cbb54cb7cbbdaa38fc0d95a267ab19ac69f150fa1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c883f0b2419dbe88de96b833df9397b41b4a04560b8dffffa3bf976f196f439fc5fa6677c1ce801fae2cc836af29303f9a0335e4d1faa4d620e7de7220cd16ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4299616b45d2c55aa31146e1e96abfd1207128821deefa78c8efeaf5a50e9911db07ff36a500f4a504b76dbff62604edeada221049b01ae016696e229a6c888f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/304391af73ca29c026935eb5785bd746bdea472550874c506dd728d21d346fe579003fb88124c3e4ee5ffdf7429affdc21de643404cdfa5394fad5a8874aa7fb"} 09:43:51 INFO - Running post-run listener: copy_logs_to_upload_dir 09:43:51 INFO - Copying logs to upload dir... 09:43:51 INFO - mkdir: /builds/slave/test/build/upload/logs 09:43:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.257153 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-05-05 09:43:51.987666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 09:43:51.991252) ========= 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.KPNlouIT63/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.1OzCEjt1du/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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/5f493771221cb22a187a0f88512c9be4496144e6f1164c8b3ce40c57684087c4b9bfcd031ee3601d0bf5419cbb54cb7cbbdaa38fc0d95a267ab19ac69f150fa1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c883f0b2419dbe88de96b833df9397b41b4a04560b8dffffa3bf976f196f439fc5fa6677c1ce801fae2cc836af29303f9a0335e4d1faa4d620e7de7220cd16ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4299616b45d2c55aa31146e1e96abfd1207128821deefa78c8efeaf5a50e9911db07ff36a500f4a504b76dbff62604edeada221049b01ae016696e229a6c888f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/304391af73ca29c026935eb5785bd746bdea472550874c506dd728d21d346fe579003fb88124c3e4ee5ffdf7429affdc21de643404cdfa5394fad5a8874aa7fb"} build_url:https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/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/5f493771221cb22a187a0f88512c9be4496144e6f1164c8b3ce40c57684087c4b9bfcd031ee3601d0bf5419cbb54cb7cbbdaa38fc0d95a267ab19ac69f150fa1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c883f0b2419dbe88de96b833df9397b41b4a04560b8dffffa3bf976f196f439fc5fa6677c1ce801fae2cc836af29303f9a0335e4d1faa4d620e7de7220cd16ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4299616b45d2c55aa31146e1e96abfd1207128821deefa78c8efeaf5a50e9911db07ff36a500f4a504b76dbff62604edeada221049b01ae016696e229a6c888f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/304391af73ca29c026935eb5785bd746bdea472550874c506dd728d21d346fe579003fb88124c3e4ee5ffdf7429affdc21de643404cdfa5394fad5a8874aa7fb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 09:43:52.030909) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 09:43:52.031231) ========= 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.KPNlouIT63/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.1OzCEjt1du/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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.005280 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 09:43:52.080692) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 09:43:52.081231) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 09:43:52.081782) ========= ========= Total master_lag: 2.10 =========