builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0357 starttime: 1487411882.64 results: success (0) buildid: 20170218004013 builduid: a6787a1668ce4ef0b35a6e629093e0ca revision: 104592a2b9be438203cfc489e60e0db851466ce5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-18 01:58:02.636817) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-18 01:58:02.637311) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-18 01:58:02.637609) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-18 01:58:02.664253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-18 01:58:02.664622) ========= 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.0oW5TIjpWi/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.yuEEJSmmbB/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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-02-18 01:58:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 24.4M=0s 2017-02-18 01:58:03 (24.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.629609 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-18 01:58:03.320565) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-18 01:58:03.320907) ========= 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.0oW5TIjpWi/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.yuEEJSmmbB/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.029265 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-18 01:58:03.373945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-18 01:58:03.374358) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 104592a2b9be438203cfc489e60e0db851466ce5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 104592a2b9be438203cfc489e60e0db851466ce5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0oW5TIjpWi/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.yuEEJSmmbB/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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-02-18 01:58:03,510 truncating revision to first 12 chars 2017-02-18 01:58:03,510 Setting DEBUG logging. 2017-02-18 01:58:03,510 attempt 1/10 2017-02-18 01:58:03,511 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/104592a2b9be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-18 01:58:04,278 unpacking tar archive at: mozilla-aurora-104592a2b9be/testing/mozharness/ program finished with exit code 0 elapsedTime=1.027443 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-18 01:58:04.426051) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-18 01:58:04.426417) ========= script_repo_revision: 104592a2b9be438203cfc489e60e0db851466ce5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-18 01:58:04.426846) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-18 01:58:04.427135) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-18 01:58:04.451241) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-18 01:58:04.451567) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0oW5TIjpWi/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.yuEEJSmmbB/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 01:58:04 INFO - MultiFileLogger online at 20170218 01:58:04 in /builds/slave/test 01:58:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:58:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:58:04 INFO - {'append_to_log': False, 01:58:04 INFO - 'base_work_dir': '/builds/slave/test', 01:58:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:58:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:58:04 INFO - 'branch': 'Mozilla-Aurora', 01:58:04 INFO - 'buildbot_json_path': 'buildprops.json', 01:58:04 INFO - 'config_files': ('talos/mac_config.py',), 01:58:04 INFO - 'default_actions': ('clobber', 01:58:04 INFO - 'read-buildbot-config', 01:58:04 INFO - 'download-and-extract', 01:58:04 INFO - 'populate-webroot', 01:58:04 INFO - 'create-virtualenv', 01:58:04 INFO - 'install', 01:58:04 INFO - 'run-tests'), 01:58:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:58:04 INFO - 'download_minidump_stackwalk': True, 01:58:04 INFO - 'download_symbols': 'ondemand', 01:58:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:58:04 INFO - 'tooltool.py': '/tools/tooltool.py', 01:58:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:58:04 INFO - '/tools/misc-python/virtualenv.py')}, 01:58:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:58:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:58:04 INFO - 'installer_path': 'installer.exe', 01:58:04 INFO - 'log_level': 'info', 01:58:04 INFO - 'log_name': 'talos', 01:58:04 INFO - 'log_to_console': True, 01:58:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:58:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:58:04 INFO - 'opt_config_files': (), 01:58:04 INFO - 'pip_index': False, 01:58:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:58:04 INFO - 'cmd': ('bash', 01:58:04 INFO - '-c', 01:58:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:58:04 INFO - 'enabled': True, 01:58:04 INFO - 'halt_on_failure': False, 01:58:04 INFO - 'name': 'check_screen_resolution'},), 01:58:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:58:04 INFO - 'cmd': ('bash', 01:58:04 INFO - '-c', 01:58:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:58:04 INFO - 'enabled': True, 01:58:04 INFO - 'halt_on_failure': False, 01:58:04 INFO - 'name': 'check_screen_resolution'},), 01:58:04 INFO - 'run_cmd_checks_enabled': True, 01:58:04 INFO - 'sps_profile': False, 01:58:04 INFO - 'sps_profile_interval': 0, 01:58:04 INFO - 'suite': 'dromaeojs-e10s', 01:58:04 INFO - 'system_bits': '32', 01:58:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:58:04 INFO - 'title': 't-yosemite-r7-0357', 01:58:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:58:04 INFO - 'use_talos_json': True, 01:58:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:58:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:58:04 INFO - 'work_dir': 'build'} 01:58:04 INFO - [mozharness: 2017-02-18 09:58:04.696908Z] Running clobber step. 01:58:04 INFO - Running pre-action listener: _resource_record_pre_action 01:58:04 INFO - Running main action method: clobber 01:58:04 INFO - rmtree: /builds/slave/test/build 01:58:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:58:07 INFO - Running post-action listener: _resource_record_post_action 01:58:07 INFO - [mozharness: 2017-02-18 09:58:07.206078Z] Finished clobber step (success) 01:58:07 INFO - [mozharness: 2017-02-18 09:58:07.206239Z] Running read-buildbot-config step. 01:58:07 INFO - Running pre-action listener: _resource_record_pre_action 01:58:07 INFO - Running main action method: read_buildbot_config 01:58:07 INFO - Using buildbot properties: 01:58:07 INFO - { 01:58:07 INFO - "project": "", 01:58:07 INFO - "product": "firefox", 01:58:07 INFO - "script_repo_revision": "production", 01:58:07 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 01:58:07 INFO - "repository": "", 01:58:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 01:58:07 INFO - "buildid": "20170218004013", 01:58:07 INFO - "stage_platform": "macosx64", 01:58:07 INFO - "basedir": "/builds/slave/test", 01:58:07 INFO - "nightly_build": "True", 01:58:07 INFO - "buildnumber": 55, 01:58:07 INFO - "slavename": "t-yosemite-r7-0357", 01:58:07 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 01:58:07 INFO - "platform": "yosemite_r7", 01:58:07 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:58:07 INFO - "branch": "mozilla-aurora", 01:58:07 INFO - "repo_path": "releases/mozilla-aurora", 01:58:07 INFO - "revision": "104592a2b9be438203cfc489e60e0db851466ce5", 01:58:07 INFO - "pgo_build": "False", 01:58:07 INFO - "builduid": "a6787a1668ce4ef0b35a6e629093e0ca", 01:58:07 INFO - "slavebuilddir": "test" 01:58:07 INFO - } 01:58:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 01:58:07 INFO - Running post-action listener: _resource_record_post_action 01:58:07 INFO - [mozharness: 2017-02-18 09:58:07.209897Z] Finished read-buildbot-config step (success) 01:58:07 INFO - [mozharness: 2017-02-18 09:58:07.210033Z] Running download-and-extract step. 01:58:07 INFO - Running pre-action listener: _resource_record_pre_action 01:58:07 INFO - Running main action method: download_and_extract 01:58:07 INFO - mkdir: /builds/slave/test/build/tests 01:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:07 INFO - trying https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 01:58:07 INFO - Downloading https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 01:58:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 01:58:08 INFO - Downloaded 1199 bytes. 01:58:08 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 01:58:08 INFO - Using the following test package requirements: 01:58:08 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 01:58:08 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:58:08 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 01:58:08 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:58:08 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 01:58:08 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:58:08 INFO - u'jsshell-mac.zip'], 01:58:08 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:58:08 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 01:58:08 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 01:58:08 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:58:08 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 01:58:08 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:58:08 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 01:58:08 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:58:08 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 01:58:08 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:58:08 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 01:58:08 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:58:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 01:58:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:58:08 INFO - Fetch https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 01:58:09 INFO - Expected file size: 16358963 01:58:09 INFO - Obtained file size: 16358963 01:58:15 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 01:58:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 01:58:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:58:15 INFO - Fetch https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 01:58:16 INFO - Expected file size: 16358963 01:58:16 INFO - Obtained file size: 16358963 01:58:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 01:58:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:58:23 INFO - Fetch https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 01:58:23 INFO - Expected file size: 14403485 01:58:23 INFO - Obtained file size: 14403485 01:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:24 INFO - trying https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 01:58:24 INFO - Downloading https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 01:58:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 01:58:26 INFO - Downloaded 74023109 bytes. 01:58:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 01:58:26 INFO - mkdir: /builds/slave/test/properties 01:58:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:58:26 INFO - Writing to file /builds/slave/test/properties/build_url 01:58:26 INFO - Contents: 01:58:26 INFO - build_url:https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 01:58:27 INFO - Running post-action listener: _resource_record_post_action 01:58:27 INFO - Running post-action listener: set_extra_try_arguments 01:58:27 INFO - [mozharness: 2017-02-18 09:58:27.223951Z] Finished download-and-extract step (success) 01:58:27 INFO - [mozharness: 2017-02-18 09:58:27.224099Z] Running populate-webroot step. 01:58:27 INFO - Running pre-action listener: _resource_record_pre_action 01:58:27 INFO - Running main action method: populate_webroot 01:58:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:58:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:58:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:58:27 INFO - '--tppagecycles', 01:58:27 INFO - '7'], 01:58:27 INFO - 'tests': ['tsvgm']}}, 01:58:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:58:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:58:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:58:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:58:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:58:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:58:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:58:27 INFO - 'talos_options': ['--disable-e10s'], 01:58:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:58:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:58:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:58:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:58:27 INFO - 'talos_options': ['--disable-e10s'], 01:58:27 INFO - 'tests': ['damp', 'tps']}, 01:58:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:58:27 INFO - 'tests': ['damp', 'tps']}, 01:58:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:58:27 INFO - 'tests': ['dromaeo_dom']}, 01:58:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:58:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:58:27 INFO - 'tests': ['basic_compositor_video']}, 01:58:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:58:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:58:27 INFO - 'tests': ['a11yr', 01:58:27 INFO - 'ts_paint', 01:58:27 INFO - 'tpaint', 01:58:27 INFO - 'sessionrestore', 01:58:27 INFO - 'sessionrestore_no_auto_restore', 01:58:27 INFO - 'tabpaint']}, 01:58:27 INFO - 'other-e10s': {'tests': ['a11yr', 01:58:27 INFO - 'ts_paint', 01:58:27 INFO - 'tpaint', 01:58:27 INFO - 'sessionrestore', 01:58:27 INFO - 'sessionrestore_no_auto_restore', 01:58:27 INFO - 'tabpaint']}, 01:58:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:58:27 INFO - 'ts_paint', 01:58:27 INFO - 'tpaint', 01:58:27 INFO - 'sessionrestore', 01:58:27 INFO - 'sessionrestore_no_auto_restore', 01:58:27 INFO - 'tabpaint']}, 01:58:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:58:27 INFO - 'ts_paint', 01:58:27 INFO - 'tpaint', 01:58:27 INFO - 'sessionrestore', 01:58:27 INFO - 'sessionrestore_no_auto_restore', 01:58:27 INFO - 'tabpaint']}, 01:58:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:58:27 INFO - 'tests': ['a11yr', 01:58:27 INFO - 'ts_paint', 01:58:27 INFO - 'tpaint', 01:58:27 INFO - 'sessionrestore', 01:58:27 INFO - 'sessionrestore_no_auto_restore', 01:58:27 INFO - 'tabpaint']}, 01:58:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:58:27 INFO - 'tests': ['a11yr', 01:58:27 INFO - 'ts_paint', 01:58:27 INFO - 'tpaint', 01:58:27 INFO - 'sessionrestore', 01:58:27 INFO - 'sessionrestore_no_auto_restore', 01:58:27 INFO - 'tabpaint']}, 01:58:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:58:27 INFO - 'tests': ['tsvgx', 01:58:27 INFO - 'tsvgr_opacity', 01:58:27 INFO - 'tart', 01:58:27 INFO - 'tscrollx', 01:58:27 INFO - 'cart', 01:58:27 INFO - 'tsvg_static']}, 01:58:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:58:27 INFO - 'tsvgr_opacity', 01:58:27 INFO - 'tart', 01:58:27 INFO - 'tscrollx', 01:58:27 INFO - 'cart', 01:58:27 INFO - 'tsvg_static']}, 01:58:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:58:27 INFO - 'talos_options': ['--disable-e10s'], 01:58:27 INFO - 'tests': ['tp5o']}, 01:58:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:58:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:58:27 INFO - 'talos_options': ['--disable-e10s', 01:58:27 INFO - '--xperf_path', 01:58:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:58:27 INFO - 'tests': ['tp5n']}, 01:58:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:58:27 INFO - 'talos_options': ['--xperf_path', 01:58:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:58:27 INFO - 'tests': ['tp5n']}}, 01:58:27 INFO - 'talos.zip': {'path': '', 01:58:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:58:27 INFO - Running post-action listener: _resource_record_post_action 01:58:27 INFO - [mozharness: 2017-02-18 09:58:27.242381Z] Finished populate-webroot step (success) 01:58:27 INFO - [mozharness: 2017-02-18 09:58:27.242514Z] Running create-virtualenv step. 01:58:27 INFO - Running pre-action listener: _resource_record_pre_action 01:58:27 INFO - Running main action method: create_virtualenv 01:58:27 INFO - Creating virtualenv /builds/slave/test/build/venv 01:58:27 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 01:58:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:58:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:58:27 INFO - Using real prefix '/tools/python27' 01:58:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:58:28 INFO - Installing distribute.............................................................................................................................................................................................done. 01:58:31 INFO - Installing pip.................done. 01:58:31 INFO - Return code: 0 01:58:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:58:31 INFO - Reading from file tmpfile_stdout 01:58:31 INFO - Output received: 01:58:31 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) 01:58:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe413c921f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b4d30>, '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 0x10f2dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a9be8>, '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.0oW5TIjpWi/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.yuEEJSmmbB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 01:58:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:58:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0oW5TIjpWi/Render', 01:58:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:58:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:58:31 INFO - 'HOME': '/Users/cltbld', 01:58:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:58:31 INFO - 'LOGNAME': 'cltbld', 01:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:31 INFO - 'MOZ_NO_REMOTE': '1', 01:58:31 INFO - 'NO_EM_RESTART': '1', 01:58:31 INFO - 'PAGER': '/bin/cat', 01:58:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:31 INFO - 'PWD': '/builds/slave/test', 01:58:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:58:31 INFO - 'SHELL': '/bin/bash', 01:58:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuEEJSmmbB/Listeners', 01:58:31 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 01:58:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:58:31 INFO - 'USER': 'cltbld', 01:58:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:58:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:31 INFO - 'XPC_FLAGS': '0x0', 01:58:31 INFO - 'XPC_SERVICE_NAME': '0', 01:58:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:31 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 01:58:31 INFO - Cleaning up... 01:58:31 INFO - Return code: 0 01:58:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f5d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe413c921f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b4d30>, '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 0x10f2dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a9be8>, '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.0oW5TIjpWi/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.yuEEJSmmbB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 01:58:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:58:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0oW5TIjpWi/Render', 01:58:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:58:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:58:31 INFO - 'HOME': '/Users/cltbld', 01:58:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:58:31 INFO - 'LOGNAME': 'cltbld', 01:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:31 INFO - 'MOZ_NO_REMOTE': '1', 01:58:31 INFO - 'NO_EM_RESTART': '1', 01:58:31 INFO - 'PAGER': '/bin/cat', 01:58:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:31 INFO - 'PWD': '/builds/slave/test', 01:58:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:58:31 INFO - 'SHELL': '/bin/bash', 01:58:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuEEJSmmbB/Listeners', 01:58:31 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 01:58:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:58:31 INFO - 'USER': 'cltbld', 01:58:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:58:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:31 INFO - 'XPC_FLAGS': '0x0', 01:58:31 INFO - 'XPC_SERVICE_NAME': '0', 01:58:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:31 INFO - Downloading/unpacking psutil>=3.1.1 01:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:58:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:58:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:58:35 INFO - Installing collected packages: psutil 01:58:35 INFO - Running setup.py install for psutil 01:58:35 INFO - building 'psutil._psutil_osx' extension 01:58:35 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 01:58:36 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 01:58:36 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 01:58:36 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 01:58:36 INFO - building 'psutil._psutil_posix' extension 01:58:36 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 01:58:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:58:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:58:36 INFO - ^ 01:58:36 INFO - 1 warning generated. 01:58:36 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 01:58:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:58:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:58:36 INFO - Successfully installed psutil 01:58:36 INFO - Cleaning up... 01:58:37 INFO - Return code: 0 01:58:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe413c921f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b4d30>, '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 0x10f2dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a9be8>, '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.0oW5TIjpWi/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.yuEEJSmmbB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 01:58:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:58:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0oW5TIjpWi/Render', 01:58:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:58:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:58:37 INFO - 'HOME': '/Users/cltbld', 01:58:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:58:37 INFO - 'LOGNAME': 'cltbld', 01:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:37 INFO - 'MOZ_NO_REMOTE': '1', 01:58:37 INFO - 'NO_EM_RESTART': '1', 01:58:37 INFO - 'PAGER': '/bin/cat', 01:58:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:37 INFO - 'PWD': '/builds/slave/test', 01:58:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:58:37 INFO - 'SHELL': '/bin/bash', 01:58:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuEEJSmmbB/Listeners', 01:58:37 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 01:58:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:58:37 INFO - 'USER': 'cltbld', 01:58:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:58:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:37 INFO - 'XPC_FLAGS': '0x0', 01:58:37 INFO - 'XPC_SERVICE_NAME': '0', 01:58:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:58:40 INFO - Installing collected packages: mozsystemmonitor 01:58:40 INFO - Running setup.py install for mozsystemmonitor 01:58:40 INFO - Successfully installed mozsystemmonitor 01:58:40 INFO - Cleaning up... 01:58:40 INFO - Return code: 0 01:58:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:40 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 0x10f5d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe413c921f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b4d30>, '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 0x10f2dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a9be8>, '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.0oW5TIjpWi/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.yuEEJSmmbB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 01:58:40 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 01:58:40 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 01:58:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0oW5TIjpWi/Render', 01:58:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:58:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:58:40 INFO - 'HOME': '/Users/cltbld', 01:58:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:58:40 INFO - 'LOGNAME': 'cltbld', 01:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:40 INFO - 'MOZ_NO_REMOTE': '1', 01:58:40 INFO - 'NO_EM_RESTART': '1', 01:58:40 INFO - 'PAGER': '/bin/cat', 01:58:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:40 INFO - 'PWD': '/builds/slave/test', 01:58:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:58:40 INFO - 'SHELL': '/bin/bash', 01:58:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuEEJSmmbB/Listeners', 01:58:40 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 01:58:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:58:40 INFO - 'USER': 'cltbld', 01:58:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:58:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:40 INFO - 'XPC_FLAGS': '0x0', 01:58:40 INFO - 'XPC_SERVICE_NAME': '0', 01:58:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:40 INFO - Downloading/unpacking jsonschema==2.5.1 01:58:40 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 01:58:40 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 01:58:40 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 01:58:40 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 01:58:40 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 01:58:40 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 01:58:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:58:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58:43 INFO - Downloading functools32-3.2.3-2.tar.gz 01:58:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:58:43 INFO - warning: no files found matching '*.txt' 01:58:43 INFO - no previously-included directories found matching 'build' 01:58:43 INFO - no previously-included directories found matching 'dist' 01:58:43 INFO - no previously-included directories found matching '.git*' 01:58:43 INFO - Installing collected packages: jsonschema, functools32 01:58:43 INFO - Running setup.py install for functools32 01:58:43 INFO - warning: no files found matching '*.txt' 01:58:43 INFO - no previously-included directories found matching 'build' 01:58:43 INFO - no previously-included directories found matching 'dist' 01:58:43 INFO - no previously-included directories found matching '.git*' 01:58:43 INFO - Successfully installed jsonschema functools32 01:58:43 INFO - Cleaning up... 01:58:43 INFO - Return code: 0 01:58:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:58: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')]} 01:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58: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')]} 01:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f5d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe413c921f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b4d30>, '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 0x10f2dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a9be8>, '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.0oW5TIjpWi/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.yuEEJSmmbB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 01:58:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:58:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:58:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0oW5TIjpWi/Render', 01:58:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:58:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:58:43 INFO - 'HOME': '/Users/cltbld', 01:58:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:58:43 INFO - 'LOGNAME': 'cltbld', 01:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:43 INFO - 'MOZ_NO_REMOTE': '1', 01:58:43 INFO - 'NO_EM_RESTART': '1', 01:58:43 INFO - 'PAGER': '/bin/cat', 01:58:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:43 INFO - 'PWD': '/builds/slave/test', 01:58:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:58:43 INFO - 'SHELL': '/bin/bash', 01:58:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuEEJSmmbB/Listeners', 01:58:43 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 01:58:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:58:43 INFO - 'USER': 'cltbld', 01:58:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:58:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:43 INFO - 'XPC_FLAGS': '0x0', 01:58:43 INFO - 'XPC_SERVICE_NAME': '0', 01:58:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:58:44 INFO - Cleaning up... 01:58:44 INFO - Return code: 0 01:58:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f5d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe413c921f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b4d30>, '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 0x10f2dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a9be8>, '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.0oW5TIjpWi/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.yuEEJSmmbB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 01:58:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:58:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0oW5TIjpWi/Render', 01:58:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:58:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:58:44 INFO - 'HOME': '/Users/cltbld', 01:58:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:58:44 INFO - 'LOGNAME': 'cltbld', 01:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:44 INFO - 'MOZ_NO_REMOTE': '1', 01:58:44 INFO - 'NO_EM_RESTART': '1', 01:58:44 INFO - 'PAGER': '/bin/cat', 01:58:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:44 INFO - 'PWD': '/builds/slave/test', 01:58:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:58:44 INFO - 'SHELL': '/bin/bash', 01:58:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuEEJSmmbB/Listeners', 01:58:44 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 01:58:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:58:44 INFO - 'USER': 'cltbld', 01:58:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:58:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:44 INFO - 'XPC_FLAGS': '0x0', 01:58:44 INFO - 'XPC_SERVICE_NAME': '0', 01:58:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:44 INFO - Downloading/unpacking blobuploader==1.2.4 01:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:47 INFO - Downloading blobuploader-1.2.4.tar.gz 01:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:58:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:58:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:48 INFO - Downloading docopt-0.6.1.tar.gz 01:58:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:58:48 INFO - Installing collected packages: blobuploader, requests, docopt 01:58:48 INFO - Running setup.py install for blobuploader 01:58:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:58:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:58:48 INFO - Running setup.py install for requests 01:58:49 INFO - Running setup.py install for docopt 01:58:49 INFO - Successfully installed blobuploader requests docopt 01:58:49 INFO - Cleaning up... 01:58:49 INFO - Return code: 0 01:58:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:58: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')]} 01:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58: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')]} 01:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:49 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 0x10f5d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe413c921f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b4d30>, '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 0x10f2dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a9be8>, '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.0oW5TIjpWi/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.yuEEJSmmbB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 01:58:49 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 01:58:49 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 01:58:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0oW5TIjpWi/Render', 01:58:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:58:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:58:49 INFO - 'HOME': '/Users/cltbld', 01:58:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:58:49 INFO - 'LOGNAME': 'cltbld', 01:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:49 INFO - 'MOZ_NO_REMOTE': '1', 01:58:49 INFO - 'NO_EM_RESTART': '1', 01:58:49 INFO - 'PAGER': '/bin/cat', 01:58:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:49 INFO - 'PWD': '/builds/slave/test', 01:58:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:58:49 INFO - 'SHELL': '/bin/bash', 01:58:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuEEJSmmbB/Listeners', 01:58:49 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 01:58:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:58:49 INFO - 'USER': 'cltbld', 01:58:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:58:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:49 INFO - 'XPC_FLAGS': '0x0', 01:58:49 INFO - 'XPC_SERVICE_NAME': '0', 01:58:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:58:49 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-5CbnJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:58:49 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-OR_LDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:58:49 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-3rh0hD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:58:49 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-NxbamQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:58:49 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-SSRjZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:58:50 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-veM5mY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:58:50 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-1MNxBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:58:50 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-EObpw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:58:50 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-xuCdbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:58:50 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-nFQpya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:58:50 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Vdnari-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:58:50 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-RqSGnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:58:50 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-5SkqWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:58:50 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-BR1UGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:51 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-2HuA6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:58:51 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-aI_n9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:58:51 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-A4Bake-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:58:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:58:51 INFO - Running setup.py install for manifestparser 01:58:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:58:51 INFO - Running setup.py install for mozcrash 01:58:51 INFO - Running setup.py install for mozdebug 01:58:51 INFO - Running setup.py install for mozdevice 01:58:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:58:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:58:51 INFO - Running setup.py install for mozfile 01:58:52 INFO - Running setup.py install for mozhttpd 01:58:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:58:52 INFO - Running setup.py install for mozinfo 01:58:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:58:52 INFO - Running setup.py install for mozInstall 01:58:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:58:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:58:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:58:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:58:52 INFO - Running setup.py install for mozleak 01:58:52 INFO - Running setup.py install for mozlog 01:58:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:58:52 INFO - Running setup.py install for moznetwork 01:58:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:58:52 INFO - Running setup.py install for mozprocess 01:58:53 INFO - Running setup.py install for mozprofile 01:58:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:58:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:58:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:58:53 INFO - Running setup.py install for mozrunner 01:58:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:58:53 INFO - Running setup.py install for mozscreenshot 01:58:53 INFO - Running setup.py install for moztest 01:58:53 INFO - Running setup.py install for mozversion 01:58:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:58:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:58:53 INFO - Cleaning up... 01:58:53 INFO - Return code: 0 01:58:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:58:53 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')]} 01:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:53 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')]} 01:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:53 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 0x10f5d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe413c921f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b4d30>, '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 0x10f2dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a9be8>, '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.0oW5TIjpWi/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.yuEEJSmmbB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 01:58:53 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 01:58:53 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 01:58:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0oW5TIjpWi/Render', 01:58:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:58:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:58:53 INFO - 'HOME': '/Users/cltbld', 01:58:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:58:53 INFO - 'LOGNAME': 'cltbld', 01:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:53 INFO - 'MOZ_NO_REMOTE': '1', 01:58:53 INFO - 'NO_EM_RESTART': '1', 01:58:53 INFO - 'PAGER': '/bin/cat', 01:58:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:53 INFO - 'PWD': '/builds/slave/test', 01:58:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:58:53 INFO - 'SHELL': '/bin/bash', 01:58:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuEEJSmmbB/Listeners', 01:58:53 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 01:58:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:58:53 INFO - 'USER': 'cltbld', 01:58:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:58:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:53 INFO - 'XPC_FLAGS': '0x0', 01:58:53 INFO - 'XPC_SERVICE_NAME': '0', 01:58:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:58:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-irHfLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:58:54 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)) 01:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:58:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-mZ3zZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:58:54 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)) 01:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:58:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-gxPnUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:58:54 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)) 01:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:58:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-9uNsUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:58:54 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)) 01:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:58:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-y47MIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:58:54 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)) 01:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:58:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-ZfTjCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:58:54 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)) 01:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:58:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-rWAmuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:58:54 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)) 01:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:58:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-stCjHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:58:55 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)) 01:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:58:55 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-qUbBni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:58:55 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)) 01:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:58:55 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-gy0S2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:58:55 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)) 01:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:58:55 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-zOFSQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:58:55 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)) 01:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:58:55 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-eq7pJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 01:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:58:55 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-chKoyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:58:55 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)) 01:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:58:55 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Ri7juu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:58:55 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)) 01:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:55 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-EAQnAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:55 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)) 01:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:58:55 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-qo3ttz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:58:55 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)) 01:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:58:55 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-_LpFlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:58:56 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)) 01:58:56 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)) 01:58:56 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)) 01:58:56 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)) 01:58:56 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)) 01:58:56 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)) 01:58:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58:58 INFO - Downloading blessings-1.6.tar.gz 01:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:58:58 INFO - Installing collected packages: blessings 01:58:58 INFO - Running setup.py install for blessings 01:58:58 INFO - Successfully installed blessings 01:58:58 INFO - Cleaning up... 01:58:59 INFO - Return code: 0 01:58:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:58:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:58:59 INFO - Reading from file tmpfile_stdout 01:58:59 INFO - Current package versions: 01:58:59 INFO - blessings == 1.6 01:58:59 INFO - blobuploader == 1.2.4 01:58:59 INFO - docopt == 0.6.1 01:58:59 INFO - functools32 == 3.2.3-2 01:58:59 INFO - jsonschema == 2.5.1 01:58:59 INFO - manifestparser == 1.1 01:58:59 INFO - mozInstall == 1.12 01:58:59 INFO - mozcrash == 1.0 01:58:59 INFO - mozdebug == 0.1 01:58:59 INFO - mozdevice == 0.49 01:58:59 INFO - mozfile == 1.2 01:58:59 INFO - mozhttpd == 0.7 01:58:59 INFO - mozinfo == 0.9 01:58:59 INFO - mozleak == 0.1 01:58:59 INFO - mozlog == 3.4 01:58:59 INFO - moznetwork == 0.27 01:58:59 INFO - mozprocess == 0.24 01:58:59 INFO - mozprofile == 0.28 01:58:59 INFO - mozrunner == 6.13 01:58:59 INFO - mozscreenshot == 0.1 01:58:59 INFO - mozsystemmonitor == 0.3 01:58:59 INFO - moztest == 0.8 01:58:59 INFO - mozversion == 1.4 01:58:59 INFO - psutil == 3.1.1 01:58:59 INFO - requests == 1.2.3 01:58:59 INFO - wsgiref == 0.1.2 01:58:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:59 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 0x10f5d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe413c921f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b4d30>, '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 0x10f2dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a9be8>, '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.0oW5TIjpWi/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.yuEEJSmmbB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 01:58:59 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 01:58:59 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 01:58:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0oW5TIjpWi/Render', 01:58:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:58:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:58:59 INFO - 'HOME': '/Users/cltbld', 01:58:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:58:59 INFO - 'LOGNAME': 'cltbld', 01:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:59 INFO - 'MOZ_NO_REMOTE': '1', 01:58:59 INFO - 'NO_EM_RESTART': '1', 01:58:59 INFO - 'PAGER': '/bin/cat', 01:58:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:59 INFO - 'PWD': '/builds/slave/test', 01:58:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:58:59 INFO - 'SHELL': '/bin/bash', 01:58:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuEEJSmmbB/Listeners', 01:58:59 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 01:58:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:58:59 INFO - 'USER': 'cltbld', 01:58:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:58:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:59 INFO - 'XPC_FLAGS': '0x0', 01:58:59 INFO - 'XPC_SERVICE_NAME': '0', 01:58:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:59 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)) 01:58:59 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)) 01:58:59 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)) 01:58:59 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)) 01:58:59 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)) 01:58:59 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)) 01:58:59 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)) 01:58:59 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)) 01:58:59 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)) 01:58:59 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)) 01:58:59 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)) 01:58:59 INFO - Cleaning up... 01:58:59 INFO - Return code: 0 01:58:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:59 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 0x10f5d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe413c921f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b4d30>, '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 0x10f2dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a9be8>, '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.0oW5TIjpWi/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.yuEEJSmmbB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 01:58:59 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 01:58:59 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 01:58:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0oW5TIjpWi/Render', 01:58:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:58:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:58:59 INFO - 'HOME': '/Users/cltbld', 01:58:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:58:59 INFO - 'LOGNAME': 'cltbld', 01:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:59 INFO - 'MOZ_NO_REMOTE': '1', 01:58:59 INFO - 'NO_EM_RESTART': '1', 01:58:59 INFO - 'PAGER': '/bin/cat', 01:58:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:59 INFO - 'PWD': '/builds/slave/test', 01:58:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:58:59 INFO - 'SHELL': '/bin/bash', 01:58:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuEEJSmmbB/Listeners', 01:58:59 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 01:58:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:58:59 INFO - 'USER': 'cltbld', 01:58:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:58:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:59 INFO - 'XPC_FLAGS': '0x0', 01:58:59 INFO - 'XPC_SERVICE_NAME': '0', 01:58:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:58:59 INFO - Cleaning up... 01:58:59 INFO - Return code: 0 01:58:59 INFO - Running post-action listener: _resource_record_post_action 01:58:59 INFO - Running post-action listener: _start_resource_monitoring 01:58:59 INFO - Starting resource monitoring. 01:58:59 INFO - [mozharness: 2017-02-18 09:58:59.935270Z] Finished create-virtualenv step (success) 01:58:59 INFO - [mozharness: 2017-02-18 09:58:59.936300Z] Running install step. 01:58:59 INFO - Running pre-action listener: _resource_record_pre_action 01:58:59 INFO - Running main action method: install 01:58:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:59:00 INFO - Reading from file tmpfile_stdout 01:59:00 INFO - Detecting whether we're running mozinstall >=1.0... 01:59:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:59:00 INFO - Reading from file tmpfile_stdout 01:59:00 INFO - Output received: 01:59:00 INFO - Usage: mozinstall [options] installer 01:59:00 INFO - Options: 01:59:00 INFO - -h, --help show this help message and exit 01:59:00 INFO - -d DEST, --destination=DEST 01:59:00 INFO - Directory to install application into. [default: 01:59:00 INFO - "/builds/slave/test"] 01:59:00 INFO - --app=APP Application being installed. [default: firefox] 01:59:00 INFO - mkdir: /builds/slave/test/build/application 01:59:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 01:59:20 INFO - Reading from file tmpfile_stdout 01:59:20 INFO - Output received: 01:59:20 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:59:20 INFO - Running post-action listener: _resource_record_post_action 01:59:20 INFO - [mozharness: 2017-02-18 09:59:20.111170Z] Finished install step (success) 01:59:20 INFO - [mozharness: 2017-02-18 09:59:20.111349Z] Running run-tests step. 01:59:20 INFO - Running pre-action listener: _resource_record_pre_action 01:59:20 INFO - Running main action method: run_tests 01:59:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:59:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:59:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:59:20 INFO - 2017-02-18 01:59:20.126 screenresolution[1650:8396] starting screenresolution argv=screenresolution get 01:59:20 INFO - 2017-02-18 01:59:20.129 screenresolution[1650:8396] Display 0: 1600x1200x32@60 01:59:20 INFO - 2017-02-18 01:59:20.134 screenresolution[1651:8398] starting screenresolution argv=screenresolution list 01:59:20 INFO - Available Modes on Display 0 01:59:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:59:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:59:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:59:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:59:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:59:20 INFO - Intel Iris: 01:59:20 INFO - Chipset Model: Intel Iris 01:59:20 INFO - Type: GPU 01:59:20 INFO - Bus: Built-In 01:59:20 INFO - VRAM (Dynamic, Max): 1536 MB 01:59:20 INFO - Vendor: Intel (0x8086) 01:59:20 INFO - Device ID: 0x0a2e 01:59:20 INFO - Revision ID: 0x0009 01:59:20 INFO - Displays: 01:59:20 INFO - Display: 01:59:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:59:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:59:20 INFO - Display Serial Number: 1600x1200 60 01:59:20 INFO - Main Display: Yes 01:59:20 INFO - Mirror: Off 01:59:20 INFO - Online: Yes 01:59:20 INFO - Rotation: Supported 01:59:20 INFO - Return code: 0 01:59:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:59:20 INFO - Python 2.7.3 01:59:20 INFO - Return code: 0 01:59:20 INFO - grabbing minidump binary from tooltool 01:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:20 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 0x10f3b4d30>, '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 0x10f2dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:59:20 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 01:59:20 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 01:59:20 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 01:59:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:59:20 INFO - Return code: 0 01:59:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:59:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:59:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:59:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:59:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:59:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--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 01:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0357 --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 01:59:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0oW5TIjpWi/Render', 01:59:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:59:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:59:20 INFO - 'HOME': '/Users/cltbld', 01:59:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:59:20 INFO - 'LOGNAME': 'cltbld', 01:59:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:59:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:20 INFO - 'MOZ_NO_REMOTE': '1', 01:59:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:59:20 INFO - 'NO_EM_RESTART': '1', 01:59:20 INFO - 'PAGER': '/bin/cat', 01:59:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:20 INFO - 'PWD': '/builds/slave/test', 01:59:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:59:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:59:20 INFO - 'SHELL': '/bin/bash', 01:59:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuEEJSmmbB/Listeners', 01:59:20 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 01:59:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:59:20 INFO - 'USER': 'cltbld', 01:59:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:59:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:20 INFO - 'XPC_FLAGS': '0x0', 01:59:20 INFO - 'XPC_SERVICE_NAME': '0', 01:59:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:59:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--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 01:59:20 INFO - mozversion application_buildid: 20170218004013 01:59:20 INFO - mozversion application_changeset: 104592a2b9be438203cfc489e60e0db851466ce5 01:59:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:59:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:59:20 INFO - mozversion application_name: Firefox 01:59:20 INFO - mozversion application_remotingname: firefox-dev 01:59:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:59:20 INFO - mozversion application_vendor: Mozilla 01:59:20 INFO - mozversion application_version: 53.0a2 01:59:20 INFO - mozversion platform_buildid: 20170218004013 01:59:20 INFO - mozversion platform_changeset: 104592a2b9be438203cfc489e60e0db851466ce5 01:59:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:59:20 INFO - mozversion platform_version: 53.0a2 01:59:20 INFO - using testdate: 1487411960 01:59:20 INFO - actual date: 1487411960 01:59:20 INFO - starting webserver on 'localhost:49240' 01:59:20 INFO - SUITE-START | Running 2 tests 01:59:20 INFO - TEST-START | dromaeo_css 01:59:20 INFO - operating with platform_type : mac_ 01:59:20 INFO - Initialising browser for dromaeo_css test... 01:59:20 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpYIyMTx/profile http://localhost:49240/getInfo.html) 01:59:23 INFO - PROCESS | 1661 | 2017-02-18 01:59:23.909 plugin-container[1665:8593] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9043, name = 'com.apple.tsm.portname' 01:59:23 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:59:23 INFO - PROCESS | 1661 | 2017-02-18 01:59:23.910 plugin-container[1665:8593] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d07, name = 'com.apple.CFPasteboardClient' 01:59:23 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:59:23 INFO - PROCESS | 1661 | 2017-02-18 01:59:23.910 plugin-container[1665:8593] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:59:23 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 01:59:23 INFO - PROCESS | 1661 | colorDepth:24 01:59:23 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 01:59:23 INFO - PROCESS | 1661 | __metrics 01:59:24 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 01:59:24 INFO - TEST-INFO | 1661: exit 0 01:59:24 INFO - Browser initialized. 01:59:24 INFO - Running cycle 1/1 for dromaeo_css test... 01:59:24 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpYIyMTx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:59:27 INFO - PROCESS | 1666 | 2017-02-18 01:59:27.201 plugin-container[1667:8718] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 01:59:27 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:59:27 INFO - PROCESS | 1666 | 2017-02-18 01:59:27.202 plugin-container[1667:8718] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d1b, name = 'com.apple.CFPasteboardClient' 01:59:27 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:59:27 INFO - PROCESS | 1666 | 2017-02-18 01:59:27.202 plugin-container[1667:8718] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:59:36 INFO - PROCESS | 1666 | RSS: Main: 219832320 01:59:36 INFO - PROCESS | 1666 | 02:02:40 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 02:02:42 INFO - PROCESS | 1666 | RSS: Main: 236785664 02:02:42 INFO - PROCESS | 1666 | 02:04:25 INFO - PROCESS | 1666 | ************************* 02:04:25 INFO - PROCESS | 1666 | A coding exception was thrown and uncaught in a Task. 02:04:25 INFO - PROCESS | 1666 | 02:04:25 ERROR - PROCESS | 1666 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:04:25 INFO - PROCESS | 1666 | Full stack: 02:04:25 INFO - PROCESS | 1666 | ************************* 02:05:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 02:05:45 INFO - PROCESS | 1666 | RSS: Main: 249888768 02:05:45 INFO - PROCESS | 1666 | 02:08:47 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 02:08:47 INFO - PROCESS | 1666 | RSS: Main: 256606208 02:08:47 INFO - PROCESS | 1666 | 02:11:49 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 02:11:50 INFO - PROCESS | 1666 | RSS: Main: 253255680 02:11:50 INFO - PROCESS | 1666 | 02:14:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 02:14:53 INFO - PROCESS | 1666 | RSS: Main: 257675264 02:14:53 INFO - PROCESS | 1666 | 02:17:56 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 02:17:56 INFO - PROCESS | 1666 | RSS: Main: 258596864 02:17:56 INFO - PROCESS | 1666 | 02:17:56 INFO - PROCESS | 1666 | __start_tp_report 02:17:56 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 02:17:56 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 02:17:56 INFO - PROCESS | 1666 | |i|pagename|runs| 02:17:56 INFO - PROCESS | 1666 | |0;dojo.html;2849.8575071246432;3181.85681644326;3360.411927912616;3367.2255381262325;3398.575178102737;5718.428157184285;5722.198892155102;5765.740541675625;5769.884602307951;5770.9422905770925;5755.39568345324;5784.942150578493;5827.533797296217;5846.356900740915;5886.999210134277;5250.212468129773;5271.604629652772;5286.365636123671;5288.92066619001;5316.229146773716;5310.396409872849;5325.813596524123;5334.493223143795;5345.973270133663;5353.116735738598;5198.740062996854;5207.973960130213;5313.840584782443;5318.893622127555;5331.706756128411;5275.446078161795;5297.920531192035;5307.442718514578;5310.097283461821;5315.415304316522;5164;5238.528532432061;5248.81629142982;5257.080010998098;5272.789088436458;5782.219400380979;5817.563682723812;5830.3586605473365;5843.5325173985975;5860.208871802337;4935.3090567320605;5533.529649979757;5856.472917437451;6224.097505861625;6273.87452250957;6274.0902569127675;6293.559450838443;6294.496440284812;6313.810585682437;6318.557700960934;5825.388334224887;5843.795467158629;5939.613925094898;5943.465088142088;5999.700014999233;6146.231721034871;6203.286622038433;6265.530085243625;6308.337624549448;6393.944999075101;6210;6218;6229.96885015572;6245.843853903689;6266.686665666698;6234.501239900797;6242.687865606701;6243.96878015607;6245.406686364788;6273.96863015682;6125.418085281891;6195.721192546256;6213;6262.2172228471445;6267.0286105653695;6175.166352542439;6284.717187726564;6319.905201421982;6329.556931014785;6348.936510634927;5006.299118123393;5006.4743201964;5014.448410674823;5035.84892453227;5039.748012599429;4299.78501074945;4379.211741886491;4421.889452763642;4436.334549817553;4470.687051906335;5891.9705401473575;5904.822855314262;5933.9406605934255;6012.188354572164;6040.6979651018155;6221.875562488815;6242.28213755424;6281;6291.056341548713;6300.133439285114;5044.243363495505;5329.600279979017;5701.230333904953;5873.530117590582;5884.823455296348;5419.105847535191;5469.863253418617;5508.421615730371;5518.089515229942;5566.359868615161;6414.511386854002;6434.388733070351;6441.484681225585;6455.2576453708425;6472.029195620695;6059.394060593905;6139.539534534839;6171.47542458896;6189.876202475835;6199.659018754011;5283;5358.383785864519;6277.937220627918;6423.03654451836;6425.389587989133;6134.099846298167;6177.7837775677635;6222.875542489034;6240.063990401476;6283;5197.324347834758;6292.2134733158355;6306.810795676137;6307.117003619589;6332.841678957879;5103.3110530077965;6210.596311239755;6215.782447614311;6238.376162383725;6248.906266406098;6046.244219472566;6115.266168059861;6119.319765820928;6154.630722156685;6177.444030037318;5075.264086707481;5974.61165024272;6013.188219590299;6076.058210977306;6091.969540152271;5164.896702066013;6075.756969721162;6081.483073938588;6181.1655426516845;6225;4539.409876716006;5066.82266120684;5656;5882.647041177372;5957.49361304294 02:17:56 INFO - PROCESS | 1666 | |1;ext.html;496.3274762696548;504.81826542444713;506.0688333466422;518.9584833213344;559.8208573256557;41137.382939255935;42877.78561107194;43052.354214686806;43246.78376608121;45069.774651126696;44255.89360265995;44585.55414445855;44670.55329446705;44787.328190077176;44869;7061.046758687563;8089.31240844526;8482.491050536957;9195.678151264707;9441.24470042395;11033;11340;11361.147913906449;11503.597374091909;11507.42462876857;11431.771364572704;11491.195616306863;11521;11522.96293333604;11553.306801591889;11374.545018199304;11439.771204575862;11460.942695286554;11461.598844040502;11465.598704045318;11376.772464550662;11421.885781142166;11473.541058357656;11481.425928703615;11485.253458525169;42117.57882421167;42313.57686423127;42380.788096059325;42510.78744606288;42550;3964.1873415949663;3982.5021872265966;4014.498187726534;4034.536028356747;4043.3732771420478;30682.69317306843;31063.37873242545;31323.84338078318;32481.67518324834;32602.347953041044;3228.176814912206;3272.6236482804543;3273.5253388258807;3403.6766507182024;3419.9487007694906;484576.57711711567;489579;495590;497689;498485;67178;67560.6621966887;67982.66008669925;68014.9797753034;68029.3197068023;61554.38445615576;70761;71420.28579714241;71449.64275178591;71699.64150179215;16646.001239925645;17228.569285767957;17263.827361726475;17279.222434990457;17303.30786768515;11709.590164344378;11942.940285298691;12041.09691773103;13141.737165256642;13155.947524198042;19099.427017189508;19102.61794764097;19152.329668461538;19178.424647260603;19267;6623.701933413008;6697;6724.226713927961;6754.966225168842;6761.797146085625;867.4083057589394;873.5413907698509;877.8200468903859;881.7266647339217;901.0403919825364;30350.57733966662;30641.846790765903;30701.846490767402;30781;30921.381572368875;1019.3374306700704;1059.4279089291697;1064.7604289034905;1074.8119079161115;1153.26191237608;15865.96871203368;15874.682506349809;16134.515964521082;16216;16217.51347459578;589259.0537047287;589687;590870;591520;593960;63506.729865402434;63596.68201658962;63661.72676546443;63720.36279637237;63921;1326.157889740022;1349.7042838874595;1457.2640816387657;1466.6186791434304;1467.5670677150054;29376.412471750016;30108.24729381783;30277;30575.388492230475;30641.846790765903;53974.73012634912;54471.45528544664;54520.45479545312;54550.727246363516;54554;381046;381891;382480.17519824445;383354;383712;20867.582648346644;25017;25741.35646608775;26219.21342359732;42687.93280168021;42329.15341693087;43052.06265718113;43241.567584323755;44574.77712611416;45260.54739452695;35951.7416890418;36340.636593633724;36560;36687.449688254164;37764.48942042288;35600;35989.82005089958;36172.81913590415;37125.628743712216;37340.813295933345;34966.12584685403;35425.645743542234;35786.82106589554;35997.28005439929;36026.8198659005;31413.90051348192;33115.50326745053;33372.66627333696;33599.16002099967;34118.31763364669;24245.393865153514;24501.142460013813;24648.876755616107;25027.499450010535;25044.99820007252 02:17:56 INFO - PROCESS | 1666 | |2;jquery.html;364.14062811764234;386.1254259103132;391.1590275514125;400.2455371624488;411.2043196414937;16439.342426302963;19888;20485.975701214917;21232.25687100952;21292.148314067417;21114.788852111473;21133.04901279442;21263.25578604749;21292.78707212931;21562.568748625057;5693.686847223401;5902.616329938562;5935.584509084366;5944.88110237795;5950.5834591578605;5070.442251352349;5629.380768115504;5758.222639943596;5776.884462310752;5872.17789509469;5747.482726554609;5749.8275051748515;5770.076787713967;5771.538276937835;5783.797567085153;5561.777528898819;5674.375818659944;5734.655920644754;5752.539796816244;5781.53747700183;5107.233914912756;5118.564921981636;5125.436202017775;5126.794928202905;5136.409312929024;26320.34199145037;26363;26761.866190669116;26822.73177268222;26929.32676683079;2444.5477586646525;2676.1971408577347;2680.7319268073234;2692.7576518113465;2729.1676038808155;7232.566046037255;7323.633818309063;9875.60497580103;10472.947635261851;10797.012573912842;1815.664102141108;1849.2880241107136;1856.758621379212;1869.0467861390653;1884.020309439084;124938.9999999991;126364.73635263622;131040;131842.02236966454;138488.30755846258;23555;23570.882145589163;23852.52294954091;24642.876785615957;25049.749502505107;12323;12847.357632118543;42968.57031429708;43619;43808;6692.0296556998965;7631.885521717179;8370.372222083368;8428.115047920002;8559.786005349915;8537.701180458655;8673;8673.436226645248;8867.290616750644;8879.156480134377;3393.983030084883;3708.0173753955223;3954.663853572421;4130.463039804867;4211.368294755811;1762.34793126544;2054.9178032878817;2082.2295750572384;2092.476880779805;2095.2038225474525;918.6279556779515;1013.7986486014097;1018.7265917602996;1035.7773078788098;1047.6804574604666;21260.893695531733;21606.351809445743;21607.45981350479;21950.341489755334;22122.33632991013;1051.8790339110947;1066.6373433032807;1076.448712283333;1085.918556108295;1088.1403691084113;10940.960608742156;11400.771984560262;11486.19596628228;11497.367644779617;11511.96392324678;647632.7618361878;773788;774540;781905;791882;133381;151763;153080.46919530886;155987.22006389895;156511;898.5776684958059;979.4319294808994;1003.4731765823001;1044.9216308776872;1052.7526031382772;19206.135723892738;19719.60560788805;19846.801531985075;20049.298274560322;20196;46700;52703.8918443258;58806;59997;61333.69333153305;84205.57897210475;86326;87668;88256.23487530342;88544;8268.669253229804;8289.544075075928;8346.666133354598;8452.577371131541;8510.404271700922;11400.714982125513;12759.48962041508;12818.935905320413;13096.738065238833;13183.40674669623;10865.619703310345;11321.490532926204;11368.886311137114;11501.769964600493;11570.074394048625;11048.502817373077;11131.053860421955;11207.719807004563;11255.943720281346;11656.592019279284;9578.952105239709;11376.37429941328;11430;11528.193026488401;11731.765364692828;7123.501354905107;7297.014902988029;7769.028871391076;8125.837483250184;8360;8441.677620972694;9808.509574521388;10483.737906552396;11253.15601329887;11332.830007549728 02:17:56 INFO - PROCESS | 1666 | |3;mootools.html;1446.1034158821533;1451.4411951398708;1457.5408746244932;1469.4416121873687;1479.4452080469828;7496.850062998737;7762.689492420311;8012;8469.364797640179;8474.1949514796;7008.439324854012;7915.970923779901;8053.073896501904;8353.997520297558;8449.155084491547;2330.487292795582;2375.0381095656285;2379.2505360811288;2382.380581048931;2390.2470721722602;2341.379534423379;2371.988140059297;2372.2171683344454;2387.617981123021;2392.928212153638;2314.3172764034566;2341.6838726771925;2358.457554762406;2365.6215005599106;2367.822413319008;1726.9222884970206;2247.6403775395856;2280.1107568048556;2320.3155069254612;2342.3792694935855;1905.4664693885734;2283.3378320287097;2364.7162340519076;2367.2779802160335;2368.9407764805846;8374.246317831363;8432.15678432158;8445.746627601182;8453.112423195538;8455.577221138918;5067.34124563808;5209.635325527214;5242.1088414969545;5254.605904557174;5263.105272103713;3251.3334766372836;3350;3489.3370259650587;3497.4928635347733;3499.212677147647;1193.570314686712;1195.7010747313172;1196.07304339137;1212.090931801149;1225.1179151011258;10778.676639700821;10816;10910.563577456893;10930.945345273301;10931.977584146958;4224.134052519226;4479.283314669638;4738.123447162286;4793.832215872428;4796.544328288807;9226.81546369069;9472.14750672429;9514.19129374011;9515.619375224913;9578.856317155249;5283.1546952487415;5285.577153827685;5296.311479507639;5299.6025298102795;5301.814436494704;4333.090051089243;4393.362962370438;4777.331173635694;4808.206645903457;4819.831305904277;3622.5471816022996;3692.667659910621;3729.4778730977687;3754.3805272129794;3764.962350376516;1110.2949626986922;1302.4529697527062;1318.9868101318864;1320.6698325418645;1324.0003797133104;912.8585069314267;920.1718453392001;920.7559996600907;924.7410724997012;947.4173383369179;5632.8028519002455;5862.794802181903;5883.676397798076;5908.734890171592;6100.542459315569;964.2093483343591;980.6518685866415;986.3292960786733;999.1656966432964;1018.6434747838346;3649.9635003650155;3673.963260367362;3710.8515659373325;3816.923661526754;3879.8942301443954;9824.852627210597;10106.191504679608;10141.492925353703;10159.593616255415;10175.592976281014;9821.312508124505;9939.304248702521;9970.750731231778;9991.500424978722;10064.14454771338;7851.725189618336;7928.6035698214855;7970.4819186752675;7987.440879138405;7989.760307190793;5361.973190134025;5441.619086663895;5492.642978206404;5593.916091258553;5664.008798460335;8976.28189744832;9276.16514513697;9338;9343;9360;8960.1935825776;9186.173244408035;9297.163255307054;9404.670836520689;9484.478353690612;6290.528210384148;6438.871222575429;6491.383318584727;6712.228093769279;6833.897491537531;7623.428242881695;7877.566733829694;7890.48711833729;7899.763007109796;7909.604519774103;5966.254218222723;6910.06714093611;7024;7057;7122.6438678066925;6886.965565172142;6922.58464492132;6923.757668481579;6967.756128535477;6989.37095661393;6248.4376406123665;6286.402791734778;6383.585066970632;6398.616083035033;6409.679516024274;4941.876453088702;4951.282064100757;4970.478099799614;4981.701097934136;5055.317532133115;4923.630727695366;4931.654784165074;4941.407031156285;5028.874278143076;5087.694738315713 02:17:56 INFO - PROCESS | 1666 | |4;prototype.html;357.167799028264;360.398135114359;366.2619821060565;371.8085186129144;375.88535496673524;5166.5866730661555;5182.404023537285;5508.39407665157;5580.330360356757;5603.515068506844;5316.441773613763;5338.359396872371;5451.3458384993755;5480.287562616864;5520.199571062193;3357.5131605917127;4253.7455148771205;4311.417958575584;4312.2453570625175;4316.223079845627;4085.8968078618905;4261.78691065447;4295.334223195409;4309.806058727349;4310;4196.790160491963;4205.474315710536;4211.7262377945335;4254.510731265897;4264.957350426487;3696.759710618828;3710.610385909468;4133.9793301033305;4255.957440425587;4260;3162.509810979302;3797.1014492753625;3804.9453295220546;3809.942850857239;3812.6377994090517;4384.342348647697;5151.819686310999;5221.71280579568;5279.788808447657;5303.920441193385;4193.211514342958;4543.228630535371;4880.829170979035;4926.556609905126;4931.6684495186455;5547.472990065978;5783.652980821164;5803.593748437611;5818.679972601505;5834.445727655866;3407.5125158634087;3884.7086468514976;4197.559256278108;4200.555544453549;4201.873943781691;6033.969830150865;6064.967516241879;6078.483328917047;6104.7876964894085;6127.540434467388;3575.76757510761;3771.5097037384962;4186.665066794649;4269.850555230552;4294.291441912112;3291.341731653631;3709.4992176056426;3999.5800440953863;4331.328644060176;4332.1985432695055;3885.941710874339;4125.927258912704;4745.623769106989;4958.975205123951;4991.450940396553;4633.652476064309;5361.391582525227;5623.606347555632;5871.532116970758;5885.764569417261;1171.8615591067532;1202.4228370382266;1304.8434187897512;1361.5642994241748;1388.2295326093913;880.564679572293;988.945607991553;1004.2969921055145;1011.231464087299;1014.5028935821394;4117.094239267356;4359.869203923888;4679.578837904537;5163.690178589297;5174.482551744795;4888.584470320063;5069.797208111634;5488.25908502355;5584.692841893653;5657.417491831629;4194.30793919006;4619.983603607201;4832.395950506187;5156.535911767959;5170.6380553360905;2340.566995105911;2785.7214278571983;2979.8063125896747;2990.8504574771173;3025;5922.703864806743;5932.911006334908;5952.672603006876;6004.789832355847;6007.30915944672;5690.2033715279895;5843.590948633555;5860.208871802337;5878.941210587925;5908.438698323653;5098.719570423662;5497.965752671537;5573.637713548606;5773.711314434346;5901.645901245853;4716.905661886812;4739.431268247832;5443.863903402288;5727.541796656341;5730.885382292247;4996.050750357421;5078.679543318837;5221.582273418041;5227.4124308466035;5624.74688639004;5240.528352448146;5305.946940530545;5372.474936779708;5541.947030064275;5897;3420.4527275636774;3439.294944536314;3682.963170368262;3740.6072362401555;3757.8308976095595;4384.947612573023;4910;5240.667902783225;5404.081306177881;5531.363893152339;4674.322223277673;4761.500042495627;5621;5654.830355089354;5706.144078388275;5001.4998500149695;5354.839354819362;5640.435956404491;5661.915071274017;5669.34802497718;4839.612830973584;4850.126977144007;5101.8724531887;5201.746236301438;5545.279113715191;4853;4870.805167793249;5162.793488260428;5481.945180548143;5566.610337276352;4378.846740364072;5018.7741551631;5427.7392247085845;5576.191452239484;5586.441355864381 02:17:56 INFO - PROCESS | 1666 | |5;yui.html;664.7341063574572;707.8159678483593;709.5600727548918;712.2379054411781;833.8082241084549;12573.811392829115;14625.26873656317;15345.462908798194;15377;15391.538253852388;13976.510822121229;14017.649558761035;14019.719605607881;14034.508792192275;14054.718905621881;671.5165081141595;697.2191145916555;827.8468483330573;862.348926560446;875.7591662292889;854.940154189207;870.5429649434035;874.204473928725;876.3646356391629;878.7846977490524;832.6960659359321;883.6215503814038;930.2279108340095;932.5197523275484;934.1732566678504;933.9019402962726;937.704623043739;937.9906200937971;938.2869019545127;941.0495399646372;689.1144878830678;695.8364784275691;696.9756058537978;699.1086364884761;699.2657709405155;14485.637859053502;14822.629434264121;14852.554423367315;15206.619834504116;15475.613109672237;11902.880971190263;13981.720365592733;14215.218163001031;14297.213653249068;14311.642208944755;11392.259503132353;11462.541498340057;11569.595064172714;11616.128790340757;12175.147739658227;3561.1809283864595;3707.29561383339;3708.1841994761107;3721.6836568891677;3730.347189241872;83003.7549436759;105945.94054059438;106315;106418;106988.465057675;10665.200109991782;10738.624148154933;10750.247482676137;10751.193660475496;11276.605318813803;22006.559868802535;22087.779122208893;22565;22592.774072259068;22631.88684056602;7204.17152027513;7293.452991025694;7302.123745150509;7346.6326683666675;7515.8496830063095;3480.5301284326797;3666.156783939709;3687.3362794697214;3848.5574158971517;3916.7258291919293;3446.483027545838;3516;3555.4311310190246;3559.893203203908;3569.1077230692326;626.1359324132668;638.4477427025682;642.9710663020176;643.5173619785161;660.6102399584269;682.8084991689534;686.6978529447127;698.9266127056687;721.8015045862325;726.2555880222708;7986.84026319482;9459.621615135455;9956.551955162035;10042.397456152654;10129.049670628461;700.6741865032682;702.9683664235122;708.3412426443457;712.6436781609195;727.2146082231178;4636.976815115903;4672.767057887435;4920.303548990353;4925.991241801519;4926.737930829514;105014;105769;106430.93569064364;107433.4628326869;108067;82928;91298.08701913028;92667;94575.58136627956;94654.52672736593;66459.99999999904;68187.97718034234;71822;83848;85385.14614853772;10766.461676915966;10855.457227138453;11032.44837758125;11057.281276716987;11183.720406989565;47132.7643361781;47382.52617473919;48928.75535622299;49026;51251.743741282546;63350.732985340954;68777;68961.65519172372;69230.30769692239;71281.64359178171;11154.386508741773;12727.554535591209;12734.61796146117;13241.735165296834;13315.733685326433;14251.073680210753;14350.712985740436;14396.784048239495;14852.925735371255;15175.392984280947;11540;11801.763964720829;12314.630561083182;12348.629541113422;12372.4432400544;11734.885185907326;12516.87483125157;13531;13889.305534723426;13957.316831290203;10899.618513351994;11463.828042579202;13125.868741312464;13172.407241673956;13180.736385272432;10496.422696751446;10722.571097156339;11059.889460910295;11194.160437967023;11624.94187529057;7932.4447288691545;9746.49126314512;10767.461626918779;10768.730781730519;10784.406857622593 02:17:56 INFO - PROCESS | 1666 | __end_tp_report 02:17:56 INFO - PROCESS | 1666 | __start_cc_report 02:17:56 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,392 02:17:56 INFO - PROCESS | 1666 | __end_cc_report 02:17:56 INFO - PROCESS | 1666 | __startTimestamp1487413076547__endTimestamp 02:17:56 INFO - PROCESS | 1666 | 02:17:56 INFO - PROCESS | 1666 | ------- Summary: start ------- 02:17:56 INFO - PROCESS | 1666 | Number of tests: 6 02:17:56 INFO - PROCESS | 1666 | 02:17:56 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5732.60 Median:5933.94 stddev:672.77 (11.3%) stddev-sans-first:635.69 02:17:56 INFO - PROCESS | 1666 | Values: 2849.9 3181.9 3360.4 3367.2 3398.6 5718.4 5722.2 5765.7 5769.9 5770.9 5755.4 5784.9 5827.5 5846.4 5887.0 5250.2 5271.6 5286.4 5288.9 5316.2 5310.4 5325.8 5334.5 5346.0 5353.1 5198.7 5208.0 5313.8 5318.9 5331.7 5275.4 5297.9 5307.4 5310.1 5315.4 5164.0 5238.5 5248.8 5257.1 5272.8 5782.2 5817.6 5830.4 5843.5 5860.2 4935.3 5533.5 5856.5 6224.1 6273.9 6274.1 6293.6 6294.5 6313.8 6318.6 5825.4 5843.8 5939.6 5943.5 5999.7 6146.2 6203.3 6265.5 6308.3 6393.9 6210.0 6218.0 6230.0 6245.8 6266.7 6234.5 6242.7 6244.0 6245.4 6274.0 6125.4 6195.7 6213.0 6262.2 6267.0 6175.2 6284.7 6319.9 6329.6 6348.9 5006.3 5006.5 5014.4 5035.8 5039.7 4299.8 4379.2 4421.9 4436.3 4470.7 5892.0 5904.8 5933.9 6012.2 6040.7 6221.9 6242.3 6281.0 6291.1 6300.1 5044.2 5329.6 5701.2 5873.5 5884.8 5419.1 5469.9 5508.4 5518.1 5566.4 6414.5 6434.4 6441.5 6455.3 6472.0 6059.4 6139.5 6171.5 6189.9 6199.7 5283.0 5358.4 6277.9 6423.0 6425.4 6134.1 6177.8 6222.9 6240.1 6283.0 5197.3 6292.2 6306.8 6307.1 6332.8 5103.3 6210.6 6215.8 6238.4 6248.9 6046.2 6115.3 6119.3 6154.6 6177.4 5075.3 5974.6 6013.2 6076.1 6092.0 5164.9 6075.8 6081.5 6181.2 6225.0 4539.4 5066.8 5656.0 5882.6 5957.5 02:17:56 INFO - PROCESS | 1666 | 02:17:56 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:64438.99 Median:36012.05 stddev:132078.26 (366.8%) stddev-sans-first:132361.52 02:17:56 INFO - PROCESS | 1666 | Values: 496.3 504.8 506.1 519.0 559.8 41137.4 42877.8 43052.4 43246.8 45069.8 44255.9 44585.6 44670.6 44787.3 44869.0 7061.0 8089.3 8482.5 9195.7 9441.2 11033.0 11340.0 11361.1 11503.6 11507.4 11431.8 11491.2 11521.0 11523.0 11553.3 11374.5 11439.8 11460.9 11461.6 11465.6 11376.8 11421.9 11473.5 11481.4 11485.3 42117.6 42313.6 42380.8 42510.8 42550.0 3964.2 3982.5 4014.5 4034.5 4043.4 30682.7 31063.4 31323.8 32481.7 32602.3 3228.2 3272.6 3273.5 3403.7 3419.9 484576.6 489579.0 495590.0 497689.0 498485.0 67178.0 67560.7 67982.7 68015.0 68029.3 61554.4 70761.0 71420.3 71449.6 71699.6 16646.0 17228.6 17263.8 17279.2 17303.3 11709.6 11942.9 12041.1 13141.7 13155.9 19099.4 19102.6 19152.3 19178.4 19267.0 6623.7 6697.0 6724.2 6755.0 6761.8 867.4 873.5 877.8 881.7 901.0 30350.6 30641.8 30701.8 30781.0 30921.4 1019.3 1059.4 1064.8 1074.8 1153.3 15866.0 15874.7 16134.5 16216.0 16217.5 589259.1 589687.0 590870.0 591520.0 593960.0 63506.7 63596.7 63661.7 63720.4 63921.0 1326.2 1349.7 1457.3 1466.6 1467.6 29376.4 30108.2 30277.0 30575.4 30641.8 53974.7 54471.5 54520.5 54550.7 54554.0 381046.0 381891.0 382480.2 383354.0 383712.0 20867.6 25017.0 25741.4 26219.2 42687.9 42329.2 43052.1 43241.6 44574.8 45260.5 35951.7 36340.6 36560.0 36687.4 37764.5 35600.0 35989.8 36172.8 37125.6 37340.8 34966.1 35425.6 35786.8 35997.3 36026.8 31413.9 33115.5 33372.7 33599.2 34118.3 24245.4 24501.1 24648.9 25027.5 25045.0 02:17:56 INFO - PROCESS | 1666 | 02:17:56 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:41498.51 Median:14519.60 stddev:125654.08 (865.4%) stddev-sans-first:125968.61 02:17:56 INFO - PROCESS | 1666 | Values: 364.1 386.1 391.2 400.2 411.2 16439.3 19888.0 20486.0 21232.3 21292.1 21114.8 21133.0 21263.3 21292.8 21562.6 5693.7 5902.6 5935.6 5944.9 5950.6 5070.4 5629.4 5758.2 5776.9 5872.2 5747.5 5749.8 5770.1 5771.5 5783.8 5561.8 5674.4 5734.7 5752.5 5781.5 5107.2 5118.6 5125.4 5126.8 5136.4 26320.3 26363.0 26761.9 26822.7 26929.3 2444.5 2676.2 2680.7 2692.8 2729.2 7232.6 7323.6 9875.6 10472.9 10797.0 1815.7 1849.3 1856.8 1869.0 1884.0 124939.0 126364.7 131040.0 131842.0 138488.3 23555.0 23570.9 23852.5 24642.9 25049.7 12323.0 12847.4 42968.6 43619.0 43808.0 6692.0 7631.9 8370.4 8428.1 8559.8 8537.7 8673.0 8673.4 8867.3 8879.2 3394.0 3708.0 3954.7 4130.5 4211.4 1762.3 2054.9 2082.2 2092.5 2095.2 918.6 1013.8 1018.7 1035.8 1047.7 21260.9 21606.4 21607.5 21950.3 22122.3 1051.9 1066.6 1076.4 1085.9 1088.1 10941.0 11400.8 11486.2 11497.4 11512.0 647632.8 773788.0 774540.0 781905.0 791882.0 133381.0 151763.0 153080.5 155987.2 156511.0 898.6 979.4 1003.5 1044.9 1052.8 19206.1 19719.6 19846.8 20049.3 20196.0 46700.0 52703.9 58806.0 59997.0 61333.7 84205.6 86326.0 87668.0 88256.2 88544.0 8268.7 8289.5 8346.7 8452.6 8510.4 11400.7 12759.5 12818.9 13096.7 13183.4 10865.6 11321.5 11368.9 11501.8 11570.1 11048.5 11131.1 11207.7 11255.9 11656.6 9579.0 11376.4 11430.0 11528.2 11731.8 7123.5 7297.0 7769.0 8125.8 8360.0 8441.7 9808.5 10483.7 11253.2 11332.8 02:17:56 INFO - PROCESS | 1666 | 02:17:56 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5420.05 Median:5273.13 stddev:2945.32 (55.9%) stddev-sans-first:2938.44 02:17:56 INFO - PROCESS | 1666 | Values: 1446.1 1451.4 1457.5 1469.4 1479.4 7496.9 7762.7 8012.0 8469.4 8474.2 7008.4 7916.0 8053.1 8354.0 8449.2 2330.5 2375.0 2379.3 2382.4 2390.2 2341.4 2372.0 2372.2 2387.6 2392.9 2314.3 2341.7 2358.5 2365.6 2367.8 1726.9 2247.6 2280.1 2320.3 2342.4 1905.5 2283.3 2364.7 2367.3 2368.9 8374.2 8432.2 8445.7 8453.1 8455.6 5067.3 5209.6 5242.1 5254.6 5263.1 3251.3 3350.0 3489.3 3497.5 3499.2 1193.6 1195.7 1196.1 1212.1 1225.1 10778.7 10816.0 10910.6 10930.9 10932.0 4224.1 4479.3 4738.1 4793.8 4796.5 9226.8 9472.1 9514.2 9515.6 9578.9 5283.2 5285.6 5296.3 5299.6 5301.8 4333.1 4393.4 4777.3 4808.2 4819.8 3622.5 3692.7 3729.5 3754.4 3765.0 1110.3 1302.5 1319.0 1320.7 1324.0 912.9 920.2 920.8 924.7 947.4 5632.8 5862.8 5883.7 5908.7 6100.5 964.2 980.7 986.3 999.2 1018.6 3650.0 3674.0 3710.9 3816.9 3879.9 9824.9 10106.2 10141.5 10159.6 10175.6 9821.3 9939.3 9970.8 9991.5 10064.1 7851.7 7928.6 7970.5 7987.4 7989.8 5362.0 5441.6 5492.6 5593.9 5664.0 8976.3 9276.2 9338.0 9343.0 9360.0 8960.2 9186.2 9297.2 9404.7 9484.5 6290.5 6438.9 6491.4 6712.2 6833.9 7623.4 7877.6 7890.5 7899.8 7909.6 5966.3 6910.1 7024.0 7057.0 7122.6 6887.0 6922.6 6923.8 6967.8 6989.4 6248.4 6286.4 6383.6 6398.6 6409.7 4941.9 4951.3 4970.5 4981.7 5055.3 4923.6 4931.7 4941.4 5028.9 5087.7 02:17:56 INFO - PROCESS | 1666 | 02:17:56 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4534.24 Median:4945.32 stddev:1364.75 (27.6%) stddev-sans-first:1332.08 02:17:56 INFO - PROCESS | 1666 | Values: 357.2 360.4 366.3 371.8 375.9 5166.6 5182.4 5508.4 5580.3 5603.5 5316.4 5338.4 5451.3 5480.3 5520.2 3357.5 4253.7 4311.4 4312.2 4316.2 4085.9 4261.8 4295.3 4309.8 4310.0 4196.8 4205.5 4211.7 4254.5 4265.0 3696.8 3710.6 4134.0 4256.0 4260.0 3162.5 3797.1 3804.9 3809.9 3812.6 4384.3 5151.8 5221.7 5279.8 5303.9 4193.2 4543.2 4880.8 4926.6 4931.7 5547.5 5783.7 5803.6 5818.7 5834.4 3407.5 3884.7 4197.6 4200.6 4201.9 6034.0 6065.0 6078.5 6104.8 6127.5 3575.8 3771.5 4186.7 4269.9 4294.3 3291.3 3709.5 3999.6 4331.3 4332.2 3885.9 4125.9 4745.6 4959.0 4991.5 4633.7 5361.4 5623.6 5871.5 5885.8 1171.9 1202.4 1304.8 1361.6 1388.2 880.6 988.9 1004.3 1011.2 1014.5 4117.1 4359.9 4679.6 5163.7 5174.5 4888.6 5069.8 5488.3 5584.7 5657.4 4194.3 4620.0 4832.4 5156.5 5170.6 2340.6 2785.7 2979.8 2990.9 3025.0 5922.7 5932.9 5952.7 6004.8 6007.3 5690.2 5843.6 5860.2 5878.9 5908.4 5098.7 5498.0 5573.6 5773.7 5901.6 4716.9 4739.4 5443.9 5727.5 5730.9 4996.1 5078.7 5221.6 5227.4 5624.7 5240.5 5305.9 5372.5 5541.9 5897.0 3420.5 3439.3 3683.0 3740.6 3757.8 4384.9 4910.0 5240.7 5404.1 5531.4 4674.3 4761.5 5621.0 5654.8 5706.1 5001.5 5354.8 5640.4 5661.9 5669.3 4839.6 4850.1 5101.9 5201.7 5545.3 4853.0 4870.8 5162.8 5481.9 5566.6 4378.8 5018.8 5427.7 5576.2 5586.4 02:17:56 INFO - PROCESS | 1666 | 02:17:56 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:20287.23 Median:3617.63 stddev:29455.26 (814.2%) stddev-sans-first:29501.04 02:17:56 INFO - PROCESS | 1666 | Values: 664.7 707.8 709.6 712.2 833.8 12573.8 14625.3 15345.5 15377.0 15391.5 13976.5 14017.6 14019.7 14034.5 14054.7 671.5 697.2 827.8 862.3 875.8 854.9 870.5 874.2 876.4 878.8 832.7 883.6 930.2 932.5 934.2 933.9 937.7 938.0 938.3 941.0 689.1 695.8 697.0 699.1 699.3 14485.6 14822.6 14852.6 15206.6 15475.6 11902.9 13981.7 14215.2 14297.2 14311.6 11392.3 11462.5 11569.6 11616.1 12175.1 3561.2 3707.3 3708.2 3721.7 3730.3 83003.8 105945.9 106315.0 106418.0 106988.5 10665.2 10738.6 10750.2 10751.2 11276.6 22006.6 22087.8 22565.0 22592.8 22631.9 7204.2 7293.5 7302.1 7346.6 7515.8 3480.5 3666.2 3687.3 3848.6 3916.7 3446.5 3516.0 3555.4 3559.9 3569.1 626.1 638.4 643.0 643.5 660.6 682.8 686.7 698.9 721.8 726.3 7986.8 9459.6 9956.6 10042.4 10129.0 700.7 703.0 708.3 712.6 727.2 4637.0 4672.8 4920.3 4926.0 4926.7 105014.0 105769.0 106430.9 107433.5 108067.0 82928.0 91298.1 92667.0 94575.6 94654.5 66460.0 68188.0 71822.0 83848.0 85385.1 10766.5 10855.5 11032.4 11057.3 11183.7 47132.8 47382.5 48928.8 49026.0 51251.7 63350.7 68777.0 68961.7 69230.3 71281.6 11154.4 12727.6 12734.6 13241.7 13315.7 14251.1 14350.7 14396.8 14852.9 15175.4 11540.0 11801.8 12314.6 12348.6 12372.4 11734.9 12516.9 13531.0 13889.3 13957.3 10899.6 11463.8 13125.9 13172.4 13180.7 10496.4 10722.6 11059.9 11194.2 11624.9 7932.4 9746.5 10767.5 10768.7 10784.4 02:17:56 INFO - PROCESS | 1666 | -------- Summary: end -------- 02:17:56 INFO - PROCESS | 1666 | 02:17:57 INFO - TEST-INFO | 1666: exit 0 02:17:57 INFO - TEST-OK | dromaeo_css | took 1116469ms 02:17:57 INFO - TEST-START | kraken 02:17:57 INFO - operating with platform_type : mac_ 02:17:57 INFO - Initialising browser for kraken test... 02:17:57 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpkRPMjs/profile http://localhost:49240/getInfo.html) 02:17:59 INFO - PROCESS | 1674 | 2017-02-18 02:17:59.985 plugin-container[1676:10686] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4f, name = 'com.apple.tsm.portname' 02:17:59 INFO - PROCESS | 1674 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:17:59 INFO - PROCESS | 1674 | 2017-02-18 02:17:59.985 plugin-container[1676:10686] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 02:17:59 INFO - PROCESS | 1674 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:17:59 INFO - PROCESS | 1674 | 2017-02-18 02:17:59.985 plugin-container[1676:10686] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:18:00 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 02:18:00 INFO - PROCESS | 1674 | colorDepth:24 02:18:00 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 02:18:00 INFO - PROCESS | 1674 | __metrics 02:18:00 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 02:18:00 INFO - TEST-INFO | 1674: exit 0 02:18:00 INFO - Browser initialized. 02:18:00 INFO - Running cycle 1/1 for kraken test... 02:18:00 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpkRPMjs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:18:03 INFO - PROCESS | 1677 | 2017-02-18 02:18:03.272 plugin-container[1678:10811] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d4f, name = 'com.apple.tsm.portname' 02:18:03 INFO - PROCESS | 1677 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:18:03 INFO - PROCESS | 1677 | 2017-02-18 02:18:03.274 plugin-container[1678:10811] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x440f, name = 'com.apple.CFPasteboardClient' 02:18:03 INFO - PROCESS | 1677 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:18:03 INFO - PROCESS | 1677 | 2017-02-18 02:18:03.274 plugin-container[1678:10811] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:18:12 INFO - PROCESS | 1677 | RSS: Main: 219746304 02:18:12 INFO - PROCESS | 1677 | 02:18:16 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 02:18:16 INFO - PROCESS | 1677 | RSS: Main: 234016768 02:18:16 INFO - PROCESS | 1677 | 02:18:19 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 02:18:20 INFO - PROCESS | 1677 | RSS: Main: 241623040 02:18:20 INFO - PROCESS | 1677 | 02:18:23 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 02:18:24 INFO - PROCESS | 1677 | RSS: Main: 245600256 02:18:24 INFO - PROCESS | 1677 | 02:18:26 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 02:18:26 INFO - PROCESS | 1677 | RSS: Main: 246865920 02:18:26 INFO - PROCESS | 1677 | 02:18:28 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:18:29 INFO - PROCESS | 1677 | RSS: Main: 247205888 02:18:29 INFO - PROCESS | 1677 | 02:18:32 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 02:18:33 INFO - PROCESS | 1677 | RSS: Main: 251076608 02:18:33 INFO - PROCESS | 1677 | 02:18:36 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 02:18:37 INFO - PROCESS | 1677 | RSS: Main: 250327040 02:18:37 INFO - PROCESS | 1677 | 02:18:39 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 02:18:40 INFO - PROCESS | 1677 | RSS: Main: 250392576 02:18:40 INFO - PROCESS | 1677 | 02:18:42 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:18:42 INFO - PROCESS | 1677 | RSS: Main: 249864192 02:18:42 INFO - PROCESS | 1677 | 02:18:44 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:18:45 INFO - PROCESS | 1677 | RSS: Main: 249802752 02:18:45 INFO - PROCESS | 1677 | 02:18:47 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:18:48 INFO - PROCESS | 1677 | RSS: Main: 249835520 02:18:48 INFO - PROCESS | 1677 | 02:18:51 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:18:52 INFO - PROCESS | 1677 | RSS: Main: 250208256 02:18:52 INFO - PROCESS | 1677 | 02:18:55 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:18:55 INFO - PROCESS | 1677 | RSS: Main: 250052608 02:18:55 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 02:18:57 INFO - PROCESS | 1677 | RSS: Main: 252067840 02:18:57 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | __start_tp_report 02:18:57 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 02:18:57 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 02:18:57 INFO - PROCESS | 1677 | |i|pagename|runs| 02:18:57 INFO - PROCESS | 1677 | |0;ai-astar;105;119;120;118;119;119;118;119;118;119 02:18:57 INFO - PROCESS | 1677 | |1;audio-beat-detection;146;116;115;147;113;121;143;94;165;143 02:18:57 INFO - PROCESS | 1677 | |2;audio-dft;200;196;195;203;200;198;194;256;279;194 02:18:57 INFO - PROCESS | 1677 | |3;audio-fft;83;60;64;112;82;86;68;61;73;61 02:18:57 INFO - PROCESS | 1677 | |4;audio-oscillator;81;70;84;71;74;84;80;58;87;109 02:18:57 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;87;87;89;87;135;130;90;125;106;73 02:18:57 INFO - PROCESS | 1677 | |6;imaging-darkroom;96;100;96;154;154;131;152;96;95;96 02:18:57 INFO - PROCESS | 1677 | |7;imaging-desaturate;93;110;147;90;92;93;91;95;93;95 02:18:57 INFO - PROCESS | 1677 | |8;json-parse-financial;60;69;73;97;97;96;81;64;63;62 02:18:57 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;68;78;72;80;71;70;70;71;69;98 02:18:57 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;85;86;85;77;90;104;104;107;85;83 02:18:57 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;160;139;154;153;144;146;151;163;263;171 02:18:57 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;170;170;169;167;166;212;170;169;170;162 02:18:57 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;68;66;67;65;81;89;86;81;66;68 02:18:57 INFO - PROCESS | 1677 | __end_tp_report 02:18:57 INFO - PROCESS | 1677 | __start_cc_report 02:18:57 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,984 02:18:57 INFO - PROCESS | 1677 | __end_cc_report 02:18:57 INFO - PROCESS | 1677 | __startTimestamp1487413137740__endTimestamp 02:18:57 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | ------- Summary: start ------- 02:18:57 INFO - PROCESS | 1677 | Number of tests: 14 02:18:57 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:117.40 Median:119.00 stddev:4.40 (3.7%) stddev-sans-first:0.67 02:18:57 INFO - PROCESS | 1677 | Values: 105.0 119.0 120.0 118.0 119.0 119.0 118.0 119.0 118.0 119.0 02:18:57 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:130.30 Median:144.50 stddev:21.59 (14.9%) stddev-sans-first:22.14 02:18:57 INFO - PROCESS | 1677 | Values: 146.0 116.0 115.0 147.0 113.0 121.0 143.0 94.0 165.0 143.0 02:18:57 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:211.50 Median:200.00 stddev:30.15 (15.1%) stddev-sans-first:31.69 02:18:57 INFO - PROCESS | 1677 | Values: 200.0 196.0 195.0 203.0 200.0 198.0 194.0 256.0 279.0 194.0 02:18:57 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:75.00 Median:70.50 stddev:16.31 (23.1%) stddev-sans-first:17.04 02:18:57 INFO - PROCESS | 1677 | Values: 83.0 60.0 64.0 112.0 82.0 86.0 68.0 61.0 73.0 61.0 02:18:57 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:80.50 stddev:13.43 (16.7%) stddev-sans-first:14.24 02:18:57 INFO - PROCESS | 1677 | Values: 81.0 70.0 84.0 71.0 74.0 84.0 80.0 58.0 87.0 109.0 02:18:57 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:100.90 Median:87.00 stddev:21.69 (24.9%) stddev-sans-first:22.42 02:18:57 INFO - PROCESS | 1677 | Values: 87.0 87.0 89.0 87.0 135.0 130.0 90.0 125.0 106.0 73.0 02:18:57 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:117.00 Median:95.50 stddev:27.28 (28.6%) stddev-sans-first:27.85 02:18:57 INFO - PROCESS | 1677 | Values: 96.0 100.0 96.0 154.0 154.0 131.0 152.0 96.0 95.0 96.0 02:18:57 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:99.90 Median:93.00 stddev:17.48 (18.8%) stddev-sans-first:18.36 02:18:57 INFO - PROCESS | 1677 | Values: 93.0 110.0 147.0 90.0 92.0 93.0 91.0 95.0 93.0 95.0 02:18:57 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:76.20 Median:77.00 stddev:15.38 (20.0%) stddev-sans-first:15.16 02:18:57 INFO - PROCESS | 1677 | Values: 60.0 69.0 73.0 97.0 97.0 96.0 81.0 64.0 63.0 62.0 02:18:57 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:74.70 Median:71.50 stddev:9.06 (12.7%) stddev-sans-first:9.28 02:18:57 INFO - PROCESS | 1677 | Values: 68.0 78.0 72.0 80.0 71.0 70.0 70.0 71.0 69.0 98.0 02:18:57 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:85.00 stddev:10.47 (12.3%) stddev-sans-first:10.91 02:18:57 INFO - PROCESS | 1677 | Values: 85.0 86.0 85.0 77.0 90.0 104.0 104.0 107.0 85.0 83.0 02:18:57 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:164.40 Median:157.00 stddev:35.91 (22.9%) stddev-sans-first:38.05 02:18:57 INFO - PROCESS | 1677 | Values: 160.0 139.0 154.0 153.0 144.0 146.0 151.0 163.0 263.0 171.0 02:18:57 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:170.00 stddev:14.11 (8.3%) stddev-sans-first:14.94 02:18:57 INFO - PROCESS | 1677 | Values: 170.0 170.0 169.0 167.0 166.0 212.0 170.0 169.0 170.0 162.0 02:18:57 INFO - PROCESS | 1677 | 02:18:57 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:74.50 stddev:9.41 (12.6%) stddev-sans-first:9.75 02:18:57 INFO - PROCESS | 1677 | Values: 68.0 66.0 67.0 65.0 81.0 89.0 86.0 81.0 66.0 68.0 02:18:57 INFO - PROCESS | 1677 | -------- Summary: end -------- 02:18:57 INFO - PROCESS | 1677 | 02:18:58 INFO - TEST-INFO | 1677: exit 0 02:18:58 INFO - TEST-OK | kraken | took 61422ms 02:18:58 INFO - SUITE-END | took 1177s 02:18:58 INFO - Completed test suite (00:19:38) 02:18:58 INFO - javascript benchmark 02:18:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7362.053402281997, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2849.8575071246432, 3181.85681644326, 3360.411927912616, 3367.2255381262325, 3398.575178102737, 5718.428157184285, 5722.198892155102, 5765.740541675625, 5769.884602307951, 5770.9422905770925, 5755.39568345324, 5784.942150578493, 5827.533797296217, 5846.356900740915, 5886.999210134277, 5250.212468129773, 5271.604629652772, 5286.365636123671, 5288.92066619001, 5316.229146773716, 5310.396409872849, 5325.813596524123, 5334.493223143795, 5345.973270133663, 5353.116735738598, 5198.740062996854, 5207.973960130213, 5313.840584782443, 5318.893622127555, 5331.706756128411, 5275.446078161795, 5297.920531192035, 5307.442718514578, 5310.097283461821, 5315.415304316522, 5164.0, 5238.528532432061, 5248.81629142982, 5257.080010998098, 5272.789088436458, 5782.219400380979, 5817.563682723812, 5830.3586605473365, 5843.5325173985975, 5860.208871802337, 4935.3090567320605, 5533.529649979757, 5856.472917437451, 6224.097505861625, 6273.87452250957, 6274.0902569127675, 6293.559450838443, 6294.496440284812, 6313.810585682437, 6318.557700960934, 5825.388334224887, 5843.795467158629, 5939.613925094898, 5943.465088142088, 5999.700014999233, 6146.231721034871, 6203.286622038433, 6265.530085243625, 6308.337624549448, 6393.944999075101, 6210.0, 6218.0, 6229.96885015572, 6245.843853903689, 6266.686665666698, 6234.501239900797, 6242.687865606701, 6243.96878015607, 6245.406686364788, 6273.96863015682, 6125.418085281891, 6195.721192546256, 6213.0, 6262.2172228471445, 6267.0286105653695, 6175.166352542439, 6284.717187726564, 6319.905201421982, 6329.556931014785, 6348.936510634927, 5006.299118123393, 5006.4743201964, 5014.448410674823, 5035.84892453227, 5039.748012599429, 4299.78501074945, 4379.211741886491, 4421.889452763642, 4436.334549817553, 4470.687051906335, 5891.9705401473575, 5904.822855314262, 5933.9406605934255, 6012.188354572164, 6040.6979651018155, 6221.875562488815, 6242.28213755424, 6281.0, 6291.056341548713, 6300.133439285114, 5044.243363495505, 5329.600279979017, 5701.230333904953, 5873.530117590582, 5884.823455296348, 5419.105847535191, 5469.863253418617, 5508.421615730371, 5518.089515229942, 5566.359868615161, 6414.511386854002, 6434.388733070351, 6441.484681225585, 6455.2576453708425, 6472.029195620695, 6059.394060593905, 6139.539534534839, 6171.47542458896, 6189.876202475835, 6199.659018754011, 5283.0, 5358.383785864519, 6277.937220627918, 6423.03654451836, 6425.389587989133, 6134.099846298167, 6177.7837775677635, 6222.875542489034, 6240.063990401476, 6283.0, 5197.324347834758, 6292.2134733158355, 6306.810795676137, 6307.117003619589, 6332.841678957879, 5103.3110530077965, 6210.596311239755, 6215.782447614311, 6238.376162383725, 6248.906266406098, 6046.244219472566, 6115.266168059861, 6119.319765820928, 6154.630722156685, 6177.444030037318, 5075.264086707481, 5974.61165024272, 6013.188219590299, 6076.058210977306, 6091.969540152271, 5164.896702066013, 6075.756969721162, 6081.483073938588, 6181.1655426516845, 6225.0, 4539.409876716006, 5066.82266120684, 5656.0, 5882.647041177372, 5957.49361304294], "value": 5690.130393390406, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.3274762696548, 504.81826542444713, 506.0688333466422, 518.9584833213344, 559.8208573256557, 41137.382939255935, 42877.78561107194, 43052.354214686806, 43246.78376608121, 45069.774651126696, 44255.89360265995, 44585.55414445855, 44670.55329446705, 44787.328190077176, 44869.0, 7061.046758687563, 8089.31240844526, 8482.491050536957, 9195.678151264707, 9441.24470042395, 11033.0, 11340.0, 11361.147913906449, 11503.597374091909, 11507.42462876857, 11431.771364572704, 11491.195616306863, 11521.0, 11522.96293333604, 11553.306801591889, 11374.545018199304, 11439.771204575862, 11460.942695286554, 11461.598844040502, 11465.598704045318, 11376.772464550662, 11421.885781142166, 11473.541058357656, 11481.425928703615, 11485.253458525169, 42117.57882421167, 42313.57686423127, 42380.788096059325, 42510.78744606288, 42550.0, 3964.1873415949663, 3982.5021872265966, 4014.498187726534, 4034.536028356747, 4043.3732771420478, 30682.69317306843, 31063.37873242545, 31323.84338078318, 32481.67518324834, 32602.347953041044, 3228.176814912206, 3272.6236482804543, 3273.5253388258807, 3403.6766507182024, 3419.9487007694906, 484576.57711711567, 489579.0, 495590.0, 497689.0, 498485.0, 67178.0, 67560.6621966887, 67982.66008669925, 68014.9797753034, 68029.3197068023, 61554.38445615576, 70761.0, 71420.28579714241, 71449.64275178591, 71699.64150179215, 16646.001239925645, 17228.569285767957, 17263.827361726475, 17279.222434990457, 17303.30786768515, 11709.590164344378, 11942.940285298691, 12041.09691773103, 13141.737165256642, 13155.947524198042, 19099.427017189508, 19102.61794764097, 19152.329668461538, 19178.424647260603, 19267.0, 6623.701933413008, 6697.0, 6724.226713927961, 6754.966225168842, 6761.797146085625, 867.4083057589394, 873.5413907698509, 877.8200468903859, 881.7266647339217, 901.0403919825364, 30350.57733966662, 30641.846790765903, 30701.846490767402, 30781.0, 30921.381572368875, 1019.3374306700704, 1059.4279089291697, 1064.7604289034905, 1074.8119079161115, 1153.26191237608, 15865.96871203368, 15874.682506349809, 16134.515964521082, 16216.0, 16217.51347459578, 589259.0537047287, 589687.0, 590870.0, 591520.0, 593960.0, 63506.729865402434, 63596.68201658962, 63661.72676546443, 63720.36279637237, 63921.0, 1326.157889740022, 1349.7042838874595, 1457.2640816387657, 1466.6186791434304, 1467.5670677150054, 29376.412471750016, 30108.24729381783, 30277.0, 30575.388492230475, 30641.846790765903, 53974.73012634912, 54471.45528544664, 54520.45479545312, 54550.727246363516, 54554.0, 381046.0, 381891.0, 382480.17519824445, 383354.0, 383712.0, 20867.582648346644, 25017.0, 25741.35646608775, 26219.21342359732, 42687.93280168021, 42329.15341693087, 43052.06265718113, 43241.567584323755, 44574.77712611416, 45260.54739452695, 35951.7416890418, 36340.636593633724, 36560.0, 36687.449688254164, 37764.48942042288, 35600.0, 35989.82005089958, 36172.81913590415, 37125.628743712216, 37340.813295933345, 34966.12584685403, 35425.645743542234, 35786.82106589554, 35997.28005439929, 36026.8198659005, 31413.90051348192, 33115.50326745053, 33372.66627333696, 33599.16002099967, 34118.31763364669, 24245.393865153514, 24501.142460013813, 24648.876755616107, 25027.499450010535, 25044.99820007252], "value": 20319.85166135958, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.14062811764234, 386.1254259103132, 391.1590275514125, 400.2455371624488, 411.2043196414937, 16439.342426302963, 19888.0, 20485.975701214917, 21232.25687100952, 21292.148314067417, 21114.788852111473, 21133.04901279442, 21263.25578604749, 21292.78707212931, 21562.568748625057, 5693.686847223401, 5902.616329938562, 5935.584509084366, 5944.88110237795, 5950.5834591578605, 5070.442251352349, 5629.380768115504, 5758.222639943596, 5776.884462310752, 5872.17789509469, 5747.482726554609, 5749.8275051748515, 5770.076787713967, 5771.538276937835, 5783.797567085153, 5561.777528898819, 5674.375818659944, 5734.655920644754, 5752.539796816244, 5781.53747700183, 5107.233914912756, 5118.564921981636, 5125.436202017775, 5126.794928202905, 5136.409312929024, 26320.34199145037, 26363.0, 26761.866190669116, 26822.73177268222, 26929.32676683079, 2444.5477586646525, 2676.1971408577347, 2680.7319268073234, 2692.7576518113465, 2729.1676038808155, 7232.566046037255, 7323.633818309063, 9875.60497580103, 10472.947635261851, 10797.012573912842, 1815.664102141108, 1849.2880241107136, 1856.758621379212, 1869.0467861390653, 1884.020309439084, 124938.9999999991, 126364.73635263622, 131040.0, 131842.02236966454, 138488.30755846258, 23555.0, 23570.882145589163, 23852.52294954091, 24642.876785615957, 25049.749502505107, 12323.0, 12847.357632118543, 42968.57031429708, 43619.0, 43808.0, 6692.0296556998965, 7631.885521717179, 8370.372222083368, 8428.115047920002, 8559.786005349915, 8537.701180458655, 8673.0, 8673.436226645248, 8867.290616750644, 8879.156480134377, 3393.983030084883, 3708.0173753955223, 3954.663853572421, 4130.463039804867, 4211.368294755811, 1762.34793126544, 2054.9178032878817, 2082.2295750572384, 2092.476880779805, 2095.2038225474525, 918.6279556779515, 1013.7986486014097, 1018.7265917602996, 1035.7773078788098, 1047.6804574604666, 21260.893695531733, 21606.351809445743, 21607.45981350479, 21950.341489755334, 22122.33632991013, 1051.8790339110947, 1066.6373433032807, 1076.448712283333, 1085.918556108295, 1088.1403691084113, 10940.960608742156, 11400.771984560262, 11486.19596628228, 11497.367644779617, 11511.96392324678, 647632.7618361878, 773788.0, 774540.0, 781905.0, 791882.0, 133381.0, 151763.0, 153080.46919530886, 155987.22006389895, 156511.0, 898.5776684958059, 979.4319294808994, 1003.4731765823001, 1044.9216308776872, 1052.7526031382772, 19206.135723892738, 19719.60560788805, 19846.801531985075, 20049.298274560322, 20196.0, 46700.0, 52703.8918443258, 58806.0, 59997.0, 61333.69333153305, 84205.57897210475, 86326.0, 87668.0, 88256.23487530342, 88544.0, 8268.669253229804, 8289.544075075928, 8346.666133354598, 8452.577371131541, 8510.404271700922, 11400.714982125513, 12759.48962041508, 12818.935905320413, 13096.738065238833, 13183.40674669623, 10865.619703310345, 11321.490532926204, 11368.886311137114, 11501.769964600493, 11570.074394048625, 11048.502817373077, 11131.053860421955, 11207.719807004563, 11255.943720281346, 11656.592019279284, 9578.952105239709, 11376.37429941328, 11430.0, 11528.193026488401, 11731.765364692828, 7123.501354905107, 7297.014902988029, 7769.028871391076, 8125.837483250184, 8360.0, 8441.677620972694, 9808.509574521388, 10483.737906552396, 11253.15601329887, 11332.830007549728], "value": 10198.68919776759, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.1034158821533, 1451.4411951398708, 1457.5408746244932, 1469.4416121873687, 1479.4452080469828, 7496.850062998737, 7762.689492420311, 8012.0, 8469.364797640179, 8474.1949514796, 7008.439324854012, 7915.970923779901, 8053.073896501904, 8353.997520297558, 8449.155084491547, 2330.487292795582, 2375.0381095656285, 2379.2505360811288, 2382.380581048931, 2390.2470721722602, 2341.379534423379, 2371.988140059297, 2372.2171683344454, 2387.617981123021, 2392.928212153638, 2314.3172764034566, 2341.6838726771925, 2358.457554762406, 2365.6215005599106, 2367.822413319008, 1726.9222884970206, 2247.6403775395856, 2280.1107568048556, 2320.3155069254612, 2342.3792694935855, 1905.4664693885734, 2283.3378320287097, 2364.7162340519076, 2367.2779802160335, 2368.9407764805846, 8374.246317831363, 8432.15678432158, 8445.746627601182, 8453.112423195538, 8455.577221138918, 5067.34124563808, 5209.635325527214, 5242.1088414969545, 5254.605904557174, 5263.105272103713, 3251.3334766372836, 3350.0, 3489.3370259650587, 3497.4928635347733, 3499.212677147647, 1193.570314686712, 1195.7010747313172, 1196.07304339137, 1212.090931801149, 1225.1179151011258, 10778.676639700821, 10816.0, 10910.563577456893, 10930.945345273301, 10931.977584146958, 4224.134052519226, 4479.283314669638, 4738.123447162286, 4793.832215872428, 4796.544328288807, 9226.81546369069, 9472.14750672429, 9514.19129374011, 9515.619375224913, 9578.856317155249, 5283.1546952487415, 5285.577153827685, 5296.311479507639, 5299.6025298102795, 5301.814436494704, 4333.090051089243, 4393.362962370438, 4777.331173635694, 4808.206645903457, 4819.831305904277, 3622.5471816022996, 3692.667659910621, 3729.4778730977687, 3754.3805272129794, 3764.962350376516, 1110.2949626986922, 1302.4529697527062, 1318.9868101318864, 1320.6698325418645, 1324.0003797133104, 912.8585069314267, 920.1718453392001, 920.7559996600907, 924.7410724997012, 947.4173383369179, 5632.8028519002455, 5862.794802181903, 5883.676397798076, 5908.734890171592, 6100.542459315569, 964.2093483343591, 980.6518685866415, 986.3292960786733, 999.1656966432964, 1018.6434747838346, 3649.9635003650155, 3673.963260367362, 3710.8515659373325, 3816.923661526754, 3879.8942301443954, 9824.852627210597, 10106.191504679608, 10141.492925353703, 10159.593616255415, 10175.592976281014, 9821.312508124505, 9939.304248702521, 9970.750731231778, 9991.500424978722, 10064.14454771338, 7851.725189618336, 7928.6035698214855, 7970.4819186752675, 7987.440879138405, 7989.760307190793, 5361.973190134025, 5441.619086663895, 5492.642978206404, 5593.916091258553, 5664.008798460335, 8976.28189744832, 9276.16514513697, 9338.0, 9343.0, 9360.0, 8960.1935825776, 9186.173244408035, 9297.163255307054, 9404.670836520689, 9484.478353690612, 6290.528210384148, 6438.871222575429, 6491.383318584727, 6712.228093769279, 6833.897491537531, 7623.428242881695, 7877.566733829694, 7890.48711833729, 7899.763007109796, 7909.604519774103, 5966.254218222723, 6910.06714093611, 7024.0, 7057.0, 7122.6438678066925, 6886.965565172142, 6922.58464492132, 6923.757668481579, 6967.756128535477, 6989.37095661393, 6248.4376406123665, 6286.402791734778, 6383.585066970632, 6398.616083035033, 6409.679516024274, 4941.876453088702, 4951.282064100757, 4970.478099799614, 4981.701097934136, 5055.317532133115, 4923.630727695366, 4931.654784165074, 4941.407031156285, 5028.874278143076, 5087.694738315713], "value": 4423.3102199004725, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.167799028264, 360.398135114359, 366.2619821060565, 371.8085186129144, 375.88535496673524, 5166.5866730661555, 5182.404023537285, 5508.39407665157, 5580.330360356757, 5603.515068506844, 5316.441773613763, 5338.359396872371, 5451.3458384993755, 5480.287562616864, 5520.199571062193, 3357.5131605917127, 4253.7455148771205, 4311.417958575584, 4312.2453570625175, 4316.223079845627, 4085.8968078618905, 4261.78691065447, 4295.334223195409, 4309.806058727349, 4310.0, 4196.790160491963, 4205.474315710536, 4211.7262377945335, 4254.510731265897, 4264.957350426487, 3696.759710618828, 3710.610385909468, 4133.9793301033305, 4255.957440425587, 4260.0, 3162.509810979302, 3797.1014492753625, 3804.9453295220546, 3809.942850857239, 3812.6377994090517, 4384.342348647697, 5151.819686310999, 5221.71280579568, 5279.788808447657, 5303.920441193385, 4193.211514342958, 4543.228630535371, 4880.829170979035, 4926.556609905126, 4931.6684495186455, 5547.472990065978, 5783.652980821164, 5803.593748437611, 5818.679972601505, 5834.445727655866, 3407.5125158634087, 3884.7086468514976, 4197.559256278108, 4200.555544453549, 4201.873943781691, 6033.969830150865, 6064.967516241879, 6078.483328917047, 6104.7876964894085, 6127.540434467388, 3575.76757510761, 3771.5097037384962, 4186.665066794649, 4269.850555230552, 4294.291441912112, 3291.341731653631, 3709.4992176056426, 3999.5800440953863, 4331.328644060176, 4332.1985432695055, 3885.941710874339, 4125.927258912704, 4745.623769106989, 4958.975205123951, 4991.450940396553, 4633.652476064309, 5361.391582525227, 5623.606347555632, 5871.532116970758, 5885.764569417261, 1171.8615591067532, 1202.4228370382266, 1304.8434187897512, 1361.5642994241748, 1388.2295326093913, 880.564679572293, 988.945607991553, 1004.2969921055145, 1011.231464087299, 1014.5028935821394, 4117.094239267356, 4359.869203923888, 4679.578837904537, 5163.690178589297, 5174.482551744795, 4888.584470320063, 5069.797208111634, 5488.25908502355, 5584.692841893653, 5657.417491831629, 4194.30793919006, 4619.983603607201, 4832.395950506187, 5156.535911767959, 5170.6380553360905, 2340.566995105911, 2785.7214278571983, 2979.8063125896747, 2990.8504574771173, 3025.0, 5922.703864806743, 5932.911006334908, 5952.672603006876, 6004.789832355847, 6007.30915944672, 5690.2033715279895, 5843.590948633555, 5860.208871802337, 5878.941210587925, 5908.438698323653, 5098.719570423662, 5497.965752671537, 5573.637713548606, 5773.711314434346, 5901.645901245853, 4716.905661886812, 4739.431268247832, 5443.863903402288, 5727.541796656341, 5730.885382292247, 4996.050750357421, 5078.679543318837, 5221.582273418041, 5227.4124308466035, 5624.74688639004, 5240.528352448146, 5305.946940530545, 5372.474936779708, 5541.947030064275, 5897.0, 3420.4527275636774, 3439.294944536314, 3682.963170368262, 3740.6072362401555, 3757.8308976095595, 4384.947612573023, 4910.0, 5240.667902783225, 5404.081306177881, 5531.363893152339, 4674.322223277673, 4761.500042495627, 5621.0, 5654.830355089354, 5706.144078388275, 5001.4998500149695, 5354.839354819362, 5640.435956404491, 5661.915071274017, 5669.34802497718, 4839.612830973584, 4850.126977144007, 5101.8724531887, 5201.746236301438, 5545.279113715191, 4853.0, 4870.805167793249, 5162.793488260428, 5481.945180548143, 5566.610337276352, 4378.846740364072, 5018.7741551631, 5427.7392247085845, 5576.191452239484, 5586.441355864381], "value": 4122.522028829839, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.7341063574572, 707.8159678483593, 709.5600727548918, 712.2379054411781, 833.8082241084549, 12573.811392829115, 14625.26873656317, 15345.462908798194, 15377.0, 15391.538253852388, 13976.510822121229, 14017.649558761035, 14019.719605607881, 14034.508792192275, 14054.718905621881, 671.5165081141595, 697.2191145916555, 827.8468483330573, 862.348926560446, 875.7591662292889, 854.940154189207, 870.5429649434035, 874.204473928725, 876.3646356391629, 878.7846977490524, 832.6960659359321, 883.6215503814038, 930.2279108340095, 932.5197523275484, 934.1732566678504, 933.9019402962726, 937.704623043739, 937.9906200937971, 938.2869019545127, 941.0495399646372, 689.1144878830678, 695.8364784275691, 696.9756058537978, 699.1086364884761, 699.2657709405155, 14485.637859053502, 14822.629434264121, 14852.554423367315, 15206.619834504116, 15475.613109672237, 11902.880971190263, 13981.720365592733, 14215.218163001031, 14297.213653249068, 14311.642208944755, 11392.259503132353, 11462.541498340057, 11569.595064172714, 11616.128790340757, 12175.147739658227, 3561.1809283864595, 3707.29561383339, 3708.1841994761107, 3721.6836568891677, 3730.347189241872, 83003.7549436759, 105945.94054059438, 106315.0, 106418.0, 106988.465057675, 10665.200109991782, 10738.624148154933, 10750.247482676137, 10751.193660475496, 11276.605318813803, 22006.559868802535, 22087.779122208893, 22565.0, 22592.774072259068, 22631.88684056602, 7204.17152027513, 7293.452991025694, 7302.123745150509, 7346.6326683666675, 7515.8496830063095, 3480.5301284326797, 3666.156783939709, 3687.3362794697214, 3848.5574158971517, 3916.7258291919293, 3446.483027545838, 3516.0, 3555.4311310190246, 3559.893203203908, 3569.1077230692326, 626.1359324132668, 638.4477427025682, 642.9710663020176, 643.5173619785161, 660.6102399584269, 682.8084991689534, 686.6978529447127, 698.9266127056687, 721.8015045862325, 726.2555880222708, 7986.84026319482, 9459.621615135455, 9956.551955162035, 10042.397456152654, 10129.049670628461, 700.6741865032682, 702.9683664235122, 708.3412426443457, 712.6436781609195, 727.2146082231178, 4636.976815115903, 4672.767057887435, 4920.303548990353, 4925.991241801519, 4926.737930829514, 105014.0, 105769.0, 106430.93569064364, 107433.4628326869, 108067.0, 82928.0, 91298.08701913028, 92667.0, 94575.58136627956, 94654.52672736593, 66459.99999999904, 68187.97718034234, 71822.0, 83848.0, 85385.14614853772, 10766.461676915966, 10855.457227138453, 11032.44837758125, 11057.281276716987, 11183.720406989565, 47132.7643361781, 47382.52617473919, 48928.75535622299, 49026.0, 51251.743741282546, 63350.732985340954, 68777.0, 68961.65519172372, 69230.30769692239, 71281.64359178171, 11154.386508741773, 12727.554535591209, 12734.61796146117, 13241.735165296834, 13315.733685326433, 14251.073680210753, 14350.712985740436, 14396.784048239495, 14852.925735371255, 15175.392984280947, 11540.0, 11801.763964720829, 12314.630561083182, 12348.629541113422, 12372.4432400544, 11734.885185907326, 12516.87483125157, 13531.0, 13889.305534723426, 13957.316831290203, 10899.618513351994, 11463.828042579202, 13125.868741312464, 13172.407241673956, 13180.736385272432, 10496.422696751446, 10722.571097156339, 11059.889460910295, 11194.160437967023, 11624.94187529057, 7932.4447288691545, 9746.49126314512, 10767.461626918779, 10768.730781730519, 10784.406857622593], "value": 7403.682339289937, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 119.0, 120.0, 118.0, 119.0, 119.0, 118.0, 119.0, 118.0, 119.0], "value": 117.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 115.0, 147.0, 113.0, 121.0, 143.0, 94.0, 165.0, 143.0], "value": 130.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 196.0, 195.0, 203.0, 200.0, 198.0, 194.0, 256.0, 279.0, 194.0], "value": 211.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 64.0, 112.0, 82.0, 86.0, 68.0, 61.0, 73.0, 61.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 70.0, 84.0, 71.0, 74.0, 84.0, 80.0, 58.0, 87.0, 109.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 89.0, 87.0, 135.0, 130.0, 90.0, 125.0, 106.0, 73.0], "value": 100.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 100.0, 96.0, 154.0, 154.0, 131.0, 152.0, 96.0, 95.0, 96.0], "value": 117.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 110.0, 147.0, 90.0, 92.0, 93.0, 91.0, 95.0, 93.0, 95.0], "value": 99.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 69.0, 73.0, 97.0, 97.0, 96.0, 81.0, 64.0, 63.0, 62.0], "value": 76.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 78.0, 72.0, 80.0, 71.0, 70.0, 70.0, 71.0, 69.0, 98.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 77.0, 90.0, 104.0, 104.0, 107.0, 85.0, 83.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 139.0, 154.0, 153.0, 144.0, 146.0, 151.0, 163.0, 263.0, 171.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 169.0, 167.0, 166.0, 212.0, 170.0, 169.0, 170.0, 162.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 65.0, 81.0, 89.0, 86.0, 81.0, 66.0, 68.0], "value": 73.7, "unit": "score"}]}]} 02:18:59 INFO - Return code: 0 02:18:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:18:59 ERROR - # TBPL SUCCESS # 02:18:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:18:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:18:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:18:59 INFO - 2017-02-18 02:18:59.089 screenresolution[1682:11202] starting screenresolution argv=screenresolution get 02:18:59 INFO - 2017-02-18 02:18:59.092 screenresolution[1682:11202] Display 0: 1600x1200x32@60 02:18:59 INFO - 2017-02-18 02:18:59.097 screenresolution[1683:11205] starting screenresolution argv=screenresolution list 02:18:59 INFO - Available Modes on Display 0 02:18:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:18:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:18:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:18:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:18:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:18:59 INFO - Intel Iris: 02:18:59 INFO - Chipset Model: Intel Iris 02:18:59 INFO - Type: GPU 02:18:59 INFO - Bus: Built-In 02:18:59 INFO - VRAM (Dynamic, Max): 1536 MB 02:18:59 INFO - Vendor: Intel (0x8086) 02:18:59 INFO - Device ID: 0x0a2e 02:18:59 INFO - Revision ID: 0x0009 02:18:59 INFO - Displays: 02:18:59 INFO - Display: 02:18:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:18:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:18:59 INFO - Display Serial Number: 1600x1200 60 02:18:59 INFO - Main Display: Yes 02:18:59 INFO - Mirror: Off 02:18:59 INFO - Online: Yes 02:18:59 INFO - Rotation: Supported 02:18:59 INFO - Return code: 0 02:18:59 INFO - Running post-action listener: _resource_record_post_action 02:18:59 INFO - [mozharness: 2017-02-18 10:18:59.330879Z] Finished run-tests step (success) 02:18:59 INFO - Running post-run listener: _resource_record_post_run 02:18:59 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 33992704; Write bytes: 512154624; Read time: 202; Write time: 1624 02:18:59 INFO - TinderboxPrint: CPU usage
54.4% 02:18:59 INFO - TinderboxPrint: I/O read bytes / time
33,992,704 / 202 02:18:59 INFO - TinderboxPrint: I/O write bytes / time
512,154,624 / 1,624 02:18:59 INFO - TinderboxPrint: CPU idle
2,187.5 (45.6%) 02:18:59 INFO - TinderboxPrint: CPU system
964.4 (20.1%) 02:18:59 INFO - TinderboxPrint: CPU user
1,641.9 (34.3%) 02:18:59 INFO - TinderboxPrint: Swap in / out
238,546,944 / 0 02:18:59 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207643136; Write bytes: 201983488; Read time: 15834; Write time: 445 02:18:59 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30429184; Write bytes: 300123648; Read time: 181; Write time: 1144 02:18:59 INFO - Running post-run listener: _upload_blobber_files 02:18:59 INFO - Blob upload gear active. 02:18:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:18:59 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 02:18:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:19:00 INFO - (blobuploader) - INFO - Open directory for files ... 02:19:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:19:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:19:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:19:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:19:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:19:01 INFO - (blobuploader) - INFO - Done attempting. 02:19:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:19:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:19:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:19:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:19:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:19:02 INFO - (blobuploader) - INFO - Done attempting. 02:19:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:19:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:19:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:19:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:19:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:19:03 INFO - (blobuploader) - INFO - Done attempting. 02:19:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:19:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:19:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:19:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:19:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:19:06 INFO - (blobuploader) - INFO - Done attempting. 02:19:06 INFO - (blobuploader) - INFO - Iteration through files over. 02:19:06 INFO - Return code: 0 02:19:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:19:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:19:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a2e448d8e6b1e7c06e61bf6699e0b11281aeafcbde2be9ea791280811b7175e2f66d7b356e1498b364bd5f3e97a9eabee3a2c8f0416bfa817aa9656ace8650b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f3a47c2a2ba5ebb4ebbb9504f38e39d0619e5dda4e9dd63367cb95dd5df9e5db7ecf46d2bcfb874b4b636b987127117f1c0b013a8e5d5ed3bb9487c03342822", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bb56d7eab2279561e3dcd4bd9a4f272ccd11dfef714e4d7e3906d5c1857da3f31277b90e4a6655b2f954207130e08fc8148916555e92156b11a07525bd5956d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f4f2c665b0cdc0a870a916c08899eaf8c3d256c814674f26ddcaeca5c769b97496b70eb8fc428178f3edf26c983dab1e7da350bd11f483f9c24eeb802cc3995"} 02:19:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:19:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:19:06 INFO - Contents: 02:19:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a2e448d8e6b1e7c06e61bf6699e0b11281aeafcbde2be9ea791280811b7175e2f66d7b356e1498b364bd5f3e97a9eabee3a2c8f0416bfa817aa9656ace8650b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f3a47c2a2ba5ebb4ebbb9504f38e39d0619e5dda4e9dd63367cb95dd5df9e5db7ecf46d2bcfb874b4b636b987127117f1c0b013a8e5d5ed3bb9487c03342822", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bb56d7eab2279561e3dcd4bd9a4f272ccd11dfef714e4d7e3906d5c1857da3f31277b90e4a6655b2f954207130e08fc8148916555e92156b11a07525bd5956d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f4f2c665b0cdc0a870a916c08899eaf8c3d256c814674f26ddcaeca5c769b97496b70eb8fc428178f3edf26c983dab1e7da350bd11f483f9c24eeb802cc3995"} 02:19:06 INFO - Running post-run listener: copy_logs_to_upload_dir 02:19:06 INFO - Copying logs to upload dir... 02:19:06 INFO - mkdir: /builds/slave/test/build/upload/logs 02:19:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.963262 ========= master_lag: 3.36 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-18 02:19:09.773251) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-18 02:19:09.780756) ========= 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.0oW5TIjpWi/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.yuEEJSmmbB/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a2e448d8e6b1e7c06e61bf6699e0b11281aeafcbde2be9ea791280811b7175e2f66d7b356e1498b364bd5f3e97a9eabee3a2c8f0416bfa817aa9656ace8650b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f3a47c2a2ba5ebb4ebbb9504f38e39d0619e5dda4e9dd63367cb95dd5df9e5db7ecf46d2bcfb874b4b636b987127117f1c0b013a8e5d5ed3bb9487c03342822", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bb56d7eab2279561e3dcd4bd9a4f272ccd11dfef714e4d7e3906d5c1857da3f31277b90e4a6655b2f954207130e08fc8148916555e92156b11a07525bd5956d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f4f2c665b0cdc0a870a916c08899eaf8c3d256c814674f26ddcaeca5c769b97496b70eb8fc428178f3edf26c983dab1e7da350bd11f483f9c24eeb802cc3995"} build_url:https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010826 build_url: 'https://queue.taskcluster.net/v1/task/KVrZEepVSuy_wFztkVlYAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a2e448d8e6b1e7c06e61bf6699e0b11281aeafcbde2be9ea791280811b7175e2f66d7b356e1498b364bd5f3e97a9eabee3a2c8f0416bfa817aa9656ace8650b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f3a47c2a2ba5ebb4ebbb9504f38e39d0619e5dda4e9dd63367cb95dd5df9e5db7ecf46d2bcfb874b4b636b987127117f1c0b013a8e5d5ed3bb9487c03342822", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bb56d7eab2279561e3dcd4bd9a4f272ccd11dfef714e4d7e3906d5c1857da3f31277b90e4a6655b2f954207130e08fc8148916555e92156b11a07525bd5956d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f4f2c665b0cdc0a870a916c08899eaf8c3d256c814674f26ddcaeca5c769b97496b70eb8fc428178f3edf26c983dab1e7da350bd11f483f9c24eeb802cc3995"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-18 02:19:09.820848) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-18 02:19:09.821213) ========= 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.0oW5TIjpWi/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.yuEEJSmmbB/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.005105 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-18 02:19:09.870241) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-18 02:19:09.872630) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-18 02:19:09.873011) ========= ========= Total master_lag: 3.51 =========