builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0325 starttime: 1494522428.08 results: success (0) buildid: 20170511081624 builduid: 378454648bbb45088226a6d5db3691fd revision: a6cafa6b8a6f82b67b5a9cb26d5dc0fe72b7fac7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 10:07:08.080607) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 10:07:08.081044) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 10:07:08.081343) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 10:07:08.107061) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 10:07:08.107399) ========= 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.PP7fEZ8BD1/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.CUITJNsjgh/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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-11 10:07:08-- 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% 19.3M=0.001s 2017-05-11 10:07:08 (19.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136034 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 10:07:08.266663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 10:07:08.267030) ========= 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.PP7fEZ8BD1/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.CUITJNsjgh/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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.026474 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 10:07:08.315447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-11 10:07:08.315807) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a6cafa6b8a6f82b67b5a9cb26d5dc0fe72b7fac7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a6cafa6b8a6f82b67b5a9cb26d5dc0fe72b7fac7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PP7fEZ8BD1/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.CUITJNsjgh/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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-11 10:07:08,421 truncating revision to first 12 chars 2017-05-11 10:07:08,422 Setting DEBUG logging. 2017-05-11 10:07:08,422 attempt 1/10 2017-05-11 10:07:08,422 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a6cafa6b8a6f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-11 10:07:09,726 unpacking tar archive at: mozilla-beta-a6cafa6b8a6f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.573338 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-11 10:07:09.911244) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 10:07:09.911578) ========= script_repo_revision: a6cafa6b8a6f82b67b5a9cb26d5dc0fe72b7fac7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 10:07:09.911973) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 10:07:09.912235) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 10:07:09.931011) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 41 mins, 17 secs) (at 2017-05-11 10:07:09.931326) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PP7fEZ8BD1/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.CUITJNsjgh/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:07:10 INFO - MultiFileLogger online at 20170511 10:07:10 in /builds/slave/test 10:07:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:07:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:07:10 INFO - {'append_to_log': False, 10:07:10 INFO - 'base_work_dir': '/builds/slave/test', 10:07:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:07:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:07:10 INFO - 'branch': 'Mozilla-Beta', 10:07:10 INFO - 'buildbot_json_path': 'buildprops.json', 10:07:10 INFO - 'config_files': ('talos/mac_config.py',), 10:07:10 INFO - 'default_actions': ('clobber', 10:07:10 INFO - 'read-buildbot-config', 10:07:10 INFO - 'download-and-extract', 10:07:10 INFO - 'populate-webroot', 10:07:10 INFO - 'create-virtualenv', 10:07:10 INFO - 'install', 10:07:10 INFO - 'run-tests'), 10:07:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:07:10 INFO - 'download_minidump_stackwalk': True, 10:07:10 INFO - 'download_symbols': 'ondemand', 10:07:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:07:10 INFO - 'tooltool.py': '/tools/tooltool.py', 10:07:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:07:10 INFO - '/tools/misc-python/virtualenv.py')}, 10:07:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:07:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:07:10 INFO - 'gecko_profile': False, 10:07:10 INFO - 'gecko_profile_interval': 0, 10:07:10 INFO - 'installer_path': 'installer.exe', 10:07:10 INFO - 'log_level': 'info', 10:07:10 INFO - 'log_name': 'talos', 10:07:10 INFO - 'log_to_console': True, 10:07:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:07:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:07:10 INFO - 'opt_config_files': (), 10:07:10 INFO - 'pip_index': False, 10:07:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:07:10 INFO - 'cmd': ('bash', 10:07:10 INFO - '-c', 10:07:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:07:10 INFO - 'enabled': True, 10:07:10 INFO - 'halt_on_failure': False, 10:07:10 INFO - 'name': 'check_screen_resolution'},), 10:07:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:07:10 INFO - 'cmd': ('bash', 10:07:10 INFO - '-c', 10:07:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:07:10 INFO - 'enabled': True, 10:07:10 INFO - 'halt_on_failure': False, 10:07:10 INFO - 'name': 'check_screen_resolution'},), 10:07:10 INFO - 'run_cmd_checks_enabled': True, 10:07:10 INFO - 'suite': 'dromaeojs-e10s', 10:07:10 INFO - 'system_bits': '32', 10:07:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:07:10 INFO - 'title': 't-yosemite-r7-0325', 10:07:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:07:10 INFO - 'use_talos_json': True, 10:07:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:07:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:07:10 INFO - 'work_dir': 'build'} 10:07:10 INFO - [mozharness: 2017-05-11 17:07:10.144288Z] Running clobber step. 10:07:10 INFO - Running pre-action listener: _resource_record_pre_action 10:07:10 INFO - Running main action method: clobber 10:07:10 INFO - rmtree: /builds/slave/test/build 10:07:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:07:12 INFO - Running post-action listener: _resource_record_post_action 10:07:12 INFO - [mozharness: 2017-05-11 17:07:12.559694Z] Finished clobber step (success) 10:07:12 INFO - [mozharness: 2017-05-11 17:07:12.559863Z] Running read-buildbot-config step. 10:07:12 INFO - Running pre-action listener: _resource_record_pre_action 10:07:12 INFO - Running main action method: read_buildbot_config 10:07:12 INFO - Using buildbot properties: 10:07:12 INFO - { 10:07:12 INFO - "project": "", 10:07:12 INFO - "product": "firefox", 10:07:12 INFO - "script_repo_revision": "production", 10:07:12 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 10:07:12 INFO - "repository": "", 10:07:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 10:07:12 INFO - "buildid": "20170511081624", 10:07:12 INFO - "pgo_build": "False", 10:07:12 INFO - "basedir": "/builds/slave/test", 10:07:12 INFO - "buildnumber": 2, 10:07:12 INFO - "slavename": "t-yosemite-r7-0325", 10:07:12 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 10:07:12 INFO - "platform": "yosemite_r7", 10:07:12 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:07:12 INFO - "branch": "mozilla-beta", 10:07:12 INFO - "repo_path": "releases/mozilla-beta", 10:07:12 INFO - "revision": "a6cafa6b8a6f82b67b5a9cb26d5dc0fe72b7fac7", 10:07:12 INFO - "stage_platform": "macosx64", 10:07:12 INFO - "builduid": "378454648bbb45088226a6d5db3691fd", 10:07:12 INFO - "slavebuilddir": "test" 10:07:12 INFO - } 10:07:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 10:07:12 INFO - Running post-action listener: _resource_record_post_action 10:07:12 INFO - [mozharness: 2017-05-11 17:07:12.563108Z] Finished read-buildbot-config step (success) 10:07:12 INFO - [mozharness: 2017-05-11 17:07:12.563237Z] Running download-and-extract step. 10:07:12 INFO - Running pre-action listener: _resource_record_pre_action 10:07:12 INFO - Running main action method: download_and_extract 10:07:12 INFO - mkdir: /builds/slave/test/build/tests 10:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:12 INFO - trying https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 10:07:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:07:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 10:07:13 INFO - Downloaded 1287 bytes. 10:07:13 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:07:13 INFO - Using the following test package requirements: 10:07:13 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:07:13 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 10:07:13 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:07:13 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:07:13 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 10:07:13 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:07:13 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 10:07:13 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:07:13 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:07:13 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 10:07:13 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:07:13 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:07:13 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 10:07:13 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:07:13 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 10:07:13 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:07:13 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 10:07:13 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:07:13 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 10:07:13 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 10:07:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:07:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:07:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:07:15 INFO - Expected file size: 51225517 10:07:15 INFO - Obtained file size: 51225517 10:07:31 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:07:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:07:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:07:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:07:33 INFO - Expected file size: 51225517 10:07:33 INFO - Obtained file size: 51225517 10:07:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 10:07:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 10:07:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 10:07:48 INFO - Expected file size: 14404449 10:07:48 INFO - Obtained file size: 14404449 10:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:49 INFO - trying https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:07:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 10:07:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 10:07:50 INFO - Downloaded 59563067 bytes. 10:07:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:07:50 INFO - mkdir: /builds/slave/test/properties 10:07:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:07:50 INFO - Writing to file /builds/slave/test/properties/build_url 10:07:50 INFO - Contents: 10:07:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:07:51 INFO - Running post-action listener: _resource_record_post_action 10:07:51 INFO - Running post-action listener: set_extra_try_arguments 10:07:51 INFO - [mozharness: 2017-05-11 17:07:51.621543Z] Finished download-and-extract step (success) 10:07:51 INFO - [mozharness: 2017-05-11 17:07:51.621650Z] Running populate-webroot step. 10:07:51 INFO - Running pre-action listener: _resource_record_pre_action 10:07:51 INFO - Running main action method: populate_webroot 10:07:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:07:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:07:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:07:51 INFO - '--tppagecycles', 10:07:51 INFO - '7'], 10:07:51 INFO - 'tests': ['tsvgm']}}, 10:07:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:07:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:07:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:07:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:07:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:07:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:07:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:07:51 INFO - 'talos_options': ['--disable-e10s'], 10:07:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:07:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:07:51 INFO - 'talos_options': ['--disable-e10s'], 10:07:51 INFO - 'tests': ['damp', 'tps']}, 10:07:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:07:51 INFO - 'tests': ['damp', 'tps']}, 10:07:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:07:51 INFO - 'tests': ['dromaeo_dom']}, 10:07:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:07:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:07:51 INFO - 'tests': ['basic_compositor_video']}, 10:07:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:07:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:07:51 INFO - 'tests': ['a11yr', 10:07:51 INFO - 'ts_paint', 10:07:51 INFO - 'tpaint', 10:07:51 INFO - 'sessionrestore', 10:07:51 INFO - 'sessionrestore_no_auto_restore', 10:07:51 INFO - 'tabpaint']}, 10:07:51 INFO - 'other-e10s': {'tests': ['a11yr', 10:07:51 INFO - 'ts_paint', 10:07:51 INFO - 'tpaint', 10:07:51 INFO - 'sessionrestore', 10:07:51 INFO - 'sessionrestore_no_auto_restore', 10:07:51 INFO - 'tabpaint']}, 10:07:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:07:51 INFO - 'ts_paint', 10:07:51 INFO - 'tpaint', 10:07:51 INFO - 'sessionrestore', 10:07:51 INFO - 'sessionrestore_no_auto_restore', 10:07:51 INFO - 'tabpaint']}, 10:07:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:07:51 INFO - 'ts_paint', 10:07:51 INFO - 'tpaint', 10:07:51 INFO - 'sessionrestore', 10:07:51 INFO - 'sessionrestore_no_auto_restore', 10:07:51 INFO - 'tabpaint']}, 10:07:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:07:51 INFO - 'tests': ['a11yr', 10:07:51 INFO - 'ts_paint', 10:07:51 INFO - 'tpaint', 10:07:51 INFO - 'sessionrestore', 10:07:51 INFO - 'sessionrestore_no_auto_restore', 10:07:51 INFO - 'tabpaint']}, 10:07:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:07:51 INFO - 'tests': ['a11yr', 10:07:51 INFO - 'ts_paint', 10:07:51 INFO - 'tpaint', 10:07:51 INFO - 'sessionrestore', 10:07:51 INFO - 'sessionrestore_no_auto_restore', 10:07:51 INFO - 'tabpaint']}, 10:07:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:07:51 INFO - 'tests': ['tsvgx', 10:07:51 INFO - 'tsvgr_opacity', 10:07:51 INFO - 'tart', 10:07:51 INFO - 'tscrollx', 10:07:51 INFO - 'cart', 10:07:51 INFO - 'tsvg_static']}, 10:07:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:07:51 INFO - 'tsvgr_opacity', 10:07:51 INFO - 'tart', 10:07:51 INFO - 'tscrollx', 10:07:51 INFO - 'cart', 10:07:51 INFO - 'tsvg_static']}, 10:07:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:07:51 INFO - 'talos_options': ['--disable-e10s'], 10:07:51 INFO - 'tests': ['tp5o']}, 10:07:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:07:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:07:51 INFO - 'talos_options': ['--disable-e10s', 10:07:51 INFO - '--xperf_path', 10:07:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:51 INFO - 'tests': ['tp5n']}, 10:07:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:07:51 INFO - 'talos_options': ['--xperf_path', 10:07:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:51 INFO - 'tests': ['tp5n']}}, 10:07:51 INFO - 'talos.zip': {'path': '', 10:07:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:07:51 INFO - Running post-action listener: _resource_record_post_action 10:07:51 INFO - [mozharness: 2017-05-11 17:07:51.639720Z] Finished populate-webroot step (success) 10:07:51 INFO - [mozharness: 2017-05-11 17:07:51.639853Z] Running create-virtualenv step. 10:07:51 INFO - Running pre-action listener: _resource_record_pre_action 10:07:51 INFO - Running main action method: create_virtualenv 10:07:51 INFO - Creating virtualenv /builds/slave/test/build/venv 10:07:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:07:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:07:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:07:51 INFO - Using real prefix '/tools/python27' 10:07:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:07:52 INFO - Installing distribute.............................................................................................................................................................................................done. 10:07:55 INFO - Installing pip.................done. 10:07:55 INFO - Return code: 0 10:07:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:07:55 INFO - Reading from file tmpfile_stdout 10:07:55 INFO - Output received: 10:07:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:07:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:55 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 0x1059aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fb4cc280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105788d30>, '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 0x1056afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10577dbe8>, '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.PP7fEZ8BD1/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.CUITJNsjgh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:07:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:07:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PP7fEZ8BD1/Render', 10:07:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:07:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:07:55 INFO - 'HOME': '/Users/cltbld', 10:07:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:07:55 INFO - 'LOGNAME': 'cltbld', 10:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:55 INFO - 'MOZ_NO_REMOTE': '1', 10:07:55 INFO - 'NO_EM_RESTART': '1', 10:07:55 INFO - 'PAGER': '/bin/cat', 10:07:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:55 INFO - 'PWD': '/builds/slave/test', 10:07:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:07:55 INFO - 'SHELL': '/bin/bash', 10:07:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CUITJNsjgh/Listeners', 10:07:55 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 10:07:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:07:55 INFO - 'USER': 'cltbld', 10:07:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:07:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:55 INFO - 'XPC_FLAGS': '0x0', 10:07:55 INFO - 'XPC_SERVICE_NAME': '0', 10:07:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:07:55 INFO - Cleaning up... 10:07:55 INFO - Return code: 0 10:07:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:55 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 0x1059aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fb4cc280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105788d30>, '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 0x1056afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10577dbe8>, '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.PP7fEZ8BD1/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.CUITJNsjgh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:07:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:07:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PP7fEZ8BD1/Render', 10:07:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:07:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:07:55 INFO - 'HOME': '/Users/cltbld', 10:07:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:07:55 INFO - 'LOGNAME': 'cltbld', 10:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:55 INFO - 'MOZ_NO_REMOTE': '1', 10:07:55 INFO - 'NO_EM_RESTART': '1', 10:07:55 INFO - 'PAGER': '/bin/cat', 10:07:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:55 INFO - 'PWD': '/builds/slave/test', 10:07:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:07:55 INFO - 'SHELL': '/bin/bash', 10:07:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CUITJNsjgh/Listeners', 10:07:55 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 10:07:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:07:55 INFO - 'USER': 'cltbld', 10:07:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:07:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:55 INFO - 'XPC_FLAGS': '0x0', 10:07:55 INFO - 'XPC_SERVICE_NAME': '0', 10:07:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:56 INFO - Downloading/unpacking psutil>=3.1.1 10:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:10:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:28 INFO - Installing collected packages: psutil 10:10:28 INFO - Running setup.py install for psutil 10:10:28 INFO - building 'psutil._psutil_osx' extension 10:10:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:10:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:10:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:10:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:10:29 INFO - building 'psutil._psutil_posix' extension 10:10:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:10:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:10:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:10:29 INFO - ^ 10:10:29 INFO - 1 warning generated. 10:10:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:10:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:29 INFO - Successfully installed psutil 10:10:29 INFO - Cleaning up... 10:10:29 INFO - Return code: 0 10:10:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:30 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 0x1059aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fb4cc280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105788d30>, '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 0x1056afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10577dbe8>, '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.PP7fEZ8BD1/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.CUITJNsjgh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:10:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:10:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PP7fEZ8BD1/Render', 10:10:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:30 INFO - 'HOME': '/Users/cltbld', 10:10:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:30 INFO - 'LOGNAME': 'cltbld', 10:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:30 INFO - 'MOZ_NO_REMOTE': '1', 10:10:30 INFO - 'NO_EM_RESTART': '1', 10:10:30 INFO - 'PAGER': '/bin/cat', 10:10:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:30 INFO - 'PWD': '/builds/slave/test', 10:10:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:30 INFO - 'SHELL': '/bin/bash', 10:10:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CUITJNsjgh/Listeners', 10:10:30 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 10:10:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:30 INFO - 'USER': 'cltbld', 10:10:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:30 INFO - 'XPC_FLAGS': '0x0', 10:10:30 INFO - 'XPC_SERVICE_NAME': '0', 10:10:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:13:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:13:03 INFO - Installing collected packages: mozsystemmonitor 10:13:03 INFO - Running setup.py install for mozsystemmonitor 10:13:03 INFO - Successfully installed mozsystemmonitor 10:13:03 INFO - Cleaning up... 10:13:03 INFO - Return code: 0 10:13:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:04 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 0x1059aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fb4cc280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105788d30>, '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 0x1056afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10577dbe8>, '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.PP7fEZ8BD1/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.CUITJNsjgh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:13:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PP7fEZ8BD1/Render', 10:13:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:04 INFO - 'HOME': '/Users/cltbld', 10:13:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:04 INFO - 'LOGNAME': 'cltbld', 10:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:04 INFO - 'MOZ_NO_REMOTE': '1', 10:13:04 INFO - 'NO_EM_RESTART': '1', 10:13:04 INFO - 'PAGER': '/bin/cat', 10:13:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:04 INFO - 'PWD': '/builds/slave/test', 10:13:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:04 INFO - 'SHELL': '/bin/bash', 10:13:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CUITJNsjgh/Listeners', 10:13:04 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 10:13:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:04 INFO - 'USER': 'cltbld', 10:13:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:04 INFO - 'XPC_FLAGS': '0x0', 10:13:04 INFO - 'XPC_SERVICE_NAME': '0', 10:13:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:05 INFO - Downloading/unpacking jsonschema==2.5.1 10:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:15:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:18:08 INFO - Downloading functools32-3.2.3-2.tar.gz 10:18:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:18:08 INFO - warning: no files found matching '*.txt' 10:18:08 INFO - no previously-included directories found matching 'build' 10:18:08 INFO - no previously-included directories found matching 'dist' 10:18:08 INFO - no previously-included directories found matching '.git*' 10:18:08 INFO - Installing collected packages: jsonschema, functools32 10:18:08 INFO - Running setup.py install for functools32 10:18:08 INFO - warning: no files found matching '*.txt' 10:18:08 INFO - no previously-included directories found matching 'build' 10:18:08 INFO - no previously-included directories found matching 'dist' 10:18:08 INFO - no previously-included directories found matching '.git*' 10:18:08 INFO - Successfully installed jsonschema functools32 10:18:08 INFO - Cleaning up... 10:18:08 INFO - Return code: 0 10:18:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:18: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')]} 10:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18: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')]} 10:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:10 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 0x1059aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fb4cc280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105788d30>, '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 0x1056afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10577dbe8>, '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.PP7fEZ8BD1/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.CUITJNsjgh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:18:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:18:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PP7fEZ8BD1/Render', 10:18:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:10 INFO - 'HOME': '/Users/cltbld', 10:18:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:10 INFO - 'LOGNAME': 'cltbld', 10:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:10 INFO - 'MOZ_NO_REMOTE': '1', 10:18:10 INFO - 'NO_EM_RESTART': '1', 10:18:10 INFO - 'PAGER': '/bin/cat', 10:18:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:10 INFO - 'PWD': '/builds/slave/test', 10:18:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:10 INFO - 'SHELL': '/bin/bash', 10:18:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CUITJNsjgh/Listeners', 10:18:10 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 10:18:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:10 INFO - 'USER': 'cltbld', 10:18:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:10 INFO - 'XPC_FLAGS': '0x0', 10:18:10 INFO - 'XPC_SERVICE_NAME': '0', 10:18:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:18:10 INFO - Cleaning up... 10:18:10 INFO - Return code: 0 10:18:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:10 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 0x1059aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fb4cc280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105788d30>, '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 0x1056afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10577dbe8>, '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.PP7fEZ8BD1/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.CUITJNsjgh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:18:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:18:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PP7fEZ8BD1/Render', 10:18:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:10 INFO - 'HOME': '/Users/cltbld', 10:18:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:10 INFO - 'LOGNAME': 'cltbld', 10:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:10 INFO - 'MOZ_NO_REMOTE': '1', 10:18:10 INFO - 'NO_EM_RESTART': '1', 10:18:10 INFO - 'PAGER': '/bin/cat', 10:18:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:10 INFO - 'PWD': '/builds/slave/test', 10:18:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:10 INFO - 'SHELL': '/bin/bash', 10:18:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CUITJNsjgh/Listeners', 10:18:10 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 10:18:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:10 INFO - 'USER': 'cltbld', 10:18:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:10 INFO - 'XPC_FLAGS': '0x0', 10:18:10 INFO - 'XPC_SERVICE_NAME': '0', 10:18:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:10 INFO - Downloading/unpacking blobuploader==1.2.4 10:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:42 INFO - Downloading blobuploader-1.2.4.tar.gz 10:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:20:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:23:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:44 INFO - Downloading docopt-0.6.1.tar.gz 10:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:25:44 INFO - Installing collected packages: blobuploader, requests, docopt 10:25:44 INFO - Running setup.py install for blobuploader 10:25:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:25:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:25:45 INFO - Running setup.py install for requests 10:25:45 INFO - Running setup.py install for docopt 10:25:45 INFO - Successfully installed blobuploader requests docopt 10:25:45 INFO - Cleaning up... 10:25:45 INFO - Return code: 0 10:25:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fb4cc280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105788d30>, '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 0x1056afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10577dbe8>, '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.PP7fEZ8BD1/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.CUITJNsjgh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:25:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:25:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PP7fEZ8BD1/Render', 10:25:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:46 INFO - 'HOME': '/Users/cltbld', 10:25:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:46 INFO - 'LOGNAME': 'cltbld', 10:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:46 INFO - 'MOZ_NO_REMOTE': '1', 10:25:46 INFO - 'NO_EM_RESTART': '1', 10:25:46 INFO - 'PAGER': '/bin/cat', 10:25:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:46 INFO - 'PWD': '/builds/slave/test', 10:25:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:46 INFO - 'SHELL': '/bin/bash', 10:25:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CUITJNsjgh/Listeners', 10:25:46 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 10:25:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:46 INFO - 'USER': 'cltbld', 10:25:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:46 INFO - 'XPC_FLAGS': '0x0', 10:25:46 INFO - 'XPC_SERVICE_NAME': '0', 10:25:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:25:46 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-j_G_Cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:25:46 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-TFATB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:25:46 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-YpkT9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:25:46 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-DARhqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:25:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-opZjue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:25:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-dmNJkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:25:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-q7HRYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:25:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-ZUHRfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:25:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-gCfFYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:25:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-k85pyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:25:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-nDCY5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:25:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-ltkxgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:25:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-ZAio5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:25:48 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-3QQvrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:48 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-li4NU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:25:48 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-do6Fl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:25:48 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-lc5T2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:25:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:25:48 INFO - Running setup.py install for manifestparser 10:25:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:25:48 INFO - Running setup.py install for mozcrash 10:25:48 INFO - Running setup.py install for mozdebug 10:25:48 INFO - Running setup.py install for mozdevice 10:25:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:25:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:25:49 INFO - Running setup.py install for mozfile 10:25:49 INFO - Running setup.py install for mozhttpd 10:25:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:25:49 INFO - Running setup.py install for mozinfo 10:25:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:25:49 INFO - Running setup.py install for mozInstall 10:25:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:25:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:25:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:25:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:25:49 INFO - Running setup.py install for mozleak 10:25:49 INFO - Running setup.py install for mozlog 10:25:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:25:50 INFO - Running setup.py install for moznetwork 10:25:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:25:50 INFO - Running setup.py install for mozprocess 10:25:50 INFO - Running setup.py install for mozprofile 10:25:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:25:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:25:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:25:50 INFO - Running setup.py install for mozrunner 10:25:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:25:50 INFO - Running setup.py install for mozscreenshot 10:25:50 INFO - Running setup.py install for moztest 10:25:50 INFO - Running setup.py install for mozversion 10:25:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:25:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:25:51 INFO - Cleaning up... 10:25:51 INFO - Return code: 0 10:25:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fb4cc280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105788d30>, '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 0x1056afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10577dbe8>, '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.PP7fEZ8BD1/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.CUITJNsjgh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:25:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:25:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PP7fEZ8BD1/Render', 10:25:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:51 INFO - 'HOME': '/Users/cltbld', 10:25:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:51 INFO - 'LOGNAME': 'cltbld', 10:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:51 INFO - 'MOZ_NO_REMOTE': '1', 10:25:51 INFO - 'NO_EM_RESTART': '1', 10:25:51 INFO - 'PAGER': '/bin/cat', 10:25:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:51 INFO - 'PWD': '/builds/slave/test', 10:25:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:51 INFO - 'SHELL': '/bin/bash', 10:25:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CUITJNsjgh/Listeners', 10:25:51 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 10:25:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:51 INFO - 'USER': 'cltbld', 10:25:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:51 INFO - 'XPC_FLAGS': '0x0', 10:25:51 INFO - 'XPC_SERVICE_NAME': '0', 10:25:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:25:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-dPXd7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:25:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-cC3ywf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:25:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-7huMh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:25:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-vckBNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:25:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-v91g94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:25:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-AXWFgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:25:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-ruoP8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:25:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-mzg0vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:25:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-5wm9oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:25:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-lmUecK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:25:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-D1DKfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:25:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-LoDBym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:25:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-_2kcx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:25:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-vw8Ztq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-lbDCLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:25:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-yYPi_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:25:53 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-RqeAG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:25:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:25 INFO - Downloading blessings-1.6.tar.gz 10:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:28:25 INFO - Installing collected packages: blessings 10:28:25 INFO - Running setup.py install for blessings 10:28:26 INFO - Successfully installed blessings 10:28:26 INFO - Cleaning up... 10:28:26 INFO - Return code: 0 10:28:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:28:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:28:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:28:26 INFO - Reading from file tmpfile_stdout 10:28:26 INFO - Current package versions: 10:28:26 INFO - blessings == 1.6 10:28:26 INFO - blobuploader == 1.2.4 10:28:26 INFO - docopt == 0.6.1 10:28:26 INFO - functools32 == 3.2.3-2 10:28:26 INFO - jsonschema == 2.5.1 10:28:26 INFO - manifestparser == 1.1 10:28:26 INFO - mozInstall == 1.12 10:28:26 INFO - mozcrash == 1.0 10:28:26 INFO - mozdebug == 0.1 10:28:26 INFO - mozdevice == 0.49 10:28:26 INFO - mozfile == 1.2 10:28:26 INFO - mozhttpd == 0.7 10:28:26 INFO - mozinfo == 0.9 10:28:26 INFO - mozleak == 0.1 10:28:26 INFO - mozlog == 3.4 10:28:26 INFO - moznetwork == 0.27 10:28:26 INFO - mozprocess == 0.25 10:28:26 INFO - mozprofile == 0.28 10:28:26 INFO - mozrunner == 6.13 10:28:26 INFO - mozscreenshot == 0.1 10:28:26 INFO - mozsystemmonitor == 0.3 10:28:26 INFO - moztest == 0.8 10:28:26 INFO - mozversion == 1.4 10:28:26 INFO - psutil == 3.1.1 10:28:26 INFO - requests == 1.2.3 10:28:26 INFO - wsgiref == 0.1.2 10:28:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28: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')]} 10:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28: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')]} 10:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:27 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 0x1059aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fb4cc280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105788d30>, '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 0x1056afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10577dbe8>, '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.PP7fEZ8BD1/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.CUITJNsjgh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:28:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:28:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PP7fEZ8BD1/Render', 10:28:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:27 INFO - 'HOME': '/Users/cltbld', 10:28:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:27 INFO - 'LOGNAME': 'cltbld', 10:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:27 INFO - 'MOZ_NO_REMOTE': '1', 10:28:27 INFO - 'NO_EM_RESTART': '1', 10:28:27 INFO - 'PAGER': '/bin/cat', 10:28:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:27 INFO - 'PWD': '/builds/slave/test', 10:28:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:27 INFO - 'SHELL': '/bin/bash', 10:28:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CUITJNsjgh/Listeners', 10:28:27 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 10:28:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:27 INFO - 'USER': 'cltbld', 10:28:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:27 INFO - 'XPC_FLAGS': '0x0', 10:28:27 INFO - 'XPC_SERVICE_NAME': '0', 10:28:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:28:27 INFO - Cleaning up... 10:28:27 INFO - Return code: 0 10:28:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fb4cc280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105788d30>, '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 0x1056afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10577dbe8>, '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.PP7fEZ8BD1/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.CUITJNsjgh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:28:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:28:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PP7fEZ8BD1/Render', 10:28:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:27 INFO - 'HOME': '/Users/cltbld', 10:28:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:27 INFO - 'LOGNAME': 'cltbld', 10:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:27 INFO - 'MOZ_NO_REMOTE': '1', 10:28:27 INFO - 'NO_EM_RESTART': '1', 10:28:27 INFO - 'PAGER': '/bin/cat', 10:28:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:27 INFO - 'PWD': '/builds/slave/test', 10:28:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:27 INFO - 'SHELL': '/bin/bash', 10:28:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CUITJNsjgh/Listeners', 10:28:27 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 10:28:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:27 INFO - 'USER': 'cltbld', 10:28:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:27 INFO - 'XPC_FLAGS': '0x0', 10:28:27 INFO - 'XPC_SERVICE_NAME': '0', 10:28:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:28:27 INFO - Cleaning up... 10:28:27 INFO - Return code: 0 10:28:27 INFO - Running post-action listener: _resource_record_post_action 10:28:27 INFO - Running post-action listener: _start_resource_monitoring 10:28:27 INFO - Starting resource monitoring. 10:28:27 INFO - [mozharness: 2017-05-11 17:28:27.955115Z] Finished create-virtualenv step (success) 10:28:27 INFO - [mozharness: 2017-05-11 17:28:27.956156Z] Running install step. 10:28:27 INFO - Running pre-action listener: _resource_record_pre_action 10:28:27 INFO - Running main action method: install 10:28:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:28:28 INFO - Reading from file tmpfile_stdout 10:28:28 INFO - Detecting whether we're running mozinstall >=1.0... 10:28:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:28:28 INFO - Reading from file tmpfile_stdout 10:28:28 INFO - Output received: 10:28:28 INFO - Usage: mozinstall [options] installer 10:28:28 INFO - Options: 10:28:28 INFO - -h, --help show this help message and exit 10:28:28 INFO - -d DEST, --destination=DEST 10:28:28 INFO - Directory to install application into. [default: 10:28:28 INFO - "/builds/slave/test"] 10:28:28 INFO - --app=APP Application being installed. [default: firefox] 10:28:28 INFO - mkdir: /builds/slave/test/build/application 10:28:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:28:43 INFO - Reading from file tmpfile_stdout 10:28:43 INFO - Output received: 10:28:43 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:28:43 INFO - Running post-action listener: _resource_record_post_action 10:28:43 INFO - [mozharness: 2017-05-11 17:28:43.039748Z] Finished install step (success) 10:28:43 INFO - [mozharness: 2017-05-11 17:28:43.039877Z] Running run-tests step. 10:28:43 INFO - Running pre-action listener: _resource_record_pre_action 10:28:43 INFO - Running main action method: run_tests 10:28:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:28:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:28:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:28:43 INFO - 2017-05-11 10:28:43.054 screenresolution[1637:8704] starting screenresolution argv=screenresolution get 10:28:43 INFO - 2017-05-11 10:28:43.057 screenresolution[1637:8704] Display 0: 1600x1200x32@60 10:28:43 INFO - 2017-05-11 10:28:43.063 screenresolution[1638:8706] starting screenresolution argv=screenresolution list 10:28:43 INFO - Available Modes on Display 0 10:28:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:28:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:28:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:28:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:28:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:28:43 INFO - Intel Iris: 10:28:43 INFO - Chipset Model: Intel Iris 10:28:43 INFO - Type: GPU 10:28:43 INFO - Bus: Built-In 10:28:43 INFO - VRAM (Dynamic, Max): 1536 MB 10:28:43 INFO - Vendor: Intel (0x8086) 10:28:43 INFO - Device ID: 0x0a2e 10:28:43 INFO - Revision ID: 0x0009 10:28:43 INFO - Displays: 10:28:43 INFO - Display: 10:28:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:28:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:28:43 INFO - Display Serial Number: 1600x1200 60 10:28:43 INFO - Main Display: Yes 10:28:43 INFO - Mirror: Off 10:28:43 INFO - Online: Yes 10:28:43 INFO - Rotation: Supported 10:28:43 INFO - Return code: 0 10:28:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:28:43 INFO - Python 2.7.3 10:28:43 INFO - Return code: 0 10:28:43 INFO - grabbing minidump binary from tooltool 10:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:43 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 0x105788d30>, '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 0x1056afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10577dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:28:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:28:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:28:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:28:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:28:43 INFO - Return code: 0 10:28:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:28:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:28:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:28:43 INFO - ENV: RUST_BACKTRACE is now 1 10:28:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:28:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:28:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0325', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0325 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:28:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PP7fEZ8BD1/Render', 10:28:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:43 INFO - 'HOME': '/Users/cltbld', 10:28:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:43 INFO - 'LOGNAME': 'cltbld', 10:28:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:28:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:43 INFO - 'MOZ_NO_REMOTE': '1', 10:28:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:28:43 INFO - 'NO_EM_RESTART': '1', 10:28:43 INFO - 'PAGER': '/bin/cat', 10:28:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:43 INFO - 'PWD': '/builds/slave/test', 10:28:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:28:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:43 INFO - 'RUST_BACKTRACE': '1', 10:28:43 INFO - 'SHELL': '/bin/bash', 10:28:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CUITJNsjgh/Listeners', 10:28:43 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 10:28:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:43 INFO - 'USER': 'cltbld', 10:28:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:43 INFO - 'XPC_FLAGS': '0x0', 10:28:43 INFO - 'XPC_SERVICE_NAME': '0', 10:28:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0325', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:28:43 INFO - mozversion application_buildid: 20170511081624 10:28:43 INFO - mozversion application_changeset: a6cafa6b8a6f82b67b5a9cb26d5dc0fe72b7fac7 10:28:43 INFO - mozversion application_display_name: Firefox 10:28:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:28:43 INFO - mozversion application_name: Firefox 10:28:43 INFO - mozversion application_remotingname: firefox 10:28:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:28:43 INFO - mozversion application_vendor: Mozilla 10:28:43 INFO - mozversion application_version: 54.0 10:28:43 INFO - mozversion platform_buildid: 20170511081624 10:28:43 INFO - mozversion platform_changeset: a6cafa6b8a6f82b67b5a9cb26d5dc0fe72b7fac7 10:28:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:28:43 INFO - mozversion platform_version: 54.0 10:28:43 INFO - using testdate: 1494523723 10:28:43 INFO - actual date: 1494523723 10:28:43 INFO - starting webserver on 'localhost:49249' 10:28:43 INFO - SUITE-START | Running 2 tests 10:28:43 INFO - TEST-START | dromaeo_css 10:28:43 INFO - operating with platform_type : mac_ 10:28:43 INFO - Initialising browser for dromaeo_css test... 10:28:43 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmp3k5rV4/profile http://localhost:49249/getInfo.html) 10:28:46 INFO - PROCESS | 1648 | 2017-05-11 10:28:46.800 plugin-container[1653:8890] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a4b, name = 'com.apple.tsm.portname' 10:28:46 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:28:46 INFO - PROCESS | 1648 | 2017-05-11 10:28:46.800 plugin-container[1653:8890] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 10:28:46 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:28:46 INFO - PROCESS | 1648 | 2017-05-11 10:28:46.800 plugin-container[1653:8890] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:28:46 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 10:28:46 INFO - PROCESS | 1648 | colorDepth:24 10:28:46 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 10:28:46 INFO - PROCESS | 1648 | __metrics 10:28:46 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 10:28:47 INFO - TEST-INFO | 1648: exit 0 10:28:47 INFO - Browser initialized. 10:28:47 INFO - Running cycle 1/1 for dromaeo_css test... 10:28:47 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmp3k5rV4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:50 INFO - PROCESS | 1655 | 2017-05-11 10:28:50.032 plugin-container[1656:9026] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8543, name = 'com.apple.tsm.portname' 10:28:50 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:28:50 INFO - PROCESS | 1655 | 2017-05-11 10:28:50.033 plugin-container[1656:9026] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x441b, name = 'com.apple.CFPasteboardClient' 10:28:50 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:28:50 INFO - PROCESS | 1655 | 2017-05-11 10:28:50.033 plugin-container[1656:9026] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:28:59 INFO - PROCESS | 1655 | RSS: Main: 174125056 10:28:59 INFO - PROCESS | 1655 | 10:32:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 10:32:04 INFO - PROCESS | 1655 | RSS: Main: 193011712 10:32:04 INFO - PROCESS | 1655 | 10:35:06 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 10:35:07 INFO - PROCESS | 1655 | RSS: Main: 202166272 10:35:07 INFO - PROCESS | 1655 | 10:38:09 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 10:38:09 INFO - PROCESS | 1655 | RSS: Main: 206934016 10:38:09 INFO - PROCESS | 1655 | 10:41:11 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 10:41:12 INFO - PROCESS | 1655 | RSS: Main: 210214912 10:41:12 INFO - PROCESS | 1655 | 10:44:15 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 10:44:15 INFO - PROCESS | 1655 | RSS: Main: 212860928 10:44:15 INFO - PROCESS | 1655 | 10:47:18 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 10:47:19 INFO - PROCESS | 1655 | RSS: Main: 211046400 10:47:19 INFO - PROCESS | 1655 | 10:47:19 INFO - PROCESS | 1655 | __start_tp_report 10:47:19 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 10:47:19 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 10:47:19 INFO - PROCESS | 1655 | |i|pagename|runs| 10:47:19 INFO - PROCESS | 1655 | |0;dojo.html;3631.310051090293;3634.345817752803;3649.7262705297107;3657.1405719655877;3665.1203711109333;6191.659458729768;6194.3805619438035;6196.008638617822;6212.223472065992;6243.937560624392;6011.458968692817;6199.853027189973;6217.067439884019;6249.250089989197;6267;5524.806631767889;5577.972110139443;5597.8600534986745;5609.158626206081;5662.6602403855695;5630.887382252353;5650.434956504358;5653.349864765543;5660.094384898417;5692.345380281258;5452.154915988028;5478.753456094485;5645;5663.830085097433;5681.573881958849;5540.778368865241;5567.693776842272;5581.134924086773;5586.441355864401;5621.297337832771;4783.756223381911;5430.782768689287;5597.104463285855;5598.468145526169;5621.409751976065;6044.455998960115;6068.878622427571;6198.783042593533;6258.530610204208;6293.213348331458;4860.562549370538;6422.100905873182;6448.806535803887;6505.967470162666;6632.237292711304;6730.091437655951;6746.696398662072;6747.190337159573;6761.3238676132;6777.762778302736;5152.6650767699975;6276.278228003746;6282.654454005074;6314.589551679126;6316.021016742412;6466.515011374072;6613.5370524062855;6712.563683360566;6742.157230346207;6826.146731658543;6532.5753826001155;6541.182352205974;6550.115734375893;6560.639164845979;6563.212414510289;5564.666120032811;6223.751049958041;6229.595076320024;6677.933220667828;6737.461003119836;6306.085617585424;6378.2346118466085;6473.773417930444;6623.172103487064;6657.533972621967;6591.373819487237;6671.39957403836;6682.83292917681;6685.532012759158;6685.866282674319;4677.4854765975715;5165.793368265227;5252.1596544552685;5286.022085914118;5318.335208098988;4237.343211802176;4726.220173671306;4740.14677358072;4762.999770048329;4823.252395878644;6363.840903977345;6365.554411191172;6369.777057802955;6371.139896114058;6398.520110991694;6451;6515.185601799775;6664.366885146001;6674.23246326669;6706.83232919181;6351.936480635134;6354.682265886687;6358.936410635927;6373.107764912916;6379.585326953733;5192.974035129876;5509.641873278304;5685.687287199244;5929.258842644669;5935.109733540004;6704.195496540349;6785.830354241183;6872.10662613857;6926.757563485254;6992.825179370557;6690.464762818866;6725.865482690417;6746.561473504206;6775.288594697486;6776.7628133015105;6956.965215173892;6970.825729356604;6987.161540614956;7002.124734408199;7052.365287124184;6375.394337537927;6409.038644203407;6529.575577587441;6638.070670106285;6667.499937504804;6665.5334126612615;6740.325967403221;6744.156980377453;6747.426468750211;6765.221999470124;6502.154719886385;6540.37866402691;6540.738370465318;6542.34576542342;6546.214454265519;5230.8169214077325;6276.843078923063;6308.716107775253;6538.574992625464;6550.410463058157;6201.782937597162;6246.562740608296;6279.183706118175;6322.114903913363;6362.6818659067785;6552.3775241352;6559.0817285579105;6581.177352830896;6583.242927063257;6584.111144995556;6175.783847565313;6203.627782333075;6255.874882502233;6320.652364119834;6354.777582784581 10:47:19 INFO - PROCESS | 1655 | |1;ext.html;785.7760538246597;797.9122296547379;837.6774941647465;858.463460337289;893.8837951066361;41618.58381416185;41884;41922.58077419225;41978.79010604946;42100;43659.126817463635;43979.34030989538;44019.33970990438;44152.77923610377;44528;9711.660091896785;9828;9877.160441362494;11391.031762300214;11637.47631356591;11397.373144477051;11474;11518.193726439153;11518.596849110283;11536.423178841067;11543.480543375568;11549.307041577533;11576.073914086854;11579.305241685484;11593.188476806627;10108.39349639024;11003.559857605685;11512.136589755719;11512.654620361403;11530.423478826067;9437.622495100188;11290.322580645188;11343.865613438673;11362.37506937118;11366.943165284203;36589.634103659155;36624.26751464982;36808.263834723424;36826.447603285975;36903.63096369056;3349.8492567834505;3877.1470276539117;3897.3569361055393;3925.646691797752;3941.2314598653275;26326.86836565824;26335.473290534082;27202.591961120597;27364.31589210266;28156.014539491018;3177.539256807773;3250.5124231365485;3300.5874265716784;3418.504316874064;3423.0073278749132;353787;357665;366090;367506;387822.0608896966;44910.55089449064;45188.70707282803;45280.54719452763;45475;45478;47067.76466117647;47138.29292560614;47177.764111179225;47300;47423.051538969026;14220.431182752574;14309.141451512942;14316.57050288493;14326.49857254991;14351.425942962165;12495.93752031234;12544.24734515932;12551.686207844878;12589.370531473389;12618.369081545887;12065.155439119177;12074.939625301993;12092.87907120935;12183.939080304543;12196.512139514498;5696.316442026983;5703.771849126071;5744.253247077937;5745.511631511285;5757;984.9113579777854;1072.672834785398;1112.516055515837;1135.9261647992853;1156.2888823373564;26628.733712663012;27456.45087098247;27610.44779104447;27666.446671066868;27893;909.5270459361095;964.8697425847561;1168.4449886303937;1212.1696637802957;1228.9262644241373;14532.854671453362;14953.925230373778;15372.770178385703;15479.922600387152;15512;329142;329491;329532;330435;334604;54379;54624.180637290476;54648.18027729587;54734.631634209465;54864.45135548673;1497.423491955605;1533.1414407931818;1535.654477742499;1538.4922975418085;1548.7367147584712;23907.834283903372;25192.74807251904;26299.73700262973;28418.721157547545;29113;49516.50483495119;49774.502254976986;49869.75065124651;49937.751556211384;49950.750246248535;403690;404434;404477;404489;405448;27449.588256175775;28277.57583636206;32686.855960041285;34072.31855362929;34285;38993.610063898996;40728.98177545585;40730.592694073865;40884.97787555335;40936.79531602323;23129;24928;28653.856730716212;28996.27509312284;29964.400711986073;29254.41491170207;29320;29548.96578619738;30302.696973029986;30390;30857.074287771404;31878.043658690276;31957.36085278235;32109.35781284408;32123.678763213004;29174.124776256747;29503.85248073746;29575.704242957294;29918.70081299246;30074;19914.70127948111;21056.473588159806;23205.839708014868;23331.18340858062;23782.16762413307 10:47:19 INFO - PROCESS | 1655 | |2;jquery.html;422.6006423929388;434.25308469432576;434.83041613770627;439.34976235171945;448.05013371652103;20753.896230518843;21222.83274419908;21755.67366489504;21975.23086691966;22068.448288792788;21685.566288674218;22132.446688832788;22146.335609931688;22478.438039049033;22794.31617051487;5520.723963801814;6453.515986301023;6679.799606011803;6891.5872246189665;7094.964525177367;6889.276625954278;7057.541259818121;7090.220075791659;7091.149062112554;7095.113110861143;6787.932120678779;6972.093627828375;7008.684609192573;7023;7088.4683648726295;6617.841877671388;6905.240423553405;6905.827354316132;6943;6958.338957799001;6827.761028364033;6843.247242803288;6844;6848.417884479825;6855.07456493372;24632;25709.614355784677;27617.447651047067;27707.584386234223;28072.877084916578;3027.5458681197774;3070.815751054944;3074.98462507686;3081.1988882890387;3091.644460886982;13682.631736826337;15415.922920385327;15539.30073146711;16428.6714265714;16737.91631041849;1871.1953859840398;2006.5084054406618;2058.742657167854;2107.7681455039933;2119.300630791835;104443.43334849984;133761;168201;172362;175100;16460.506184814476;19812.405627831187;21002.894985524974;21038.894805525873;21287;31904.68095319017;32071;32598;32733;32733.345333093206;10795.78408431827;10870.61952831647;11055.613053543248;11088.944555277334;11192.936671016241;9264.53677316145;9265.95367023174;9289;9429.245660347156;9432.056794320513;9419.659500434946;9698.47839561719;9719.611215551298;9791;9824.705258842247;3510.7717998330027;4165.187788381237;4221.535631080578;4231.19607274623;4237.406763053175;773.7485317271796;805.8831469436899;839.4837175137369;863.1411745313453;879.872418499314;21270.680939785914;22198;22587;22713.659295110585;22848;894.8478758611052;897.237348253992;915.6291701860757;918.7840857398639;926.7544100813155;10765.354078755143;11529.423528823525;11780.99861511764;11814.46834892432;11824.704382390337;693935;695966;709331;712554;717660;106526;124794;126124;132878;138338;1280.9935950320375;1320.458611969088;1337.3848029906353;1339.3437215764206;1341.5841089262165;19693.60612787765;19884.801151988875;20397.79602203959;20467;20479.4880127998;60911.78176436358;61564;61829.9999999982;62270.688646556475;62582.68708656428;77666;87183.56408217919;89225;90452.54773726089;91521.5423922876;6897.89653155193;10946.233763636468;11211.215214935202;11253.71865703364;11628.011619012479;12226.877731222574;13203.867961320264;13270.469181232642;13308.93345533266;13550.864491355354;9997.900020999989;10740.355578664992;11198.16013798952;11382.715432114263;11535.423228838357;8173.550454724809;8879;10088.949555252177;10647;10915.508802103766;11012.779744405227;11588.768224635629;11751.412429378326;11811.114166437723;11920.761584768083;11580.768384632429;11591.478383472595;11606.825897611374;11691.766164676488;11886.643400697993;11043.895610438893;11232.66302010941;11367.943160284476;11439.942800286279;11618.360990145624 10:47:19 INFO - PROCESS | 1655 | |3;mootools.html;1246.738184981154;1623.6022174567229;1629.0388670684295;1645.9341626334954;1653.4956838164355;8451.57742112895;9713.757156071102;10952.5618975241;11664.125190610706;11673.883261167386;10911.945440272788;11298.661040168787;11304.886951130486;11309.604163854267;11310.717232069183;2455.8772061396903;2503.2240005598323;2521.697396312445;2533.4933013397304;2543.3768726661992;2090.4042347930845;2456.1280745335416;2530.202986059395;2533.278015765507;2534.721180670125;2497.3506888209013;2510.184190138203;2516.484120755241;2516.660250866128;2523.864261082511;2487.9378015549664;2493.6259561065804;2493.7007559092935;2496.8002559795173;2498.912538061177;2256.6685655463357;2445.9877700611382;2456.5578195924727;2463.1379017343966;2470.518248941457;9504.572294246775;9540.856887146698;9559.904400955971;9584.233261339075;11398.886011139948;6008.879822403527;6170.043643235305;6201.782937597208;6217.751289948396;6224.719887605069;3747.8500859965843;3888.6111388860886;3906.0820707133803;3965.0682089708894;3968.444417781513;1072.5173671847622;1279;1295.533607901155;1329.9135556188915;1332.1540821578367;15592.61018474536;15890;15924.442644507502;15946.28241729125;15959.04245745259;5003.249512573143;5182.689038657692;5246.31797866275;5249.685018898878;5284.524392804589;13351.532696355775;13369.532066377824;13390.531331403354;13394.531191408254;13397.464101436028;6129.172561704202;6158.3841615838055;6186.412290832363;6190.50475961922;6202.5658203925295;5380.166074258418;5515.531179849678;5584.357798853184;5605.159226116115;5605.831825045255;4184.66522678185;4304.612584867377;4323.827046918088;4345.391645169679;4353.194658988097;1162.0703437250165;1188.7503624238834;1197.2636828350676;1202.699325168708;1204.175140029083;828.1056459024239;840.4789030800943;860.3309579415914;873.4846440599949;885.6501681835639;6773.966130169318;6843.726250949906;6898.241193468714;6994.300569942965;7076.787696369117;987.1855719031828;1030.8041472120274;1038.807820553185;1056.3872953686844;1080.1466841195368;3726.4037753959237;4001.3197756381487;4324.005478739908;4385.859676484137;4388.802503887333;13388;14044.016918815585;14050.36773345202;14054.508092216724;14062.789058164135;13979.39236987739;13996.950228732885;14006.509772157926;14038.947078969119;14052.718945621235;9034.86447703285;9338.673146439842;10231.13035391985;10548.525316360781;10582.312149710091;7042;7071.858562828817;7090.680919358538;7238.457115716237;7241.565506069653;12492.500299988262;12614.810777838156;12754.872451275369;12797.808032879328;12809;11591.188616796744;12585.811212831997;12706.809397859224;12959.352032398154;13117.344132793512;9063.818723625622;9288.256939444964;9440.150386465251;9445.858312125461;9520.952395237979;10123.7469063274;10328;10387.480625968823;10465.738356540844;10571.841422378824;8923.063078376677;8968.461892286223;9000.63997440095;9132.817343653223;9201.769955750891;8670.609822557873;8708.956455217683;8716.607752651273;8830.470171789713;8900.5994730236;7978.601069946596;8048.356131509582;8162.347012238888;8167.673293068211;8203.630836612487;5982.58121931478;5990.880182396415;6039.15451836752;6187.783427580013;6241.937580624317;6041.24484439445;6071.180390647206;6103.6032657877095;6111.083337499233;6258.530610204344 10:47:19 INFO - PROCESS | 1655 | |4;prototype.html;396.674726724086;398.8025927166053;401.9308639020207;404.37927780856376;405.61482537135674;4736.100140973213;4767.594754445868;5224.21636754487;5464.890702185959;5526.309211348582;4736.786844591993;5352.2239275305055;5385.495744478817;5453.509184173424;5455.345358556969;3823.1589050408866;4041.6766658667384;4410.25025745624;4436.846419930809;4524.886877828064;3784.5458544974504;4369.759663218521;4483.5964763171305;4506.797194126272;4530.79611417487;3541.0786101466265;3937.7243592948507;4329.956700433003;4443.400140980959;4560.33875088112;3376.7129793967542;3948.190620922704;4407.735535867858;4443.667249562828;4478.2386994211065;3436.3642726095754;3662.8717994870317;3776.376897811858;4096.549379568245;4163.39630753539;4600.5169457207185;5239.816606418757;5286.682799032032;5360.571154307646;5400.324959380077;4757.857264282077;5054.494550544953;5141.845744627667;5192.3528442044535;5232.790688372461;5373.328333958255;5485.369182544018;5807.709614519257;5833.88332233353;5836.649801011953;3796.8988993191942;4351.430997452662;4586.1744885920525;4639.953600463986;4649.721016738973;5149.922751158736;5219.634625576211;5490.423505531941;5521.779128834842;5936.881262374728;3709.870154544578;4673.766311684402;4710.764461776897;4758.78585463655;4759.215858722617;4310.418093557392;4550.522195169526;4775.283707443842;4843.505594618704;4857.392825896763;4247.5752424757275;4417.757023363682;4973.975130124399;5087.338645976073;5169.604206864125;4667.929981050287;5080.012190430494;5377.660717587862;5753.626014309057;5801.7099145042575;1390.9289846817894;1432.4986254810942;1625.8618017468648;1636.9181540922907;1651.6201273706874;1087.005390068079;1140.7946569617548;1188.839506666589;1233.6052463211686;1261.2054405724334;5301.575873930076;5465.87821639766;5496.560275177976;5512.80705175317;5536.889262214733;5008.924866127011;5584.609077364546;5927.673977931169;5954.196183515257;6016.789412370546;4824.237095065854;5074.974625126851;5082.872928176826;5510.834674959678;5512.6968016759465;2866.7706583473273;3020.758339332892;3102.2709663229125;3164.275469868881;3172.175234439016;5012.774425150877;5504.889902201933;5735.799247026334;6203.937960620427;6311.832311022476;5924.31870334917;5964.882466724251;6085.66528840918;6089.878202436015;6209.285932117774;6219.689015549295;6260.968695156586;6269.529785266123;6284.591501552384;6305.337939516285;4995.375578052744;5285.7621407036;5724.427557244242;5995.520358371407;6040.969795151172;5047.7476126192805;5286.229113246952;5408.702521361363;5601.3476024573665;5745.2818397700285;5556.861078473071;6002.609830361187;6172.598781079216;6182.1345011699295;6222.688865556795;4158.251514727257;4718.791221968957;4901.627544287605;5253.973730131478;5304.124819404755;5414.566834653139;5454.5091141670155;5677;5814.993827129802;5945.10823376497;5323.813666521653;5537;5725.570582206268;5729.62757420783;5778.306603207642;5080.46655101209;5341.359036915595;5460.372057213472;5839.445252700986;5849.811852540291;4816.662833601615;5099.439061703284;5263.473652634706;5588.608797384144;5676.914846277226;5287.524122828964;5321.680699158062;5450.373207081077;5851.531877449709;5864.67744274069;4484.11231757386;4656.767161641972;4746.359241502353;5752.418085026651;5760.963026655242 10:47:19 INFO - PROCESS | 1655 | |5;yui.html;687.7407715654077;758.2455456820464;759.1952530317864;869.7086476030529;885.9069797671244;13530.661733456669;16468;16985.235664395103;17087.48737537873;17108.828911710894;13173.604791856236;15863.048217106982;16054.956427832212;16280.348786048544;16310;844.3287586368821;979.4074584876137;1011.5700827148469;1027.650598796409;1030.3457304611588;980.4264505264429;1017.120191034757;1018.694391682496;1020.8366661334188;1028.8816786069585;1063.0910571461404;1074.5486895503907;1076.5532304093792;1079.1097344690622;1080.173667144635;1070.9143268538498;1072.244067932106;1072.9195310351715;1072.9785404291908;1074.178253635973;715.1811176203219;756.7427074794541;787.279639130201;792.5640897506406;800.2517646001007;16467.176641167895;16475.91762041194;16612.750808737877;17280.22238999248;17351.958882466966;14679.192644404553;14902.627434314121;14942.028768130036;14952.775708364383;15116.94181407302;10650.786984260349;11869.46587403569;12105.939470302681;12270.938645306716;12335.876641233563;3852.210296889131;3918.15759611682;3924.4309575111733;4073.388991651246;4075.797639696267;119021;120465.39767301107;123834;124135;125711;11144.164187685956;11382.373969431761;11485.885141148481;11522.481488333045;11706.648800535997;23270.418239544146;23572.528549428916;23797.929093190847;23879.52240955171;23903.402414939766;8061.6372263248295;8070.919290807017;8081.272685458337;8084.797880052928;8205.58972051395;4514.593686568159;4532.546745325441;4602.263637817933;4652.62778977681;4665.953340466552;3643.417053271517;3714.3871261241593;3729.310077635646;3742.9812850935573;3763.849446022183;668.4418510543653;669.5413641655482;671.5064427645676;684.1858188755365;686.2142846440797;707.504746677328;709.5139829217003;727.4435057181261;734.3904559215838;763.6983391560302;9213.170814626716;9923.393282795198;10155.746106347253;10373.896261037444;10769.353838769699;695.2942763095463;722.6422920654205;738.4424759306689;740.6778051547594;767.244264399566;4637.837675681335;5063.240513922941;5066.442691303953;5092.974535127375;5094.465081166424;91562.54218728864;102345.97654023513;105916;107252.46373768081;108470;56104.830217170915;64442.677786610766;78044.21955780483;83457.58271208727;95454.04545954452;61873.83441579523;77925.61037194778;81429.59285203654;81501;82592.58703706563;8228.382871284557;11174.944125279322;11245.831312530156;11519.654410367702;11553.768924621292;48722;48772.512274878216;49005.50994490009;50023.499765001885;50105.74947125241;51256;60443.09335359885;61042;62969.425764354426;64684.35315646972;12327.69180770488;12336.876631233572;12571;12687.958183208408;12776.552820651232;14469.204193769443;14811.777823332874;14912.254387280376;14977;15043;14009.449511042938;14107.294635268401;14392.640183995065;14429.42282308696;14901.031432956823;13668.65828354299;13755.724885502033;14285.642858928195;14291.356888939814;14502.492412765503;13211.537596184087;13946.860531394963;14100.08349457282;14367.20980346091;14450.710985780435;8693.913060869563;8908.10918908104;8956.68651597191;9097.272218222393;9183.265338772748;10057.855803240313;10931.508082136164;11449.484773185393;11675.35785531804;11693.473793679475 10:47:19 INFO - PROCESS | 1655 | __end_tp_report 10:47:19 INFO - PROCESS | 1655 | __start_cc_report 10:47:19 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,400 10:47:19 INFO - PROCESS | 1655 | __end_cc_report 10:47:19 INFO - PROCESS | 1655 | __startTimestamp1494524839000__endTimestamp 10:47:19 INFO - PROCESS | 1655 | 10:47:19 INFO - PROCESS | 1655 | ------- Summary: start ------- 10:47:19 INFO - PROCESS | 1655 | Number of tests: 6 10:47:19 INFO - PROCESS | 1655 | 10:47:19 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:6126.16 Median:6354.68 stddev:716.71 (11.3%) stddev-sans-first:691.67 10:47:19 INFO - PROCESS | 1655 | Values: 3631.3 3634.3 3649.7 3657.1 3665.1 6191.7 6194.4 6196.0 6212.2 6243.9 6011.5 6199.9 6217.1 6249.3 6267.0 5524.8 5578.0 5597.9 5609.2 5662.7 5630.9 5650.4 5653.3 5660.1 5692.3 5452.2 5478.8 5645.0 5663.8 5681.6 5540.8 5567.7 5581.1 5586.4 5621.3 4783.8 5430.8 5597.1 5598.5 5621.4 6044.5 6068.9 6198.8 6258.5 6293.2 4860.6 6422.1 6448.8 6506.0 6632.2 6730.1 6746.7 6747.2 6761.3 6777.8 5152.7 6276.3 6282.7 6314.6 6316.0 6466.5 6613.5 6712.6 6742.2 6826.1 6532.6 6541.2 6550.1 6560.6 6563.2 5564.7 6223.8 6229.6 6677.9 6737.5 6306.1 6378.2 6473.8 6623.2 6657.5 6591.4 6671.4 6682.8 6685.5 6685.9 4677.5 5165.8 5252.2 5286.0 5318.3 4237.3 4726.2 4740.1 4763.0 4823.3 6363.8 6365.6 6369.8 6371.1 6398.5 6451.0 6515.2 6664.4 6674.2 6706.8 6351.9 6354.7 6358.9 6373.1 6379.6 5193.0 5509.6 5685.7 5929.3 5935.1 6704.2 6785.8 6872.1 6926.8 6992.8 6690.5 6725.9 6746.6 6775.3 6776.8 6957.0 6970.8 6987.2 7002.1 7052.4 6375.4 6409.0 6529.6 6638.1 6667.5 6665.5 6740.3 6744.2 6747.4 6765.2 6502.2 6540.4 6540.7 6542.3 6546.2 5230.8 6276.8 6308.7 6538.6 6550.4 6201.8 6246.6 6279.2 6322.1 6362.7 6552.4 6559.1 6581.2 6583.2 6584.1 6175.8 6203.6 6255.9 6320.7 6354.8 10:47:19 INFO - PROCESS | 1655 | 10:47:19 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:51169.36 Median:17017.31 stddev:97205.97 (571.2%) stddev-sans-first:97405.05 10:47:19 INFO - PROCESS | 1655 | Values: 785.8 797.9 837.7 858.5 893.9 41618.6 41884.0 41922.6 41978.8 42100.0 43659.1 43979.3 44019.3 44152.8 44528.0 9711.7 9828.0 9877.2 11391.0 11637.5 11397.4 11474.0 11518.2 11518.6 11536.4 11543.5 11549.3 11576.1 11579.3 11593.2 10108.4 11003.6 11512.1 11512.7 11530.4 9437.6 11290.3 11343.9 11362.4 11366.9 36589.6 36624.3 36808.3 36826.4 36903.6 3349.8 3877.1 3897.4 3925.6 3941.2 26326.9 26335.5 27202.6 27364.3 28156.0 3177.5 3250.5 3300.6 3418.5 3423.0 353787.0 357665.0 366090.0 367506.0 387822.1 44910.6 45188.7 45280.5 45475.0 45478.0 47067.8 47138.3 47177.8 47300.0 47423.1 14220.4 14309.1 14316.6 14326.5 14351.4 12495.9 12544.2 12551.7 12589.4 12618.4 12065.2 12074.9 12092.9 12183.9 12196.5 5696.3 5703.8 5744.3 5745.5 5757.0 984.9 1072.7 1112.5 1135.9 1156.3 26628.7 27456.5 27610.4 27666.4 27893.0 909.5 964.9 1168.4 1212.2 1228.9 14532.9 14953.9 15372.8 15479.9 15512.0 329142.0 329491.0 329532.0 330435.0 334604.0 54379.0 54624.2 54648.2 54734.6 54864.5 1497.4 1533.1 1535.7 1538.5 1548.7 23907.8 25192.7 26299.7 28418.7 29113.0 49516.5 49774.5 49869.8 49937.8 49950.8 403690.0 404434.0 404477.0 404489.0 405448.0 27449.6 28277.6 32686.9 34072.3 34285.0 38993.6 40729.0 40730.6 40885.0 40936.8 23129.0 24928.0 28653.9 28996.3 29964.4 29254.4 29320.0 29549.0 30302.7 30390.0 30857.1 31878.0 31957.4 32109.4 32123.7 29174.1 29503.9 29575.7 29918.7 30074.0 19914.7 21056.5 23205.8 23331.2 23782.2 10:47:19 INFO - PROCESS | 1655 | 10:47:19 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:41103.65 Median:23740.00 stddev:117503.87 (495.0%) stddev-sans-first:117793.80 10:47:19 INFO - PROCESS | 1655 | Values: 422.6 434.3 434.8 439.3 448.1 20753.9 21222.8 21755.7 21975.2 22068.4 21685.6 22132.4 22146.3 22478.4 22794.3 5520.7 6453.5 6679.8 6891.6 7095.0 6889.3 7057.5 7090.2 7091.1 7095.1 6787.9 6972.1 7008.7 7023.0 7088.5 6617.8 6905.2 6905.8 6943.0 6958.3 6827.8 6843.2 6844.0 6848.4 6855.1 24632.0 25709.6 27617.4 27707.6 28072.9 3027.5 3070.8 3075.0 3081.2 3091.6 13682.6 15415.9 15539.3 16428.7 16737.9 1871.2 2006.5 2058.7 2107.8 2119.3 104443.4 133761.0 168201.0 172362.0 175100.0 16460.5 19812.4 21002.9 21038.9 21287.0 31904.7 32071.0 32598.0 32733.0 32733.3 10795.8 10870.6 11055.6 11088.9 11192.9 9264.5 9266.0 9289.0 9429.2 9432.1 9419.7 9698.5 9719.6 9791.0 9824.7 3510.8 4165.2 4221.5 4231.2 4237.4 773.7 805.9 839.5 863.1 879.9 21270.7 22198.0 22587.0 22713.7 22848.0 894.8 897.2 915.6 918.8 926.8 10765.4 11529.4 11781.0 11814.5 11824.7 693935.0 695966.0 709331.0 712554.0 717660.0 106526.0 124794.0 126124.0 132878.0 138338.0 1281.0 1320.5 1337.4 1339.3 1341.6 19693.6 19884.8 20397.8 20467.0 20479.5 60911.8 61564.0 61830.0 62270.7 62582.7 77666.0 87183.6 89225.0 90452.5 91521.5 6897.9 10946.2 11211.2 11253.7 11628.0 12226.9 13203.9 13270.5 13308.9 13550.9 9997.9 10740.4 11198.2 11382.7 11535.4 8173.6 8879.0 10088.9 10647.0 10915.5 11012.8 11588.8 11751.4 11811.1 11920.8 11580.8 11591.5 11606.8 11691.8 11886.6 11043.9 11232.7 11367.9 11439.9 11618.4 10:47:19 INFO - PROCESS | 1655 | 10:47:19 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:6935.12 Median:3134.89 stddev:4297.56 (137.1%) stddev-sans-first:4288.35 10:47:19 INFO - PROCESS | 1655 | Values: 1246.7 1623.6 1629.0 1645.9 1653.5 8451.6 9713.8 10952.6 11664.1 11673.9 10911.9 11298.7 11304.9 11309.6 11310.7 2455.9 2503.2 2521.7 2533.5 2543.4 2090.4 2456.1 2530.2 2533.3 2534.7 2497.4 2510.2 2516.5 2516.7 2523.9 2487.9 2493.6 2493.7 2496.8 2498.9 2256.7 2446.0 2456.6 2463.1 2470.5 9504.6 9540.9 9559.9 9584.2 11398.9 6008.9 6170.0 6201.8 6217.8 6224.7 3747.9 3888.6 3906.1 3965.1 3968.4 1072.5 1279.0 1295.5 1329.9 1332.2 15592.6 15890.0 15924.4 15946.3 15959.0 5003.2 5182.7 5246.3 5249.7 5284.5 13351.5 13369.5 13390.5 13394.5 13397.5 6129.2 6158.4 6186.4 6190.5 6202.6 5380.2 5515.5 5584.4 5605.2 5605.8 4184.7 4304.6 4323.8 4345.4 4353.2 1162.1 1188.8 1197.3 1202.7 1204.2 828.1 840.5 860.3 873.5 885.7 6774.0 6843.7 6898.2 6994.3 7076.8 987.2 1030.8 1038.8 1056.4 1080.1 3726.4 4001.3 4324.0 4385.9 4388.8 13388.0 14044.0 14050.4 14054.5 14062.8 13979.4 13997.0 14006.5 14038.9 14052.7 9034.9 9338.7 10231.1 10548.5 10582.3 7042.0 7071.9 7090.7 7238.5 7241.6 12492.5 12614.8 12754.9 12797.8 12809.0 11591.2 12585.8 12706.8 12959.4 13117.3 9063.8 9288.3 9440.2 9445.9 9521.0 10123.7 10328.0 10387.5 10465.7 10571.8 8923.1 8968.5 9000.6 9132.8 9201.8 8670.6 8709.0 8716.6 8830.5 8900.6 7978.6 8048.4 8162.3 8167.7 8203.6 5982.6 5990.9 6039.2 6187.8 6241.9 6041.2 6071.2 6103.6 6111.1 6258.5 10:47:19 INFO - PROCESS | 1655 | 10:47:19 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4763.71 Median:5180.98 stddev:1349.27 (26.0%) stddev-sans-first:1312.64 10:47:19 INFO - PROCESS | 1655 | Values: 396.7 398.8 401.9 404.4 405.6 4736.1 4767.6 5224.2 5464.9 5526.3 4736.8 5352.2 5385.5 5453.5 5455.3 3823.2 4041.7 4410.3 4436.8 4524.9 3784.5 4369.8 4483.6 4506.8 4530.8 3541.1 3937.7 4330.0 4443.4 4560.3 3376.7 3948.2 4407.7 4443.7 4478.2 3436.4 3662.9 3776.4 4096.5 4163.4 4600.5 5239.8 5286.7 5360.6 5400.3 4757.9 5054.5 5141.8 5192.4 5232.8 5373.3 5485.4 5807.7 5833.9 5836.6 3796.9 4351.4 4586.2 4640.0 4649.7 5149.9 5219.6 5490.4 5521.8 5936.9 3709.9 4673.8 4710.8 4758.8 4759.2 4310.4 4550.5 4775.3 4843.5 4857.4 4247.6 4417.8 4974.0 5087.3 5169.6 4667.9 5080.0 5377.7 5753.6 5801.7 1390.9 1432.5 1625.9 1636.9 1651.6 1087.0 1140.8 1188.8 1233.6 1261.2 5301.6 5465.9 5496.6 5512.8 5536.9 5008.9 5584.6 5927.7 5954.2 6016.8 4824.2 5075.0 5082.9 5510.8 5512.7 2866.8 3020.8 3102.3 3164.3 3172.2 5012.8 5504.9 5735.8 6203.9 6311.8 5924.3 5964.9 6085.7 6089.9 6209.3 6219.7 6261.0 6269.5 6284.6 6305.3 4995.4 5285.8 5724.4 5995.5 6041.0 5047.7 5286.2 5408.7 5601.3 5745.3 5556.9 6002.6 6172.6 6182.1 6222.7 4158.3 4718.8 4901.6 5254.0 5304.1 5414.6 5454.5 5677.0 5815.0 5945.1 5323.8 5537.0 5725.6 5729.6 5778.3 5080.5 5341.4 5460.4 5839.4 5849.8 4816.7 5099.4 5263.5 5588.6 5676.9 5287.5 5321.7 5450.4 5851.5 5864.7 4484.1 4656.8 4746.4 5752.4 5761.0 10:47:19 INFO - PROCESS | 1655 | 10:47:19 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:20618.36 Median:17194.53 stddev:29788.46 (173.2%) stddev-sans-first:29834.43 10:47:19 INFO - PROCESS | 1655 | Values: 687.7 758.2 759.2 869.7 885.9 13530.7 16468.0 16985.2 17087.5 17108.8 13173.6 15863.0 16055.0 16280.3 16310.0 844.3 979.4 1011.6 1027.7 1030.3 980.4 1017.1 1018.7 1020.8 1028.9 1063.1 1074.5 1076.6 1079.1 1080.2 1070.9 1072.2 1072.9 1073.0 1074.2 715.2 756.7 787.3 792.6 800.3 16467.2 16475.9 16612.8 17280.2 17352.0 14679.2 14902.6 14942.0 14952.8 15116.9 10650.8 11869.5 12105.9 12270.9 12335.9 3852.2 3918.2 3924.4 4073.4 4075.8 119021.0 120465.4 123834.0 124135.0 125711.0 11144.2 11382.4 11485.9 11522.5 11706.6 23270.4 23572.5 23797.9 23879.5 23903.4 8061.6 8070.9 8081.3 8084.8 8205.6 4514.6 4532.5 4602.3 4652.6 4666.0 3643.4 3714.4 3729.3 3743.0 3763.8 668.4 669.5 671.5 684.2 686.2 707.5 709.5 727.4 734.4 763.7 9213.2 9923.4 10155.7 10373.9 10769.4 695.3 722.6 738.4 740.7 767.2 4637.8 5063.2 5066.4 5093.0 5094.5 91562.5 102346.0 105916.0 107252.5 108470.0 56104.8 64442.7 78044.2 83457.6 95454.0 61873.8 77925.6 81429.6 81501.0 82592.6 8228.4 11174.9 11245.8 11519.7 11553.8 48722.0 48772.5 49005.5 50023.5 50105.7 51256.0 60443.1 61042.0 62969.4 64684.4 12327.7 12336.9 12571.0 12688.0 12776.6 14469.2 14811.8 14912.3 14977.0 15043.0 14009.4 14107.3 14392.6 14429.4 14901.0 13668.7 13755.7 14285.6 14291.4 14502.5 13211.5 13946.9 14100.1 14367.2 14450.7 8693.9 8908.1 8956.7 9097.3 9183.3 10057.9 10931.5 11449.5 11675.4 11693.5 10:47:19 INFO - PROCESS | 1655 | -------- Summary: end -------- 10:47:19 INFO - PROCESS | 1655 | 10:47:19 INFO - TEST-INFO | 1655: exit 0 10:47:19 INFO - TEST-OK | dromaeo_css | took 1115923ms 10:47:19 INFO - TEST-START | kraken 10:47:19 INFO - operating with platform_type : mac_ 10:47:19 INFO - Initialising browser for kraken test... 10:47:19 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmpwpE5X3/profile http://localhost:49249/getInfo.html) 10:47:22 INFO - PROCESS | 1664 | 2017-05-11 10:47:22.328 plugin-container[1666:11315] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 10:47:22 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:47:22 INFO - PROCESS | 1664 | 2017-05-11 10:47:22.329 plugin-container[1666:11315] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890b, name = 'com.apple.CFPasteboardClient' 10:47:22 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:47:22 INFO - PROCESS | 1664 | 2017-05-11 10:47:22.329 plugin-container[1666:11315] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:47:22 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 10:47:22 INFO - PROCESS | 1664 | colorDepth:24 10:47:22 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 10:47:22 INFO - PROCESS | 1664 | __metrics 10:47:22 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 10:47:23 INFO - TEST-INFO | 1664: exit 0 10:47:23 INFO - Browser initialized. 10:47:23 INFO - Running cycle 1/1 for kraken test... 10:47:23 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmpwpE5X3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:47:25 INFO - PROCESS | 1667 | 2017-05-11 10:47:25.607 plugin-container[1668:11446] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x864f, name = 'com.apple.tsm.portname' 10:47:25 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:47:25 INFO - PROCESS | 1667 | 2017-05-11 10:47:25.607 plugin-container[1668:11446] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 10:47:25 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:47:25 INFO - PROCESS | 1667 | 2017-05-11 10:47:25.607 plugin-container[1668:11446] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:47:35 INFO - PROCESS | 1667 | RSS: Main: 174239744 10:47:35 INFO - PROCESS | 1667 | 10:47:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 10:47:39 INFO - PROCESS | 1667 | RSS: Main: 187772928 10:47:39 INFO - PROCESS | 1667 | 10:47:41 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 10:47:42 INFO - PROCESS | 1667 | RSS: Main: 195735552 10:47:42 INFO - PROCESS | 1667 | 10:47:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 10:47:46 INFO - PROCESS | 1667 | RSS: Main: 197279744 10:47:46 INFO - PROCESS | 1667 | 10:47:48 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 10:47:49 INFO - PROCESS | 1667 | RSS: Main: 199159808 10:47:49 INFO - PROCESS | 1667 | 10:47:51 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:47:52 INFO - PROCESS | 1667 | RSS: Main: 199512064 10:47:52 INFO - PROCESS | 1667 | 10:47:55 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 10:47:55 INFO - PROCESS | 1667 | RSS: Main: 203386880 10:47:55 INFO - PROCESS | 1667 | 10:47:58 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 10:47:59 INFO - PROCESS | 1667 | RSS: Main: 202805248 10:47:59 INFO - PROCESS | 1667 | 10:48:02 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 10:48:02 INFO - PROCESS | 1667 | RSS: Main: 203034624 10:48:02 INFO - PROCESS | 1667 | 10:48:04 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:48:05 INFO - PROCESS | 1667 | RSS: Main: 204099584 10:48:05 INFO - PROCESS | 1667 | 10:48:06 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:48:07 INFO - PROCESS | 1667 | RSS: Main: 204066816 10:48:07 INFO - PROCESS | 1667 | 10:48:09 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:48:10 INFO - PROCESS | 1667 | RSS: Main: 204075008 10:48:10 INFO - PROCESS | 1667 | 10:48:13 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:48:14 INFO - PROCESS | 1667 | RSS: Main: 204419072 10:48:14 INFO - PROCESS | 1667 | 10:48:16 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:48:17 INFO - PROCESS | 1667 | RSS: Main: 204513280 10:48:17 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 10:48:19 INFO - PROCESS | 1667 | RSS: Main: 206209024 10:48:19 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | __start_tp_report 10:48:19 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 10:48:19 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 10:48:19 INFO - PROCESS | 1667 | |i|pagename|runs| 10:48:19 INFO - PROCESS | 1667 | |0;ai-astar;107;121;119;117;118;120;118;119;117;119 10:48:19 INFO - PROCESS | 1667 | |1;audio-beat-detection;154;140;97;176;94;134;101;147;162;140 10:48:19 INFO - PROCESS | 1667 | |2;audio-dft;264;211;282;274;205;233;197;197;228;190 10:48:19 INFO - PROCESS | 1667 | |3;audio-fft;84;59;59;87;62;61;51;69;101;85 10:48:19 INFO - PROCESS | 1667 | |4;audio-oscillator;88;56;83;95;101;55;96;93;62;99 10:48:19 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;108;88;88;87;105;136;125;87;96;89 10:48:19 INFO - PROCESS | 1667 | |6;imaging-darkroom;95;96;95;95;122;115;97;94;100;147 10:48:19 INFO - PROCESS | 1667 | |7;imaging-desaturate;89;92;90;90;90;92;91;97;92;137 10:48:19 INFO - PROCESS | 1667 | |8;json-parse-financial;65;64;66;66;67;67;68;69;67;69 10:48:19 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;59;64;59;71;63;65;58;59;65;58 10:48:19 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;80;85;86;81;82;78;82;82;87;84 10:48:19 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;136;139;130;135;139;149;150;153;190;148 10:48:19 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;164;164;161;162;163;166;186;167;164;160 10:48:19 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;64;65;66;78;89;85;85;84;86;65 10:48:19 INFO - PROCESS | 1667 | __end_tp_report 10:48:19 INFO - PROCESS | 1667 | __start_cc_report 10:48:19 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,981 10:48:19 INFO - PROCESS | 1667 | __end_cc_report 10:48:19 INFO - PROCESS | 1667 | __startTimestamp1494524899489__endTimestamp 10:48:19 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | ------- Summary: start ------- 10:48:19 INFO - PROCESS | 1667 | Number of tests: 14 10:48:19 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:117.50 Median:119.00 stddev:3.89 (3.3%) stddev-sans-first:1.32 10:48:19 INFO - PROCESS | 1667 | Values: 107.0 121.0 119.0 117.0 118.0 120.0 118.0 119.0 117.0 119.0 10:48:19 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:158.00 stddev:28.37 (18.0%) stddev-sans-first:29.20 10:48:19 INFO - PROCESS | 1667 | Values: 154.0 140.0 97.0 176.0 94.0 134.0 101.0 147.0 162.0 140.0 10:48:19 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:228.10 Median:230.50 stddev:34.22 (14.8%) stddev-sans-first:33.74 10:48:19 INFO - PROCESS | 1667 | Values: 264.0 211.0 282.0 274.0 205.0 233.0 197.0 197.0 228.0 190.0 10:48:19 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:71.80 Median:65.50 stddev:16.29 (24.9%) stddev-sans-first:16.67 10:48:19 INFO - PROCESS | 1667 | Values: 84.0 59.0 59.0 87.0 62.0 61.0 51.0 69.0 101.0 85.0 10:48:19 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:82.80 Median:90.50 stddev:18.17 (20.1%) stddev-sans-first:19.18 10:48:19 INFO - PROCESS | 1667 | Values: 88.0 56.0 83.0 95.0 101.0 55.0 96.0 93.0 62.0 99.0 10:48:19 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:100.90 Median:87.50 stddev:17.53 (20.0%) stddev-sans-first:18.40 10:48:19 INFO - PROCESS | 1667 | Values: 108.0 88.0 88.0 87.0 105.0 136.0 125.0 87.0 96.0 89.0 10:48:19 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:105.60 Median:95.00 stddev:17.45 (18.4%) stddev-sans-first:18.08 10:48:19 INFO - PROCESS | 1667 | Values: 95.0 96.0 95.0 95.0 122.0 115.0 97.0 94.0 100.0 147.0 10:48:19 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:91.50 stddev:14.58 (15.9%) stddev-sans-first:15.24 10:48:19 INFO - PROCESS | 1667 | Values: 89.0 92.0 90.0 90.0 90.0 92.0 91.0 97.0 92.0 137.0 10:48:19 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:67.00 stddev:1.62 (2.4%) stddev-sans-first:1.58 10:48:19 INFO - PROCESS | 1667 | Values: 65.0 64.0 66.0 66.0 67.0 67.0 68.0 69.0 67.0 69.0 10:48:19 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:63.50 stddev:4.25 (6.7%) stddev-sans-first:4.36 10:48:19 INFO - PROCESS | 1667 | Values: 59.0 64.0 59.0 71.0 63.0 65.0 58.0 59.0 65.0 58.0 10:48:19 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:2.79 (3.4%) stddev-sans-first:2.78 10:48:19 INFO - PROCESS | 1667 | Values: 80.0 85.0 86.0 81.0 82.0 78.0 82.0 82.0 87.0 84.0 10:48:19 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:146.90 Median:148.50 stddev:16.93 (11.4%) stddev-sans-first:17.50 10:48:19 INFO - PROCESS | 1667 | Values: 136.0 139.0 130.0 135.0 139.0 149.0 150.0 153.0 190.0 148.0 10:48:19 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:164.00 stddev:7.44 (4.5%) stddev-sans-first:7.87 10:48:19 INFO - PROCESS | 1667 | Values: 164.0 164.0 161.0 162.0 163.0 166.0 186.0 167.0 164.0 160.0 10:48:19 INFO - PROCESS | 1667 | 10:48:19 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.70 Median:84.50 stddev:10.44 (12.3%) stddev-sans-first:10.01 10:48:19 INFO - PROCESS | 1667 | Values: 64.0 65.0 66.0 78.0 89.0 85.0 85.0 84.0 86.0 65.0 10:48:19 INFO - PROCESS | 1667 | -------- Summary: end -------- 10:48:19 INFO - PROCESS | 1667 | 10:48:20 INFO - TEST-INFO | 1667: exit 0 10:48:20 INFO - TEST-OK | kraken | took 60875ms 10:48:20 INFO - SUITE-END | took 1176s 10:48:20 INFO - Completed test suite (00:19:36) 10:48:20 INFO - javascript benchmark 10:48:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7878.354400203537, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3631.310051090293, 3634.345817752803, 3649.7262705297107, 3657.1405719655877, 3665.1203711109333, 6191.659458729768, 6194.3805619438035, 6196.008638617822, 6212.223472065992, 6243.937560624392, 6011.458968692817, 6199.853027189973, 6217.067439884019, 6249.250089989197, 6267.0, 5524.806631767889, 5577.972110139443, 5597.8600534986745, 5609.158626206081, 5662.6602403855695, 5630.887382252353, 5650.434956504358, 5653.349864765543, 5660.094384898417, 5692.345380281258, 5452.154915988028, 5478.753456094485, 5645.0, 5663.830085097433, 5681.573881958849, 5540.778368865241, 5567.693776842272, 5581.134924086773, 5586.441355864401, 5621.297337832771, 4783.756223381911, 5430.782768689287, 5597.104463285855, 5598.468145526169, 5621.409751976065, 6044.455998960115, 6068.878622427571, 6198.783042593533, 6258.530610204208, 6293.213348331458, 4860.562549370538, 6422.100905873182, 6448.806535803887, 6505.967470162666, 6632.237292711304, 6730.091437655951, 6746.696398662072, 6747.190337159573, 6761.3238676132, 6777.762778302736, 5152.6650767699975, 6276.278228003746, 6282.654454005074, 6314.589551679126, 6316.021016742412, 6466.515011374072, 6613.5370524062855, 6712.563683360566, 6742.157230346207, 6826.146731658543, 6532.5753826001155, 6541.182352205974, 6550.115734375893, 6560.639164845979, 6563.212414510289, 5564.666120032811, 6223.751049958041, 6229.595076320024, 6677.933220667828, 6737.461003119836, 6306.085617585424, 6378.2346118466085, 6473.773417930444, 6623.172103487064, 6657.533972621967, 6591.373819487237, 6671.39957403836, 6682.83292917681, 6685.532012759158, 6685.866282674319, 4677.4854765975715, 5165.793368265227, 5252.1596544552685, 5286.022085914118, 5318.335208098988, 4237.343211802176, 4726.220173671306, 4740.14677358072, 4762.999770048329, 4823.252395878644, 6363.840903977345, 6365.554411191172, 6369.777057802955, 6371.139896114058, 6398.520110991694, 6451.0, 6515.185601799775, 6664.366885146001, 6674.23246326669, 6706.83232919181, 6351.936480635134, 6354.682265886687, 6358.936410635927, 6373.107764912916, 6379.585326953733, 5192.974035129876, 5509.641873278304, 5685.687287199244, 5929.258842644669, 5935.109733540004, 6704.195496540349, 6785.830354241183, 6872.10662613857, 6926.757563485254, 6992.825179370557, 6690.464762818866, 6725.865482690417, 6746.561473504206, 6775.288594697486, 6776.7628133015105, 6956.965215173892, 6970.825729356604, 6987.161540614956, 7002.124734408199, 7052.365287124184, 6375.394337537927, 6409.038644203407, 6529.575577587441, 6638.070670106285, 6667.499937504804, 6665.5334126612615, 6740.325967403221, 6744.156980377453, 6747.426468750211, 6765.221999470124, 6502.154719886385, 6540.37866402691, 6540.738370465318, 6542.34576542342, 6546.214454265519, 5230.8169214077325, 6276.843078923063, 6308.716107775253, 6538.574992625464, 6550.410463058157, 6201.782937597162, 6246.562740608296, 6279.183706118175, 6322.114903913363, 6362.6818659067785, 6552.3775241352, 6559.0817285579105, 6581.177352830896, 6583.242927063257, 6584.111144995556, 6175.783847565313, 6203.627782333075, 6255.874882502233, 6320.652364119834, 6354.777582784581], "value": 6081.306822326576, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.7760538246597, 797.9122296547379, 837.6774941647465, 858.463460337289, 893.8837951066361, 41618.58381416185, 41884.0, 41922.58077419225, 41978.79010604946, 42100.0, 43659.126817463635, 43979.34030989538, 44019.33970990438, 44152.77923610377, 44528.0, 9711.660091896785, 9828.0, 9877.160441362494, 11391.031762300214, 11637.47631356591, 11397.373144477051, 11474.0, 11518.193726439153, 11518.596849110283, 11536.423178841067, 11543.480543375568, 11549.307041577533, 11576.073914086854, 11579.305241685484, 11593.188476806627, 10108.39349639024, 11003.559857605685, 11512.136589755719, 11512.654620361403, 11530.423478826067, 9437.622495100188, 11290.322580645188, 11343.865613438673, 11362.37506937118, 11366.943165284203, 36589.634103659155, 36624.26751464982, 36808.263834723424, 36826.447603285975, 36903.63096369056, 3349.8492567834505, 3877.1470276539117, 3897.3569361055393, 3925.646691797752, 3941.2314598653275, 26326.86836565824, 26335.473290534082, 27202.591961120597, 27364.31589210266, 28156.014539491018, 3177.539256807773, 3250.5124231365485, 3300.5874265716784, 3418.504316874064, 3423.0073278749132, 353787.0, 357665.0, 366090.0, 367506.0, 387822.0608896966, 44910.55089449064, 45188.70707282803, 45280.54719452763, 45475.0, 45478.0, 47067.76466117647, 47138.29292560614, 47177.764111179225, 47300.0, 47423.051538969026, 14220.431182752574, 14309.141451512942, 14316.57050288493, 14326.49857254991, 14351.425942962165, 12495.93752031234, 12544.24734515932, 12551.686207844878, 12589.370531473389, 12618.369081545887, 12065.155439119177, 12074.939625301993, 12092.87907120935, 12183.939080304543, 12196.512139514498, 5696.316442026983, 5703.771849126071, 5744.253247077937, 5745.511631511285, 5757.0, 984.9113579777854, 1072.672834785398, 1112.516055515837, 1135.9261647992853, 1156.2888823373564, 26628.733712663012, 27456.45087098247, 27610.44779104447, 27666.446671066868, 27893.0, 909.5270459361095, 964.8697425847561, 1168.4449886303937, 1212.1696637802957, 1228.9262644241373, 14532.854671453362, 14953.925230373778, 15372.770178385703, 15479.922600387152, 15512.0, 329142.0, 329491.0, 329532.0, 330435.0, 334604.0, 54379.0, 54624.180637290476, 54648.18027729587, 54734.631634209465, 54864.45135548673, 1497.423491955605, 1533.1414407931818, 1535.654477742499, 1538.4922975418085, 1548.7367147584712, 23907.834283903372, 25192.74807251904, 26299.73700262973, 28418.721157547545, 29113.0, 49516.50483495119, 49774.502254976986, 49869.75065124651, 49937.751556211384, 49950.750246248535, 403690.0, 404434.0, 404477.0, 404489.0, 405448.0, 27449.588256175775, 28277.57583636206, 32686.855960041285, 34072.31855362929, 34285.0, 38993.610063898996, 40728.98177545585, 40730.592694073865, 40884.97787555335, 40936.79531602323, 23129.0, 24928.0, 28653.856730716212, 28996.27509312284, 29964.400711986073, 29254.41491170207, 29320.0, 29548.96578619738, 30302.696973029986, 30390.0, 30857.074287771404, 31878.043658690276, 31957.36085278235, 32109.35781284408, 32123.678763213004, 29174.124776256747, 29503.85248073746, 29575.704242957294, 29918.70081299246, 30074.0, 19914.70127948111, 21056.473588159806, 23205.839708014868, 23331.18340858062, 23782.16762413307], "value": 18608.155548823674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.6006423929388, 434.25308469432576, 434.83041613770627, 439.34976235171945, 448.05013371652103, 20753.896230518843, 21222.83274419908, 21755.67366489504, 21975.23086691966, 22068.448288792788, 21685.566288674218, 22132.446688832788, 22146.335609931688, 22478.438039049033, 22794.31617051487, 5520.723963801814, 6453.515986301023, 6679.799606011803, 6891.5872246189665, 7094.964525177367, 6889.276625954278, 7057.541259818121, 7090.220075791659, 7091.149062112554, 7095.113110861143, 6787.932120678779, 6972.093627828375, 7008.684609192573, 7023.0, 7088.4683648726295, 6617.841877671388, 6905.240423553405, 6905.827354316132, 6943.0, 6958.338957799001, 6827.761028364033, 6843.247242803288, 6844.0, 6848.417884479825, 6855.07456493372, 24632.0, 25709.614355784677, 27617.447651047067, 27707.584386234223, 28072.877084916578, 3027.5458681197774, 3070.815751054944, 3074.98462507686, 3081.1988882890387, 3091.644460886982, 13682.631736826337, 15415.922920385327, 15539.30073146711, 16428.6714265714, 16737.91631041849, 1871.1953859840398, 2006.5084054406618, 2058.742657167854, 2107.7681455039933, 2119.300630791835, 104443.43334849984, 133761.0, 168201.0, 172362.0, 175100.0, 16460.506184814476, 19812.405627831187, 21002.894985524974, 21038.894805525873, 21287.0, 31904.68095319017, 32071.0, 32598.0, 32733.0, 32733.345333093206, 10795.78408431827, 10870.61952831647, 11055.613053543248, 11088.944555277334, 11192.936671016241, 9264.53677316145, 9265.95367023174, 9289.0, 9429.245660347156, 9432.056794320513, 9419.659500434946, 9698.47839561719, 9719.611215551298, 9791.0, 9824.705258842247, 3510.7717998330027, 4165.187788381237, 4221.535631080578, 4231.19607274623, 4237.406763053175, 773.7485317271796, 805.8831469436899, 839.4837175137369, 863.1411745313453, 879.872418499314, 21270.680939785914, 22198.0, 22587.0, 22713.659295110585, 22848.0, 894.8478758611052, 897.237348253992, 915.6291701860757, 918.7840857398639, 926.7544100813155, 10765.354078755143, 11529.423528823525, 11780.99861511764, 11814.46834892432, 11824.704382390337, 693935.0, 695966.0, 709331.0, 712554.0, 717660.0, 106526.0, 124794.0, 126124.0, 132878.0, 138338.0, 1280.9935950320375, 1320.458611969088, 1337.3848029906353, 1339.3437215764206, 1341.5841089262165, 19693.60612787765, 19884.801151988875, 20397.79602203959, 20467.0, 20479.4880127998, 60911.78176436358, 61564.0, 61829.9999999982, 62270.688646556475, 62582.68708656428, 77666.0, 87183.56408217919, 89225.0, 90452.54773726089, 91521.5423922876, 6897.89653155193, 10946.233763636468, 11211.215214935202, 11253.71865703364, 11628.011619012479, 12226.877731222574, 13203.867961320264, 13270.469181232642, 13308.93345533266, 13550.864491355354, 9997.900020999989, 10740.355578664992, 11198.16013798952, 11382.715432114263, 11535.423228838357, 8173.550454724809, 8879.0, 10088.949555252177, 10647.0, 10915.508802103766, 11012.779744405227, 11588.768224635629, 11751.412429378326, 11811.114166437723, 11920.761584768083, 11580.768384632429, 11591.478383472595, 11606.825897611374, 11691.766164676488, 11886.643400697993, 11043.895610438893, 11232.66302010941, 11367.943160284476, 11439.942800286279, 11618.360990145624], "value": 11554.35576173794, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1246.738184981154, 1623.6022174567229, 1629.0388670684295, 1645.9341626334954, 1653.4956838164355, 8451.57742112895, 9713.757156071102, 10952.5618975241, 11664.125190610706, 11673.883261167386, 10911.945440272788, 11298.661040168787, 11304.886951130486, 11309.604163854267, 11310.717232069183, 2455.8772061396903, 2503.2240005598323, 2521.697396312445, 2533.4933013397304, 2543.3768726661992, 2090.4042347930845, 2456.1280745335416, 2530.202986059395, 2533.278015765507, 2534.721180670125, 2497.3506888209013, 2510.184190138203, 2516.484120755241, 2516.660250866128, 2523.864261082511, 2487.9378015549664, 2493.6259561065804, 2493.7007559092935, 2496.8002559795173, 2498.912538061177, 2256.6685655463357, 2445.9877700611382, 2456.5578195924727, 2463.1379017343966, 2470.518248941457, 9504.572294246775, 9540.856887146698, 9559.904400955971, 9584.233261339075, 11398.886011139948, 6008.879822403527, 6170.043643235305, 6201.782937597208, 6217.751289948396, 6224.719887605069, 3747.8500859965843, 3888.6111388860886, 3906.0820707133803, 3965.0682089708894, 3968.444417781513, 1072.5173671847622, 1279.0, 1295.533607901155, 1329.9135556188915, 1332.1540821578367, 15592.61018474536, 15890.0, 15924.442644507502, 15946.28241729125, 15959.04245745259, 5003.249512573143, 5182.689038657692, 5246.31797866275, 5249.685018898878, 5284.524392804589, 13351.532696355775, 13369.532066377824, 13390.531331403354, 13394.531191408254, 13397.464101436028, 6129.172561704202, 6158.3841615838055, 6186.412290832363, 6190.50475961922, 6202.5658203925295, 5380.166074258418, 5515.531179849678, 5584.357798853184, 5605.159226116115, 5605.831825045255, 4184.66522678185, 4304.612584867377, 4323.827046918088, 4345.391645169679, 4353.194658988097, 1162.0703437250165, 1188.7503624238834, 1197.2636828350676, 1202.699325168708, 1204.175140029083, 828.1056459024239, 840.4789030800943, 860.3309579415914, 873.4846440599949, 885.6501681835639, 6773.966130169318, 6843.726250949906, 6898.241193468714, 6994.300569942965, 7076.787696369117, 987.1855719031828, 1030.8041472120274, 1038.807820553185, 1056.3872953686844, 1080.1466841195368, 3726.4037753959237, 4001.3197756381487, 4324.005478739908, 4385.859676484137, 4388.802503887333, 13388.0, 14044.016918815585, 14050.36773345202, 14054.508092216724, 14062.789058164135, 13979.39236987739, 13996.950228732885, 14006.509772157926, 14038.947078969119, 14052.718945621235, 9034.86447703285, 9338.673146439842, 10231.13035391985, 10548.525316360781, 10582.312149710091, 7042.0, 7071.858562828817, 7090.680919358538, 7238.457115716237, 7241.565506069653, 12492.500299988262, 12614.810777838156, 12754.872451275369, 12797.808032879328, 12809.0, 11591.188616796744, 12585.811212831997, 12706.809397859224, 12959.352032398154, 13117.344132793512, 9063.818723625622, 9288.256939444964, 9440.150386465251, 9445.858312125461, 9520.952395237979, 10123.7469063274, 10328.0, 10387.480625968823, 10465.738356540844, 10571.841422378824, 8923.063078376677, 8968.461892286223, 9000.63997440095, 9132.817343653223, 9201.769955750891, 8670.609822557873, 8708.956455217683, 8716.607752651273, 8830.470171789713, 8900.5994730236, 7978.601069946596, 8048.356131509582, 8162.347012238888, 8167.673293068211, 8203.630836612487, 5982.58121931478, 5990.880182396415, 6039.15451836752, 6187.783427580013, 6241.937580624317, 6041.24484439445, 6071.180390647206, 6103.6032657877095, 6111.083337499233, 6258.530610204344], "value": 5314.2531757163815, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.674726724086, 398.8025927166053, 401.9308639020207, 404.37927780856376, 405.61482537135674, 4736.100140973213, 4767.594754445868, 5224.21636754487, 5464.890702185959, 5526.309211348582, 4736.786844591993, 5352.2239275305055, 5385.495744478817, 5453.509184173424, 5455.345358556969, 3823.1589050408866, 4041.6766658667384, 4410.25025745624, 4436.846419930809, 4524.886877828064, 3784.5458544974504, 4369.759663218521, 4483.5964763171305, 4506.797194126272, 4530.79611417487, 3541.0786101466265, 3937.7243592948507, 4329.956700433003, 4443.400140980959, 4560.33875088112, 3376.7129793967542, 3948.190620922704, 4407.735535867858, 4443.667249562828, 4478.2386994211065, 3436.3642726095754, 3662.8717994870317, 3776.376897811858, 4096.549379568245, 4163.39630753539, 4600.5169457207185, 5239.816606418757, 5286.682799032032, 5360.571154307646, 5400.324959380077, 4757.857264282077, 5054.494550544953, 5141.845744627667, 5192.3528442044535, 5232.790688372461, 5373.328333958255, 5485.369182544018, 5807.709614519257, 5833.88332233353, 5836.649801011953, 3796.8988993191942, 4351.430997452662, 4586.1744885920525, 4639.953600463986, 4649.721016738973, 5149.922751158736, 5219.634625576211, 5490.423505531941, 5521.779128834842, 5936.881262374728, 3709.870154544578, 4673.766311684402, 4710.764461776897, 4758.78585463655, 4759.215858722617, 4310.418093557392, 4550.522195169526, 4775.283707443842, 4843.505594618704, 4857.392825896763, 4247.5752424757275, 4417.757023363682, 4973.975130124399, 5087.338645976073, 5169.604206864125, 4667.929981050287, 5080.012190430494, 5377.660717587862, 5753.626014309057, 5801.7099145042575, 1390.9289846817894, 1432.4986254810942, 1625.8618017468648, 1636.9181540922907, 1651.6201273706874, 1087.005390068079, 1140.7946569617548, 1188.839506666589, 1233.6052463211686, 1261.2054405724334, 5301.575873930076, 5465.87821639766, 5496.560275177976, 5512.80705175317, 5536.889262214733, 5008.924866127011, 5584.609077364546, 5927.673977931169, 5954.196183515257, 6016.789412370546, 4824.237095065854, 5074.974625126851, 5082.872928176826, 5510.834674959678, 5512.6968016759465, 2866.7706583473273, 3020.758339332892, 3102.2709663229125, 3164.275469868881, 3172.175234439016, 5012.774425150877, 5504.889902201933, 5735.799247026334, 6203.937960620427, 6311.832311022476, 5924.31870334917, 5964.882466724251, 6085.66528840918, 6089.878202436015, 6209.285932117774, 6219.689015549295, 6260.968695156586, 6269.529785266123, 6284.591501552384, 6305.337939516285, 4995.375578052744, 5285.7621407036, 5724.427557244242, 5995.520358371407, 6040.969795151172, 5047.7476126192805, 5286.229113246952, 5408.702521361363, 5601.3476024573665, 5745.2818397700285, 5556.861078473071, 6002.609830361187, 6172.598781079216, 6182.1345011699295, 6222.688865556795, 4158.251514727257, 4718.791221968957, 4901.627544287605, 5253.973730131478, 5304.124819404755, 5414.566834653139, 5454.5091141670155, 5677.0, 5814.993827129802, 5945.10823376497, 5323.813666521653, 5537.0, 5725.570582206268, 5729.62757420783, 5778.306603207642, 5080.46655101209, 5341.359036915595, 5460.372057213472, 5839.445252700986, 5849.811852540291, 4816.662833601615, 5099.439061703284, 5263.473652634706, 5588.608797384144, 5676.914846277226, 5287.524122828964, 5321.680699158062, 5450.373207081077, 5851.531877449709, 5864.67744274069, 4484.11231757386, 4656.767161641972, 4746.359241502353, 5752.418085026651, 5760.963026655242], "value": 4374.26595650525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.7407715654077, 758.2455456820464, 759.1952530317864, 869.7086476030529, 885.9069797671244, 13530.661733456669, 16468.0, 16985.235664395103, 17087.48737537873, 17108.828911710894, 13173.604791856236, 15863.048217106982, 16054.956427832212, 16280.348786048544, 16310.0, 844.3287586368821, 979.4074584876137, 1011.5700827148469, 1027.650598796409, 1030.3457304611588, 980.4264505264429, 1017.120191034757, 1018.694391682496, 1020.8366661334188, 1028.8816786069585, 1063.0910571461404, 1074.5486895503907, 1076.5532304093792, 1079.1097344690622, 1080.173667144635, 1070.9143268538498, 1072.244067932106, 1072.9195310351715, 1072.9785404291908, 1074.178253635973, 715.1811176203219, 756.7427074794541, 787.279639130201, 792.5640897506406, 800.2517646001007, 16467.176641167895, 16475.91762041194, 16612.750808737877, 17280.22238999248, 17351.958882466966, 14679.192644404553, 14902.627434314121, 14942.028768130036, 14952.775708364383, 15116.94181407302, 10650.786984260349, 11869.46587403569, 12105.939470302681, 12270.938645306716, 12335.876641233563, 3852.210296889131, 3918.15759611682, 3924.4309575111733, 4073.388991651246, 4075.797639696267, 119021.0, 120465.39767301107, 123834.0, 124135.0, 125711.0, 11144.164187685956, 11382.373969431761, 11485.885141148481, 11522.481488333045, 11706.648800535997, 23270.418239544146, 23572.528549428916, 23797.929093190847, 23879.52240955171, 23903.402414939766, 8061.6372263248295, 8070.919290807017, 8081.272685458337, 8084.797880052928, 8205.58972051395, 4514.593686568159, 4532.546745325441, 4602.263637817933, 4652.62778977681, 4665.953340466552, 3643.417053271517, 3714.3871261241593, 3729.310077635646, 3742.9812850935573, 3763.849446022183, 668.4418510543653, 669.5413641655482, 671.5064427645676, 684.1858188755365, 686.2142846440797, 707.504746677328, 709.5139829217003, 727.4435057181261, 734.3904559215838, 763.6983391560302, 9213.170814626716, 9923.393282795198, 10155.746106347253, 10373.896261037444, 10769.353838769699, 695.2942763095463, 722.6422920654205, 738.4424759306689, 740.6778051547594, 767.244264399566, 4637.837675681335, 5063.240513922941, 5066.442691303953, 5092.974535127375, 5094.465081166424, 91562.54218728864, 102345.97654023513, 105916.0, 107252.46373768081, 108470.0, 56104.830217170915, 64442.677786610766, 78044.21955780483, 83457.58271208727, 95454.04545954452, 61873.83441579523, 77925.61037194778, 81429.59285203654, 81501.0, 82592.58703706563, 8228.382871284557, 11174.944125279322, 11245.831312530156, 11519.654410367702, 11553.768924621292, 48722.0, 48772.512274878216, 49005.50994490009, 50023.499765001885, 50105.74947125241, 51256.0, 60443.09335359885, 61042.0, 62969.425764354426, 64684.35315646972, 12327.69180770488, 12336.876631233572, 12571.0, 12687.958183208408, 12776.552820651232, 14469.204193769443, 14811.777823332874, 14912.254387280376, 14977.0, 15043.0, 14009.449511042938, 14107.294635268401, 14392.640183995065, 14429.42282308696, 14901.031432956823, 13668.65828354299, 13755.724885502033, 14285.642858928195, 14291.356888939814, 14502.492412765503, 13211.537596184087, 13946.860531394963, 14100.08349457282, 14367.20980346091, 14450.710985780435, 8693.913060869563, 8908.10918908104, 8956.68651597191, 9097.272218222393, 9183.265338772748, 10057.855803240313, 10931.508082136164, 11449.484773185393, 11675.35785531804, 11693.473793679475], "value": 7866.5060264584545, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 121.0, 119.0, 117.0, 118.0, 120.0, 118.0, 119.0, 117.0, 119.0], "value": 117.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 140.0, 97.0, 176.0, 94.0, 134.0, 101.0, 147.0, 162.0, 140.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [264.0, 211.0, 282.0, 274.0, 205.0, 233.0, 197.0, 197.0, 228.0, 190.0], "value": 228.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 59.0, 87.0, 62.0, 61.0, 51.0, 69.0, 101.0, 85.0], "value": 71.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 56.0, 83.0, 95.0, 101.0, 55.0, 96.0, 93.0, 62.0, 99.0], "value": 82.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 88.0, 88.0, 87.0, 105.0, 136.0, 125.0, 87.0, 96.0, 89.0], "value": 100.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 122.0, 115.0, 97.0, 94.0, 100.0, 147.0], "value": 105.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 90.0, 90.0, 90.0, 92.0, 91.0, 97.0, 92.0, 137.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 66.0, 67.0, 67.0, 68.0, 69.0, 67.0, 69.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 64.0, 59.0, 71.0, 63.0, 65.0, 58.0, 59.0, 65.0, 58.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 86.0, 81.0, 82.0, 78.0, 82.0, 82.0, 87.0, 84.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 139.0, 130.0, 135.0, 139.0, 149.0, 150.0, 153.0, 190.0, 148.0], "value": 146.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 161.0, 162.0, 163.0, 166.0, 186.0, 167.0, 164.0, 160.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 78.0, 89.0, 85.0, 85.0, 84.0, 86.0, 65.0], "value": 76.7, "unit": "score"}]}]} 10:48:20 INFO - Return code: 0 10:48:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:48:20 ERROR - # TBPL SUCCESS # 10:48:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:48:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:48:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:48:20 INFO - 2017-05-11 10:48:20.826 screenresolution[1672:11824] starting screenresolution argv=screenresolution get 10:48:20 INFO - 2017-05-11 10:48:20.831 screenresolution[1672:11824] Display 0: 1600x1200x32@60 10:48:20 INFO - 2017-05-11 10:48:20.837 screenresolution[1673:11827] starting screenresolution argv=screenresolution list 10:48:20 INFO - Available Modes on Display 0 10:48:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:48:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:48:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:48:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:48:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:48:21 INFO - Intel Iris: 10:48:21 INFO - Chipset Model: Intel Iris 10:48:21 INFO - Type: GPU 10:48:21 INFO - Bus: Built-In 10:48:21 INFO - VRAM (Dynamic, Max): 1536 MB 10:48:21 INFO - Vendor: Intel (0x8086) 10:48:21 INFO - Device ID: 0x0a2e 10:48:21 INFO - Revision ID: 0x0009 10:48:21 INFO - Displays: 10:48:21 INFO - Display: 10:48:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:48:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:48:21 INFO - Display Serial Number: 1600x1200 60 10:48:21 INFO - Main Display: Yes 10:48:21 INFO - Mirror: Off 10:48:21 INFO - Online: Yes 10:48:21 INFO - Rotation: Supported 10:48:21 INFO - Return code: 0 10:48:21 INFO - Running post-action listener: _resource_record_post_action 10:48:21 INFO - [mozharness: 2017-05-11 17:48:21.074940Z] Finished run-tests step (success) 10:48:21 INFO - Running post-run listener: _resource_record_post_run 10:48:21 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 34033664; Write bytes: 427425792; Read time: 203; Write time: 1495 10:48:21 INFO - TinderboxPrint: CPU usage
54.2% 10:48:21 INFO - TinderboxPrint: I/O read bytes / time
34,033,664 / 203 10:48:21 INFO - TinderboxPrint: I/O write bytes / time
427,425,792 / 1,495 10:48:21 INFO - TinderboxPrint: CPU idle
2,183.4 (45.8%) 10:48:21 INFO - TinderboxPrint: CPU system
953.0 (20.0%) 10:48:21 INFO - TinderboxPrint: CPU user
1,633.3 (34.2%) 10:48:21 INFO - TinderboxPrint: Swap in / out
153,280,512 / 0 10:48:21 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 123070976; Write bytes: 122859520; Read time: 11198; Write time: 274 10:48:21 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 30441472; Write bytes: 303255552; Read time: 180; Write time: 1216 10:48:21 INFO - Running post-run listener: _upload_blobber_files 10:48:21 INFO - Blob upload gear active. 10:48:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:48:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:48:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:48:21 INFO - (blobuploader) - INFO - Open directory for files ... 10:48:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:48:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:48:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:23 INFO - (blobuploader) - INFO - Done attempting. 10:48:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:48:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:48:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:24 INFO - (blobuploader) - INFO - Done attempting. 10:48:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:48:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:48:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:25 INFO - (blobuploader) - INFO - Done attempting. 10:48:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:48:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:48:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:26 INFO - (blobuploader) - INFO - Done attempting. 10:48:26 INFO - (blobuploader) - INFO - Iteration through files over. 10:48:26 INFO - Return code: 0 10:48:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:48:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:48:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c9f0012058882fc1ee97fcc518d7f313a969a9fa785f8126bdfe8c9820cf7a8616df1d95b14bb84d496a1d2765a27ce47e9663e7caeaac399d38fc45fd0386ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0b03cb1a70de4dcf5ef827664a863dde0f0241a81430a70b683faa8681084f8240ac70764e192a910cb7b092ffb6be3b4b56b2151992cf16e5670b97418f7a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3af2fc2e1a9640bb9c5ea65389af9932dbc0419cc96fc302f6b9c1d44230e3c305cb170f8e9c0d7ccc82a16a32c8ce47c18b92461f553be1ecad49485bad9de0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1f1b5ea4cd95079874163d58ff54b76d7ad6e209ace27cf2b1694c47cf76ee7aea028ea6b93f005c67f497f49b9802249477947c2e1433be2dba21de353de4c"} 10:48:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:48:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:48:26 INFO - Contents: 10:48:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c9f0012058882fc1ee97fcc518d7f313a969a9fa785f8126bdfe8c9820cf7a8616df1d95b14bb84d496a1d2765a27ce47e9663e7caeaac399d38fc45fd0386ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0b03cb1a70de4dcf5ef827664a863dde0f0241a81430a70b683faa8681084f8240ac70764e192a910cb7b092ffb6be3b4b56b2151992cf16e5670b97418f7a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3af2fc2e1a9640bb9c5ea65389af9932dbc0419cc96fc302f6b9c1d44230e3c305cb170f8e9c0d7ccc82a16a32c8ce47c18b92461f553be1ecad49485bad9de0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1f1b5ea4cd95079874163d58ff54b76d7ad6e209ace27cf2b1694c47cf76ee7aea028ea6b93f005c67f497f49b9802249477947c2e1433be2dba21de353de4c"} 10:48:26 INFO - Running post-run listener: copy_logs_to_upload_dir 10:48:26 INFO - Copying logs to upload dir... 10:48:27 INFO - mkdir: /builds/slave/test/build/upload/logs 10:48:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2477.091795 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 41 mins, 17 secs) (at 2017-05-11 10:48:27.067215) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 10:48:27.071198) ========= 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.PP7fEZ8BD1/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.CUITJNsjgh/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c9f0012058882fc1ee97fcc518d7f313a969a9fa785f8126bdfe8c9820cf7a8616df1d95b14bb84d496a1d2765a27ce47e9663e7caeaac399d38fc45fd0386ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0b03cb1a70de4dcf5ef827664a863dde0f0241a81430a70b683faa8681084f8240ac70764e192a910cb7b092ffb6be3b4b56b2151992cf16e5670b97418f7a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3af2fc2e1a9640bb9c5ea65389af9932dbc0419cc96fc302f6b9c1d44230e3c305cb170f8e9c0d7ccc82a16a32c8ce47c18b92461f553be1ecad49485bad9de0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1f1b5ea4cd95079874163d58ff54b76d7ad6e209ace27cf2b1694c47cf76ee7aea028ea6b93f005c67f497f49b9802249477947c2e1433be2dba21de353de4c"} build_url:https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010731 build_url: 'https://queue.taskcluster.net/v1/task/Hp79HtgBSpCFwBzfqR0Mzw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c9f0012058882fc1ee97fcc518d7f313a969a9fa785f8126bdfe8c9820cf7a8616df1d95b14bb84d496a1d2765a27ce47e9663e7caeaac399d38fc45fd0386ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0b03cb1a70de4dcf5ef827664a863dde0f0241a81430a70b683faa8681084f8240ac70764e192a910cb7b092ffb6be3b4b56b2151992cf16e5670b97418f7a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3af2fc2e1a9640bb9c5ea65389af9932dbc0419cc96fc302f6b9c1d44230e3c305cb170f8e9c0d7ccc82a16a32c8ce47c18b92461f553be1ecad49485bad9de0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1f1b5ea4cd95079874163d58ff54b76d7ad6e209ace27cf2b1694c47cf76ee7aea028ea6b93f005c67f497f49b9802249477947c2e1433be2dba21de353de4c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 10:48:27.104011) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 10:48:27.104344) ========= 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.PP7fEZ8BD1/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.CUITJNsjgh/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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.005303 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 10:48:27.154903) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 10:48:27.155220) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 10:48:27.155547) ========= ========= Total master_lag: 0.18 =========