builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0008 starttime: 1487779309.18 results: success (0) buildid: 20170222060626 builduid: 3ea4a8090d684d30897865bd4f871dbe revision: e87493254cbe0c4e91e84ecb57f56d162c187c8c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 08:01:49.178591) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 08:01:49.179253) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 08:01:49.179812) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 08:01:49.209093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:01:49.209576) ========= 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.8z3elPPQfl/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.gGH4zlYLE6/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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-22 08:01:49-- 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% 11.6M=0.001s 2017-02-22 08:01:49 (11.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101910 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:01:49.336709) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:01:49.337230) ========= 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.8z3elPPQfl/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.gGH4zlYLE6/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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.029372 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:01:49.387086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-22 08:01:49.387484) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e87493254cbe0c4e91e84ecb57f56d162c187c8c --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 e87493254cbe0c4e91e84ecb57f56d162c187c8c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8z3elPPQfl/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.gGH4zlYLE6/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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-22 08:01:49,496 truncating revision to first 12 chars 2017-02-22 08:01:49,496 Setting DEBUG logging. 2017-02-22 08:01:49,496 attempt 1/10 2017-02-22 08:01:49,497 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e87493254cbe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-22 08:01:51,445 unpacking tar archive at: mozilla-aurora-e87493254cbe/testing/mozharness/ program finished with exit code 0 elapsedTime=2.217948 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-22 08:01:51.627667) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 08:01:51.628095) ========= script_repo_revision: e87493254cbe0c4e91e84ecb57f56d162c187c8c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 08:01:51.628635) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 08:01:51.628913) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 08:01:51.647281) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-22 08:01:51.647758) ========= /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.8z3elPPQfl/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.gGH4zlYLE6/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 08:01:51 INFO - MultiFileLogger online at 20170222 08:01:51 in /builds/slave/test 08:01:51 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 08:01:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:01:51 INFO - {'append_to_log': False, 08:01:51 INFO - 'base_work_dir': '/builds/slave/test', 08:01:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:01:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:01:51 INFO - 'branch': 'Mozilla-Aurora', 08:01:51 INFO - 'buildbot_json_path': 'buildprops.json', 08:01:51 INFO - 'config_files': ('talos/mac_config.py',), 08:01:51 INFO - 'default_actions': ('clobber', 08:01:51 INFO - 'read-buildbot-config', 08:01:51 INFO - 'download-and-extract', 08:01:51 INFO - 'populate-webroot', 08:01:51 INFO - 'create-virtualenv', 08:01:51 INFO - 'install', 08:01:51 INFO - 'run-tests'), 08:01:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:01:51 INFO - 'download_minidump_stackwalk': True, 08:01:51 INFO - 'download_symbols': 'ondemand', 08:01:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:01:51 INFO - 'tooltool.py': '/tools/tooltool.py', 08:01:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:01:51 INFO - '/tools/misc-python/virtualenv.py')}, 08:01:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:01:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:01:51 INFO - 'installer_path': 'installer.exe', 08:01:51 INFO - 'log_level': 'info', 08:01:51 INFO - 'log_name': 'talos', 08:01:51 INFO - 'log_to_console': True, 08:01:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:01:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:01:51 INFO - 'opt_config_files': (), 08:01:51 INFO - 'pip_index': False, 08:01:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:01:51 INFO - 'cmd': ('bash', 08:01:51 INFO - '-c', 08:01:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:01:51 INFO - 'enabled': True, 08:01:51 INFO - 'halt_on_failure': False, 08:01:51 INFO - 'name': 'check_screen_resolution'},), 08:01:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:01:51 INFO - 'cmd': ('bash', 08:01:51 INFO - '-c', 08:01:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:01:51 INFO - 'enabled': True, 08:01:51 INFO - 'halt_on_failure': False, 08:01:51 INFO - 'name': 'check_screen_resolution'},), 08:01:51 INFO - 'run_cmd_checks_enabled': True, 08:01:51 INFO - 'sps_profile': False, 08:01:51 INFO - 'sps_profile_interval': 0, 08:01:51 INFO - 'suite': 'dromaeojs-e10s', 08:01:51 INFO - 'system_bits': '32', 08:01:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:01:51 INFO - 'title': 't-yosemite-r7-0008', 08:01:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:01:51 INFO - 'use_talos_json': True, 08:01:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:01:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:01:51 INFO - 'work_dir': 'build'} 08:01:51 INFO - [mozharness: 2017-02-22 16:01:51.870475Z] Running clobber step. 08:01:51 INFO - Running pre-action listener: _resource_record_pre_action 08:01:51 INFO - Running main action method: clobber 08:01:51 INFO - rmtree: /builds/slave/test/build 08:01:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:01:54 INFO - Running post-action listener: _resource_record_post_action 08:01:54 INFO - [mozharness: 2017-02-22 16:01:54.412187Z] Finished clobber step (success) 08:01:54 INFO - [mozharness: 2017-02-22 16:01:54.412345Z] Running read-buildbot-config step. 08:01:54 INFO - Running pre-action listener: _resource_record_pre_action 08:01:54 INFO - Running main action method: read_buildbot_config 08:01:54 INFO - Using buildbot properties: 08:01:54 INFO - { 08:01:54 INFO - "project": "", 08:01:54 INFO - "product": "firefox", 08:01:54 INFO - "script_repo_revision": "production", 08:01:54 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:01:54 INFO - "repository": "", 08:01:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:01:54 INFO - "buildid": "20170222060626", 08:01:54 INFO - "pgo_build": "False", 08:01:54 INFO - "basedir": "/builds/slave/test", 08:01:54 INFO - "buildnumber": 1, 08:01:54 INFO - "slavename": "t-yosemite-r7-0008", 08:01:54 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 08:01:54 INFO - "platform": "yosemite_r7", 08:01:54 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:01:54 INFO - "branch": "mozilla-aurora", 08:01:54 INFO - "repo_path": "releases/mozilla-aurora", 08:01:54 INFO - "revision": "e87493254cbe0c4e91e84ecb57f56d162c187c8c", 08:01:54 INFO - "stage_platform": "macosx64", 08:01:54 INFO - "builduid": "3ea4a8090d684d30897865bd4f871dbe", 08:01:54 INFO - "slavebuilddir": "test" 08:01:54 INFO - } 08:01:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:01:54 INFO - Running post-action listener: _resource_record_post_action 08:01:54 INFO - [mozharness: 2017-02-22 16:01:54.415567Z] Finished read-buildbot-config step (success) 08:01:54 INFO - [mozharness: 2017-02-22 16:01:54.415686Z] Running download-and-extract step. 08:01:54 INFO - Running pre-action listener: _resource_record_pre_action 08:01:54 INFO - Running main action method: download_and_extract 08:01:54 INFO - mkdir: /builds/slave/test/build/tests 08:01:54 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')]} 08:01:54 INFO - trying https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:01:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/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 08:01:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/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 08:01:55 INFO - Downloaded 1199 bytes. 08:01:55 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:01:55 INFO - Using the following test package requirements: 08:01:55 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:01:55 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:01:55 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:01:55 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:01:55 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:01:55 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:01:55 INFO - u'jsshell-mac.zip'], 08:01:55 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:01:55 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:01:55 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:01:55 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:01:55 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:01:55 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:01:55 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:01:55 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:01:55 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:01:55 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:01:55 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:01:55 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:01:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:01:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:01:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:01:56 INFO - Expected file size: 16357466 08:01:56 INFO - Obtained file size: 16357466 08:02:03 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 08:02:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:02:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:02:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:02:04 INFO - Expected file size: 16357466 08:02:04 INFO - Obtained file size: 16357466 08:02:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:02:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:02:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:02:11 INFO - Expected file size: 14403485 08:02:11 INFO - Obtained file size: 14403485 08:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:12 INFO - trying https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:02:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:02:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/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 08:02:14 INFO - Downloaded 73913141 bytes. 08:02:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:02:14 INFO - mkdir: /builds/slave/test/properties 08:02:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:02:14 INFO - Writing to file /builds/slave/test/properties/build_url 08:02:14 INFO - Contents: 08:02:14 INFO - build_url:https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:02:15 INFO - Running post-action listener: _resource_record_post_action 08:02:15 INFO - Running post-action listener: set_extra_try_arguments 08:02:15 INFO - [mozharness: 2017-02-22 16:02:15.360074Z] Finished download-and-extract step (success) 08:02:15 INFO - [mozharness: 2017-02-22 16:02:15.360203Z] Running populate-webroot step. 08:02:15 INFO - Running pre-action listener: _resource_record_pre_action 08:02:15 INFO - Running main action method: populate_webroot 08:02:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:02:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:02:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:02:15 INFO - '--tppagecycles', 08:02:15 INFO - '7'], 08:02:15 INFO - 'tests': ['tsvgm']}}, 08:02:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:02:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:02:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:02:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:02:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:02:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:02:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:02:15 INFO - 'talos_options': ['--disable-e10s'], 08:02:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:02:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:02:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:02:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:02:15 INFO - 'talos_options': ['--disable-e10s'], 08:02:15 INFO - 'tests': ['damp', 'tps']}, 08:02:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:02:15 INFO - 'tests': ['damp', 'tps']}, 08:02:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:02:15 INFO - 'tests': ['dromaeo_dom']}, 08:02:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:02:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:02:15 INFO - 'tests': ['basic_compositor_video']}, 08:02:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:02:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:02:15 INFO - 'tests': ['a11yr', 08:02:15 INFO - 'ts_paint', 08:02:15 INFO - 'tpaint', 08:02:15 INFO - 'sessionrestore', 08:02:15 INFO - 'sessionrestore_no_auto_restore', 08:02:15 INFO - 'tabpaint']}, 08:02:15 INFO - 'other-e10s': {'tests': ['a11yr', 08:02:15 INFO - 'ts_paint', 08:02:15 INFO - 'tpaint', 08:02:15 INFO - 'sessionrestore', 08:02:15 INFO - 'sessionrestore_no_auto_restore', 08:02:15 INFO - 'tabpaint']}, 08:02:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:02:15 INFO - 'ts_paint', 08:02:15 INFO - 'tpaint', 08:02:15 INFO - 'sessionrestore', 08:02:15 INFO - 'sessionrestore_no_auto_restore', 08:02:15 INFO - 'tabpaint']}, 08:02:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:02:15 INFO - 'ts_paint', 08:02:15 INFO - 'tpaint', 08:02:15 INFO - 'sessionrestore', 08:02:15 INFO - 'sessionrestore_no_auto_restore', 08:02:15 INFO - 'tabpaint']}, 08:02:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:02:15 INFO - 'tests': ['a11yr', 08:02:15 INFO - 'ts_paint', 08:02:15 INFO - 'tpaint', 08:02:15 INFO - 'sessionrestore', 08:02:15 INFO - 'sessionrestore_no_auto_restore', 08:02:15 INFO - 'tabpaint']}, 08:02:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:02:15 INFO - 'tests': ['a11yr', 08:02:15 INFO - 'ts_paint', 08:02:15 INFO - 'tpaint', 08:02:15 INFO - 'sessionrestore', 08:02:15 INFO - 'sessionrestore_no_auto_restore', 08:02:15 INFO - 'tabpaint']}, 08:02:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:02:15 INFO - 'tests': ['tsvgx', 08:02:15 INFO - 'tsvgr_opacity', 08:02:15 INFO - 'tart', 08:02:15 INFO - 'tscrollx', 08:02:15 INFO - 'cart', 08:02:15 INFO - 'tsvg_static']}, 08:02:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:02:15 INFO - 'tsvgr_opacity', 08:02:15 INFO - 'tart', 08:02:15 INFO - 'tscrollx', 08:02:15 INFO - 'cart', 08:02:15 INFO - 'tsvg_static']}, 08:02:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:02:15 INFO - 'talos_options': ['--disable-e10s'], 08:02:15 INFO - 'tests': ['tp5o']}, 08:02:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:02:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:02:15 INFO - 'talos_options': ['--disable-e10s', 08:02:15 INFO - '--xperf_path', 08:02:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:02:15 INFO - 'tests': ['tp5n']}, 08:02:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:02:15 INFO - 'talos_options': ['--xperf_path', 08:02:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:02:15 INFO - 'tests': ['tp5n']}}, 08:02:15 INFO - 'talos.zip': {'path': '', 08:02:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:02:15 INFO - Running post-action listener: _resource_record_post_action 08:02:15 INFO - [mozharness: 2017-02-22 16:02:15.378601Z] Finished populate-webroot step (success) 08:02:15 INFO - [mozharness: 2017-02-22 16:02:15.378711Z] Running create-virtualenv step. 08:02:15 INFO - Running pre-action listener: _resource_record_pre_action 08:02:15 INFO - Running main action method: create_virtualenv 08:02:15 INFO - Creating virtualenv /builds/slave/test/build/venv 08:02:15 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 08:02:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:02:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:02:15 INFO - Using real prefix '/tools/python27' 08:02:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:02:16 INFO - Installing distribute.............................................................................................................................................................................................done. 08:02:19 INFO - Installing pip.................done. 08:02:19 INFO - Return code: 0 08:02:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:02:19 INFO - Reading from file tmpfile_stdout 08:02:19 INFO - Output received: 08:02:19 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) 08:02:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:19 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 0x107389b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa112cbe000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107167d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10715cbe8>, '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.8z3elPPQfl/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.gGH4zlYLE6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 08:02:19 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 08:02:19 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 08:02:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8z3elPPQfl/Render', 08:02:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:19 INFO - 'HOME': '/Users/cltbld', 08:02:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:19 INFO - 'LOGNAME': 'cltbld', 08:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:19 INFO - 'MOZ_NO_REMOTE': '1', 08:02:19 INFO - 'NO_EM_RESTART': '1', 08:02:19 INFO - 'PAGER': '/bin/cat', 08:02:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:19 INFO - 'PWD': '/builds/slave/test', 08:02:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:19 INFO - 'SHELL': '/bin/bash', 08:02:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gGH4zlYLE6/Listeners', 08:02:19 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 08:02:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:19 INFO - 'USER': 'cltbld', 08:02:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:19 INFO - 'XPC_FLAGS': '0x0', 08:02:19 INFO - 'XPC_SERVICE_NAME': '0', 08:02:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:19 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 08:02:19 INFO - Cleaning up... 08:02:19 INFO - Return code: 0 08:02:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:19 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 0x107389b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa112cbe000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107167d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10715cbe8>, '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.8z3elPPQfl/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.gGH4zlYLE6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 08:02:19 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 08:02:19 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 08:02:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8z3elPPQfl/Render', 08:02:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:19 INFO - 'HOME': '/Users/cltbld', 08:02:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:19 INFO - 'LOGNAME': 'cltbld', 08:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:19 INFO - 'MOZ_NO_REMOTE': '1', 08:02:19 INFO - 'NO_EM_RESTART': '1', 08:02:19 INFO - 'PAGER': '/bin/cat', 08:02:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:19 INFO - 'PWD': '/builds/slave/test', 08:02:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:19 INFO - 'SHELL': '/bin/bash', 08:02:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gGH4zlYLE6/Listeners', 08:02:19 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 08:02:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:19 INFO - 'USER': 'cltbld', 08:02:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:19 INFO - 'XPC_FLAGS': '0x0', 08:02:19 INFO - 'XPC_SERVICE_NAME': '0', 08:02:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:19 INFO - Downloading/unpacking psutil>=3.1.1 08:02:19 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 08:02:19 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 08:02:19 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 08:02:19 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 08:02:19 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 08:02:19 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 08:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:02:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:23 INFO - Installing collected packages: psutil 08:02:23 INFO - Running setup.py install for psutil 08:02:23 INFO - building 'psutil._psutil_osx' extension 08:02:23 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 08:02:24 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 08:02:24 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 08:02:24 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 08:02:24 INFO - building 'psutil._psutil_posix' extension 08:02:24 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 08:02:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:02:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:02:24 INFO - ^ 08:02:24 INFO - 1 warning generated. 08:02:24 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 08:02:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:24 INFO - Successfully installed psutil 08:02:24 INFO - Cleaning up... 08:02:24 INFO - Return code: 0 08:02:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:24 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 0x107389b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa112cbe000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107167d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10715cbe8>, '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.8z3elPPQfl/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.gGH4zlYLE6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 08:02:24 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 08:02:24 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 08:02:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8z3elPPQfl/Render', 08:02:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:24 INFO - 'HOME': '/Users/cltbld', 08:02:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:24 INFO - 'LOGNAME': 'cltbld', 08:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:24 INFO - 'MOZ_NO_REMOTE': '1', 08:02:24 INFO - 'NO_EM_RESTART': '1', 08:02:24 INFO - 'PAGER': '/bin/cat', 08:02:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:24 INFO - 'PWD': '/builds/slave/test', 08:02:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:24 INFO - 'SHELL': '/bin/bash', 08:02:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gGH4zlYLE6/Listeners', 08:02:24 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 08:02:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:24 INFO - 'USER': 'cltbld', 08:02:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:24 INFO - 'XPC_FLAGS': '0x0', 08:02:24 INFO - 'XPC_SERVICE_NAME': '0', 08:02:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:02:24 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 08:02:24 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 08:02:24 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 08:02:24 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 08:02:24 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 08:02:24 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 08:02:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:02:27 INFO - Installing collected packages: mozsystemmonitor 08:02:27 INFO - Running setup.py install for mozsystemmonitor 08:02:27 INFO - Successfully installed mozsystemmonitor 08:02:27 INFO - Cleaning up... 08:02:27 INFO - Return code: 0 08:02:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107389b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa112cbe000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107167d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10715cbe8>, '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.8z3elPPQfl/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.gGH4zlYLE6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 08:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:02:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8z3elPPQfl/Render', 08:02:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:27 INFO - 'HOME': '/Users/cltbld', 08:02:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:27 INFO - 'LOGNAME': 'cltbld', 08:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:27 INFO - 'MOZ_NO_REMOTE': '1', 08:02:27 INFO - 'NO_EM_RESTART': '1', 08:02:27 INFO - 'PAGER': '/bin/cat', 08:02:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:27 INFO - 'PWD': '/builds/slave/test', 08:02:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:27 INFO - 'SHELL': '/bin/bash', 08:02:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gGH4zlYLE6/Listeners', 08:02:27 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 08:02:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:27 INFO - 'USER': 'cltbld', 08:02:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:27 INFO - 'XPC_FLAGS': '0x0', 08:02:27 INFO - 'XPC_SERVICE_NAME': '0', 08:02:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:27 INFO - Downloading/unpacking jsonschema==2.5.1 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 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 08:02:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:02:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:30 INFO - Downloading functools32-3.2.3-2.tar.gz 08:02:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:02:31 INFO - warning: no files found matching '*.txt' 08:02:31 INFO - no previously-included directories found matching 'build' 08:02:31 INFO - no previously-included directories found matching 'dist' 08:02:31 INFO - no previously-included directories found matching '.git*' 08:02:31 INFO - Installing collected packages: jsonschema, functools32 08:02:31 INFO - Running setup.py install for functools32 08:02:31 INFO - warning: no files found matching '*.txt' 08:02:31 INFO - no previously-included directories found matching 'build' 08:02:31 INFO - no previously-included directories found matching 'dist' 08:02:31 INFO - no previously-included directories found matching '.git*' 08:02:31 INFO - Successfully installed jsonschema functools32 08:02:31 INFO - Cleaning up... 08:02:31 INFO - Return code: 0 08:02:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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', '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 0x107389b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa112cbe000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107167d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10715cbe8>, '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.8z3elPPQfl/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.gGH4zlYLE6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 08:02: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:02: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 functools32==3.2.3-2 08:02:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8z3elPPQfl/Render', 08:02:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:31 INFO - 'HOME': '/Users/cltbld', 08:02:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:31 INFO - 'LOGNAME': 'cltbld', 08:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:31 INFO - 'MOZ_NO_REMOTE': '1', 08:02:31 INFO - 'NO_EM_RESTART': '1', 08:02:31 INFO - 'PAGER': '/bin/cat', 08:02:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:31 INFO - 'PWD': '/builds/slave/test', 08:02:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:31 INFO - 'SHELL': '/bin/bash', 08:02:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gGH4zlYLE6/Listeners', 08:02:31 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 08:02:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:31 INFO - 'USER': 'cltbld', 08:02:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:31 INFO - 'XPC_FLAGS': '0x0', 08:02:31 INFO - 'XPC_SERVICE_NAME': '0', 08:02:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:02:31 INFO - Cleaning up... 08:02:31 INFO - Return code: 0 08:02:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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', '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 0x107389b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa112cbe000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107167d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10715cbe8>, '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.8z3elPPQfl/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.gGH4zlYLE6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 08:02: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:02: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 blobuploader==1.2.4 08:02:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8z3elPPQfl/Render', 08:02:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:31 INFO - 'HOME': '/Users/cltbld', 08:02:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:31 INFO - 'LOGNAME': 'cltbld', 08:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:31 INFO - 'MOZ_NO_REMOTE': '1', 08:02:31 INFO - 'NO_EM_RESTART': '1', 08:02:31 INFO - 'PAGER': '/bin/cat', 08:02:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:31 INFO - 'PWD': '/builds/slave/test', 08:02:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:31 INFO - 'SHELL': '/bin/bash', 08:02:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gGH4zlYLE6/Listeners', 08:02:31 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 08:02:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:31 INFO - 'USER': 'cltbld', 08:02:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:31 INFO - 'XPC_FLAGS': '0x0', 08:02:31 INFO - 'XPC_SERVICE_NAME': '0', 08:02:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:31 INFO - Downloading/unpacking blobuploader==1.2.4 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02:34 INFO - Downloading blobuploader-1.2.4.tar.gz 08:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:02:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:02:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:02:35 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 08:02:35 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 08:02:35 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 08:02:35 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 08:02:35 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 08:02:35 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 08:02:35 INFO - Downloading docopt-0.6.1.tar.gz 08:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:02:35 INFO - Installing collected packages: blobuploader, requests, docopt 08:02:35 INFO - Running setup.py install for blobuploader 08:02:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:02:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:02:36 INFO - Running setup.py install for requests 08:02:36 INFO - Running setup.py install for docopt 08:02:36 INFO - Successfully installed blobuploader requests docopt 08:02:36 INFO - Cleaning up... 08:02:36 INFO - Return code: 0 08:02:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:36 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')]} 08:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:36 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')]} 08:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:36 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 0x107389b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa112cbe000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107167d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10715cbe8>, '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.8z3elPPQfl/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.gGH4zlYLE6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 08:02:36 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 08:02:36 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 08:02:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8z3elPPQfl/Render', 08:02:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:36 INFO - 'HOME': '/Users/cltbld', 08:02:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:36 INFO - 'LOGNAME': 'cltbld', 08:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:36 INFO - 'MOZ_NO_REMOTE': '1', 08:02:36 INFO - 'NO_EM_RESTART': '1', 08:02:36 INFO - 'PAGER': '/bin/cat', 08:02:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:36 INFO - 'PWD': '/builds/slave/test', 08:02:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:36 INFO - 'SHELL': '/bin/bash', 08:02:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gGH4zlYLE6/Listeners', 08:02:36 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 08:02:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:36 INFO - 'USER': 'cltbld', 08:02:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:36 INFO - 'XPC_FLAGS': '0x0', 08:02:36 INFO - 'XPC_SERVICE_NAME': '0', 08:02:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-EMnLDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:37 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-VcRaX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:37 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-hiSrfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:37 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-AFBffk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:37 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-I_cFv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:37 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-qLVHIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:37 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-UCaOqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:37 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-C1wFKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:37 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-X_hLLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:37 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-DeET0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:38 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-CZdXwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:38 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-F2Qwdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:38 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-gYPTev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:38 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-fdP5wN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:38 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-EPp3XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:38 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-rBmD0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:38 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-EuH74s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:02:38 INFO - Running setup.py install for manifestparser 08:02:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:02:38 INFO - Running setup.py install for mozcrash 08:02:39 INFO - Running setup.py install for mozdebug 08:02:39 INFO - Running setup.py install for mozdevice 08:02:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Running setup.py install for mozfile 08:02:39 INFO - Running setup.py install for mozhttpd 08:02:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Running setup.py install for mozinfo 08:02:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Running setup.py install for mozInstall 08:02:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:02:39 INFO - Running setup.py install for mozleak 08:02:40 INFO - Running setup.py install for mozlog 08:02:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:02:40 INFO - Running setup.py install for moznetwork 08:02:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:02:40 INFO - Running setup.py install for mozprocess 08:02:40 INFO - Running setup.py install for mozprofile 08:02:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:02:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:02:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:02:40 INFO - Running setup.py install for mozrunner 08:02:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:02:40 INFO - Running setup.py install for mozscreenshot 08:02:41 INFO - Running setup.py install for moztest 08:02:41 INFO - Running setup.py install for mozversion 08:02:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:02:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:02:41 INFO - Cleaning up... 08:02:41 INFO - Return code: 0 08:02:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:41 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')]} 08:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:41 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')]} 08:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:42 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 0x107389b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa112cbe000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107167d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10715cbe8>, '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.8z3elPPQfl/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.gGH4zlYLE6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 08:02:42 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 08:02:42 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 08:02:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8z3elPPQfl/Render', 08:02:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:42 INFO - 'HOME': '/Users/cltbld', 08:02:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:42 INFO - 'LOGNAME': 'cltbld', 08:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:42 INFO - 'MOZ_NO_REMOTE': '1', 08:02:42 INFO - 'NO_EM_RESTART': '1', 08:02:42 INFO - 'PAGER': '/bin/cat', 08:02:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:42 INFO - 'PWD': '/builds/slave/test', 08:02:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:42 INFO - 'SHELL': '/bin/bash', 08:02:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gGH4zlYLE6/Listeners', 08:02:42 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 08:02:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:42 INFO - 'USER': 'cltbld', 08:02:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:42 INFO - 'XPC_FLAGS': '0x0', 08:02:42 INFO - 'XPC_SERVICE_NAME': '0', 08:02:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:42 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-5KdRAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:42 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)) 08:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:42 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-4i2GrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:42 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)) 08:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:42 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-_Gci0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:42 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)) 08:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:42 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-D_2TXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:42 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)) 08:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:42 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Is9pcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:42 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)) 08:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:42 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-bnkRME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:43 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)) 08:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-3_2P5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:43 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)) 08:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-GnExYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:43 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)) 08:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-OIk1bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:43 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)) 08:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-S2jUgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:43 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)) 08:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-72EEry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:43 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)) 08:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-aqpBx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:43 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)) 08:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-vlx_d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:43 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)) 08:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ZA9T8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:43 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)) 08:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-XeIlta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:43 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)) 08:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-UfyLVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:44 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)) 08:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-OhvNph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:44 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)) 08:02:44 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)) 08:02:44 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)) 08:02:44 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)) 08:02:44 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)) 08:02:44 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)) 08:02:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02:47 INFO - Downloading blessings-1.6.tar.gz 08:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:02:47 INFO - Installing collected packages: blessings 08:02:47 INFO - Running setup.py install for blessings 08:02:47 INFO - Successfully installed blessings 08:02:47 INFO - Cleaning up... 08:02:47 INFO - Return code: 0 08:02:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:02:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:47 INFO - Reading from file tmpfile_stdout 08:02:47 INFO - Current package versions: 08:02:47 INFO - blessings == 1.6 08:02:47 INFO - blobuploader == 1.2.4 08:02:47 INFO - docopt == 0.6.1 08:02:47 INFO - functools32 == 3.2.3-2 08:02:47 INFO - jsonschema == 2.5.1 08:02:47 INFO - manifestparser == 1.1 08:02:47 INFO - mozInstall == 1.12 08:02:47 INFO - mozcrash == 1.0 08:02:47 INFO - mozdebug == 0.1 08:02:47 INFO - mozdevice == 0.49 08:02:47 INFO - mozfile == 1.2 08:02:47 INFO - mozhttpd == 0.7 08:02:47 INFO - mozinfo == 0.9 08:02:47 INFO - mozleak == 0.1 08:02:47 INFO - mozlog == 3.4 08:02:47 INFO - moznetwork == 0.27 08:02:47 INFO - mozprocess == 0.24 08:02:47 INFO - mozprofile == 0.28 08:02:47 INFO - mozrunner == 6.13 08:02:47 INFO - mozscreenshot == 0.1 08:02:47 INFO - mozsystemmonitor == 0.3 08:02:47 INFO - moztest == 0.8 08:02:47 INFO - mozversion == 1.4 08:02:47 INFO - psutil == 3.1.1 08:02:47 INFO - requests == 1.2.3 08:02:47 INFO - wsgiref == 0.1.2 08:02:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107389b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa112cbe000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107167d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10715cbe8>, '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.8z3elPPQfl/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.gGH4zlYLE6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 08:02:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:02:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8z3elPPQfl/Render', 08:02:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:47 INFO - 'HOME': '/Users/cltbld', 08:02:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:47 INFO - 'LOGNAME': 'cltbld', 08:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:47 INFO - 'MOZ_NO_REMOTE': '1', 08:02:47 INFO - 'NO_EM_RESTART': '1', 08:02:47 INFO - 'PAGER': '/bin/cat', 08:02:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:47 INFO - 'PWD': '/builds/slave/test', 08:02:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:47 INFO - 'SHELL': '/bin/bash', 08:02:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gGH4zlYLE6/Listeners', 08:02:47 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 08:02:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:47 INFO - 'USER': 'cltbld', 08:02:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:47 INFO - 'XPC_FLAGS': '0x0', 08:02:47 INFO - 'XPC_SERVICE_NAME': '0', 08:02:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:02:48 INFO - Cleaning up... 08:02:48 INFO - Return code: 0 08:02:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107389b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa112cbe000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107167d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10715cbe8>, '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.8z3elPPQfl/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.gGH4zlYLE6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 08:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:02:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8z3elPPQfl/Render', 08:02:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:02:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:02:48 INFO - 'HOME': '/Users/cltbld', 08:02:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:02:48 INFO - 'LOGNAME': 'cltbld', 08:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:48 INFO - 'MOZ_NO_REMOTE': '1', 08:02:48 INFO - 'NO_EM_RESTART': '1', 08:02:48 INFO - 'PAGER': '/bin/cat', 08:02:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:48 INFO - 'PWD': '/builds/slave/test', 08:02:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:02:48 INFO - 'SHELL': '/bin/bash', 08:02:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gGH4zlYLE6/Listeners', 08:02:48 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 08:02:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:02:48 INFO - 'USER': 'cltbld', 08:02:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:02:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:48 INFO - 'XPC_FLAGS': '0x0', 08:02:48 INFO - 'XPC_SERVICE_NAME': '0', 08:02:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:02:48 INFO - Cleaning up... 08:02:48 INFO - Return code: 0 08:02:48 INFO - Running post-action listener: _resource_record_post_action 08:02:48 INFO - Running post-action listener: _start_resource_monitoring 08:02:48 INFO - Starting resource monitoring. 08:02:48 INFO - [mozharness: 2017-02-22 16:02:48.354279Z] Finished create-virtualenv step (success) 08:02:48 INFO - [mozharness: 2017-02-22 16:02:48.355272Z] Running install step. 08:02:48 INFO - Running pre-action listener: _resource_record_pre_action 08:02:48 INFO - Running main action method: install 08:02:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:48 INFO - Reading from file tmpfile_stdout 08:02:48 INFO - Detecting whether we're running mozinstall >=1.0... 08:02:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:02:48 INFO - Reading from file tmpfile_stdout 08:02:48 INFO - Output received: 08:02:48 INFO - Usage: mozinstall [options] installer 08:02:48 INFO - Options: 08:02:48 INFO - -h, --help show this help message and exit 08:02:48 INFO - -d DEST, --destination=DEST 08:02:48 INFO - Directory to install application into. [default: 08:02:48 INFO - "/builds/slave/test"] 08:02:48 INFO - --app=APP Application being installed. [default: firefox] 08:02:48 INFO - mkdir: /builds/slave/test/build/application 08:02:48 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'] 08:02:48 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 08:03:08 INFO - Reading from file tmpfile_stdout 08:03:08 INFO - Output received: 08:03:08 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:03:08 INFO - Running post-action listener: _resource_record_post_action 08:03:08 INFO - [mozharness: 2017-02-22 16:03:08.317257Z] Finished install step (success) 08:03:08 INFO - [mozharness: 2017-02-22 16:03:08.317419Z] Running run-tests step. 08:03:08 INFO - Running pre-action listener: _resource_record_pre_action 08:03:08 INFO - Running main action method: run_tests 08:03:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:03:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:03:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:03:08 INFO - 2017-02-22 08:03:08.331 screenresolution[1625:7308] starting screenresolution argv=screenresolution get 08:03:08 INFO - 2017-02-22 08:03:08.334 screenresolution[1625:7308] Display 0: 1600x1200x32@60 08:03:08 INFO - 2017-02-22 08:03:08.340 screenresolution[1626:7311] starting screenresolution argv=screenresolution list 08:03:08 INFO - Available Modes on Display 0 08:03:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:03:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:03:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:03:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:03:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:03:08 INFO - Intel Iris: 08:03:08 INFO - Chipset Model: Intel Iris 08:03:08 INFO - Type: GPU 08:03:08 INFO - Bus: Built-In 08:03:08 INFO - VRAM (Dynamic, Max): 1536 MB 08:03:08 INFO - Vendor: Intel (0x8086) 08:03:08 INFO - Device ID: 0x0a2e 08:03:08 INFO - Revision ID: 0x0009 08:03:08 INFO - Displays: 08:03:08 INFO - Display: 08:03:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:03:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:03:08 INFO - Display Serial Number: 1600x1200 60 08:03:08 INFO - Main Display: Yes 08:03:08 INFO - Mirror: Off 08:03:08 INFO - Online: Yes 08:03:08 INFO - Rotation: Supported 08:03:08 INFO - Return code: 0 08:03:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:03:08 INFO - Python 2.7.3 08:03:08 INFO - Return code: 0 08:03:08 INFO - grabbing minidump binary from tooltool 08:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107167d30>, '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 0x10708edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10715cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:03:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:03:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:03:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:03:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:03:08 INFO - Return code: 0 08:03:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:03:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:03:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:03:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:03:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:03:08 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/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--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 08:03:08 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/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0008 --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 08:03:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8z3elPPQfl/Render', 08:03:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:08 INFO - 'HOME': '/Users/cltbld', 08:03:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:08 INFO - 'LOGNAME': 'cltbld', 08:03:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:03:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:08 INFO - 'MOZ_NO_REMOTE': '1', 08:03:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:03:08 INFO - 'NO_EM_RESTART': '1', 08:03:08 INFO - 'PAGER': '/bin/cat', 08:03:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:08 INFO - 'PWD': '/builds/slave/test', 08:03:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:03:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:08 INFO - 'SHELL': '/bin/bash', 08:03:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gGH4zlYLE6/Listeners', 08:03:08 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 08:03:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:08 INFO - 'USER': 'cltbld', 08:03:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:08 INFO - 'XPC_FLAGS': '0x0', 08:03:08 INFO - 'XPC_SERVICE_NAME': '0', 08:03:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:08 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/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--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 08:03:08 INFO - mozversion application_buildid: 20170222060626 08:03:08 INFO - mozversion application_changeset: e87493254cbe0c4e91e84ecb57f56d162c187c8c 08:03:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:03:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:03:08 INFO - mozversion application_name: Firefox 08:03:08 INFO - mozversion application_remotingname: firefox-dev 08:03:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:03:08 INFO - mozversion application_vendor: Mozilla 08:03:08 INFO - mozversion application_version: 53.0a2 08:03:08 INFO - mozversion platform_buildid: 20170222060626 08:03:08 INFO - mozversion platform_changeset: e87493254cbe0c4e91e84ecb57f56d162c187c8c 08:03:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:03:08 INFO - mozversion platform_version: 53.0a2 08:03:08 INFO - using testdate: 1487779388 08:03:08 INFO - actual date: 1487779388 08:03:08 INFO - starting webserver on 'localhost:49241' 08:03:08 INFO - SUITE-START | Running 2 tests 08:03:08 INFO - TEST-START | dromaeo_css 08:03:08 INFO - operating with platform_type : mac_ 08:03:08 INFO - Initialising browser for dromaeo_css test... 08:03:08 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmp0fm9Te/profile http://localhost:49241/getInfo.html) 08:03:11 INFO - PROCESS | 1636 | 2017-02-22 08:03:11.658 plugin-container[1638:7490] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x494f, name = 'com.apple.tsm.portname' 08:03:11 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:03:11 INFO - PROCESS | 1636 | 2017-02-22 08:03:11.662 plugin-container[1638:7490] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 08:03:11 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:03:11 INFO - PROCESS | 1636 | 2017-02-22 08:03:11.662 plugin-container[1638:7490] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:03:11 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 08:03:11 INFO - PROCESS | 1636 | colorDepth:24 08:03:11 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 08:03:11 INFO - PROCESS | 1636 | __metrics 08:03:11 ERROR - PROCESS | 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 08:03:12 INFO - TEST-INFO | 1636: exit 0 08:03:12 INFO - Browser initialized. 08:03:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:03:12 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmp0fm9Te/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:03:15 INFO - PROCESS | 1639 | 2017-02-22 08:03:15.132 plugin-container[1640:7625] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 08:03:15 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:03:15 INFO - PROCESS | 1639 | 2017-02-22 08:03:15.132 plugin-container[1640:7625] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 08:03:15 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:03:15 INFO - PROCESS | 1639 | 2017-02-22 08:03:15.132 plugin-container[1640:7625] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:03:24 INFO - PROCESS | 1639 | RSS: Main: 219160576 08:03:24 INFO - PROCESS | 1639 | 08:06:27 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:06:29 INFO - PROCESS | 1639 | RSS: Main: 240898048 08:06:29 INFO - PROCESS | 1639 | 08:08:13 INFO - PROCESS | 1639 | ************************* 08:08:13 INFO - PROCESS | 1639 | A coding exception was thrown and uncaught in a Task. 08:08:13 INFO - PROCESS | 1639 | 08:08:13 ERROR - PROCESS | 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:08:13 INFO - PROCESS | 1639 | Full stack: 08:08:13 INFO - PROCESS | 1639 | ************************* 08:09:31 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 08:09:32 INFO - PROCESS | 1639 | RSS: Main: 246018048 08:09:32 INFO - PROCESS | 1639 | 08:12:34 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 08:12:34 INFO - PROCESS | 1639 | RSS: Main: 252354560 08:12:34 INFO - PROCESS | 1639 | 08:15:36 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 08:15:37 INFO - PROCESS | 1639 | RSS: Main: 248922112 08:15:37 INFO - PROCESS | 1639 | 08:18:40 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 08:18:40 INFO - PROCESS | 1639 | RSS: Main: 252788736 08:18:40 INFO - PROCESS | 1639 | 08:21:43 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 08:21:43 INFO - PROCESS | 1639 | RSS: Main: 255356928 08:21:43 INFO - PROCESS | 1639 | 08:21:43 INFO - PROCESS | 1639 | __start_tp_report 08:21:43 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 08:21:43 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 08:21:43 INFO - PROCESS | 1639 | |i|pagename|runs| 08:21:43 INFO - PROCESS | 1639 | |0;dojo.html;3369.275605744765;3372.9156771080734;3395.6943875051243;3398.1334759636297;3406.6763657452548;5467.91798123028;5725.742341594628;5787.623804452718;5845.327787304451;5865.266841644794;5289.550388217006;5832.475077243047;5833.8833223335505;5921.555883308758;5938.910916336258;5333.253344531759;5351.0903146465;5352.4915133062495;5352.625316227865;5408.0535906216455;5384.057789886774;5399.865003374908;5416.214648875911;5425.9186112208345;5451.672899626035;5190.870228244286;5201.635885488017;5388.649737767052;5402.108652072423;5405.324334458192;5253;5282.841514754564;5347.6256662033675;5364.785408583652;5403.297571315704;5220.216967454912;5311.2298716686255;5324.334458192726;5331.946680533222;5364.9731751341;4778.928316075262;5830.38780928005;5856.414358564152;5898.498627616657;5962.34414214436;5115.897682046339;6187.102870083812;6194.163787888622;6196.473299769525;6263;5582.274304340451;6185.134081228632;6330.936690633127;6370.458511026568;6378.330275321117;5957.434043765836;5987.64074155552;5996.850078747979;6001.159837622737;6041.969790151021;6170.290416602058;6242.687865606701;6282.371762823681;6315.431611155018;6328.019157030668;6092.786752463642;6122.134291015255;6139.032198454786;6162.26052873649;6190.535709821781;6224.968875155686;6312.210973628296;6316.115743795872;6316.368363163739;6318.6524741138755;6117.736059405486;6180.690965451709;6183.196184495987;6204.565680402328;6244.500439964792;6217.4715149212825;6218.689065546704;6224.346443623445;6238.844028899314;6253.53098517613;5024.522670346311;5024.79900803971;5026.572741316956;5033.949660503421;5050.722210278396;4383.473983122046;4392.934105988413;4411.18393097278;4428.202923473741;4478.305862591304;5781.884362312814;5849.064149736022;5893.44012318829;5942.078977758454;5949.077892926603;6274.027525733427;6304.148939893147;6310.211223597051;6324.08300796382;6336.04959256106;5718.313802343745;5751.568632352507;5820.796272130455;5847.502962248256;5855.268091488564;4773.212419950739;5520;5532.336119665666;5541.5843811714285;5551.500364967092;6447.000714889105;6479.7408103675325;6491.578047426997;6497.350264973654;6508.609483430914;6178;6181.505479561714;6187.752489900354;6194.81415557534;6346.048092786119;6497.18785151856;6509.609423434609;6519.4132528072705;6527.05357723137;6557;6255.593386429868;6258.780942666985;6265.561410701207;6266.216722909637;6270.623762574261;6163.96918015425;6184.628922264678;6235;6326.905096423466;6337.429631333202;5910.911336330045;6168.19813424252;6174.413430724074;6174.475169610633;6203.7828675996125;6030.547708921936;6165.3526379731275;6181.505479561534;6187.288461826767;6211.534134939807;5875.089361149029;5887.234659494238;5961.582689211714;6004.309504407049;6084.695765211633;6127.097902969212;6130.398136741914;6188.133661287513;6256.311805701278;6270.7491700331475;6122.448979591858;6124.785632502841;6131.019036954066;6132.325444201224;6148.231471066117 08:21:43 INFO - PROCESS | 1639 | |1;ext.html;441.7923575919317;446.81903828949277;491.84506880332714;529.4625954656022;535.9464053594639;37393.62606373936;40128.79935600322;40220.39669404961;40250.39624405636;40401.98995025122;32862.34275314492;40871.38692919609;41484;41513.37729934046;41518.37722434158;8329.583520823964;8588.484690918534;8943.642254309836;9223.446593204395;9223.953880230589;10911.181661375389;11192.832107518394;11216.766155722864;11364.431778411088;11389.601363952263;10021.34861234021;10907.90920907907;11305.773884522305;11348.716282092932;11357;11271.887281127165;11338.943305283503;11339.546418143264;11352.94323528377;11359.375234362107;11165.497552610152;11236.494357753922;11237.83143252852;11241.044511216556;11270.042046425982;39884.40173397402;40141.59858401408;40192.59807401947;40232.798836005924;40337;3857.9228415431535;3913.6288933330784;3940.7241493095494;3953.5058117735284;4014.2573623879675;27595.86202068997;28419.147425577266;28776.424471510454;28878.278043048882;29152.562711559345;3125.203073216338;3160.3205310858048;3244.0916543367657;3344.715699165574;3346.2136397946465;485434;486539;488986;490720;491502.99999999645;48107.518924810305;57207;57453.71273143608;57976.71011644999;58008;60172.69913650404;60654.39345606576;60739;60740.69629651912;60808.08787868186;15228.847711522965;15812.209389530477;15812.762808557882;15827.68344633101;15849.128297943493;11005.669829905115;11293.096552275963;12009;12124.818127728091;12381.504739810307;17944.564434845182;18105.823121497062;18119.45641630753;18175.272989080553;18198.909005454887;6522.739090436425;6888.517803753789;7742.7677169683875;7772.261635144652;7787.3770098392;839.1692224697506;842.3766412854444;863.2015385768265;867.7657032601162;883.5847151838625;29503.409931801245;29979;29996.400071998873;30031.099067027586;30808.845955770077;927.826299730841;985.7338518599938;1010.4796030044533;1097.4238524774557;1181.4092953523239;14720.484783032756;15643.530694078969;15686.843131568767;16099.356025759073;16330.836691633169;628539;629869.850650753;633155;635714;649286;61546.69226653838;62229;62229.06656400158;62248;62256.68871655613;1413.6465883529117;1427.6859090999963;1445.284584130841;1446.5732608880405;1449.8260208775225;29161.85419072976;29736.405271894873;29906.8504657484;30262.54606180953;30283.848580756956;50999.23501147411;51544.96910061853;51557.48442515527;51747;51934.22098668447;488146;489024;489134;490473.5476322738;491480;35322.76370327026;35958.46062309015;38686.8393948182;39507.81476555708;43359.9160021002;41947.53183638558;41967.370489443296;42111;43357;43415.78292108519;35023.824880875436;35418;35740;36537.451938220416;36980.89057328284;35470.11324716903;35474.82262588671;36291.637083628826;36356.45465318075;36623.633763663085;34944.82527587346;35038.47442288419;35305.29389412146;35420;35734.64265357417;30486;31593.21016974502;32048;32087.358252835278;32126.83936580302;23793;23955.880220598785;23981;24316.27051188467;24322.878385607957 08:21:43 INFO - PROCESS | 1639 | |2;jquery.html;390.75773020727155;394.44580364587756;397.7692938095903;400.1876191331598;426.3902619254467;16075.276612552434;19749.901250493745;19823.801761982377;21322.89338553307;21399.67900481492;20931.686024709605;21004.57990840182;21629.134834606597;22159.00284487198;22402.43993900149;5708.857278568027;5896.734646940877;5905.557083218776;5950.642961422307;6011.188489553898;4913.9189378336705;5264.499872512105;5465.906818636268;5788.363280039192;5847.678377689225;4620.353150558924;5714.914276285859;5802.622829516089;5810.651360918338;5836.6789826559525;5408.4591540845995;5636.971815140898;5802.12968054791;5808.854778630526;5821.214136091637;4780.665353425262;5634.830955071355;5679.630823996427;5691.231683722686;5693.715314234313;13493.392797324144;13512.662183445394;13608.523701670394;13704.24626645534;21349.82575958322;2539.746025397464;2567.7047139579;2596.7143614202423;2656.774174195196;2710.945781084387;9943.801123977551;9991.200703943667;10101.393916365041;10395.94802025985;10454.738631534197;1768.018749593975;1833.1567478959694;1847.898365589892;1849.9445016649522;1869.5699989002605;101528;111011.44494277558;113787;121784;122743;11541.711457213469;11804.645860624196;11818.822717659243;11831.408429578487;11840;13416.463341466231;14043.71912561743;15724.528264152093;15743.291551879964;15795.289211985488;8031.598420078973;8633;8790.472571645721;8795.604197811113;9007.819843603222;8591.65633374658;8668.263197628272;8671.869921951176;8795.912040879637;8818.911810881937;4760.262159365304;4846.80612775492;4861.368022157168;4865.343178670905;4909.533594308607;2023.099720624308;2058.8147066764063;2065.8450616203845;2068.979310206879;2071.306112452345;398.69300638508184;417.3781066211323;427.9507856596469;840.9075001749802;881.9382643214914;11942.164048516694;12036.398180091135;12045.457954392074;12066.939665301792;12279.2018518796;454.3253268895687;456.9885752856139;459.6690382924289;463.89098561837943;470.4284294582031;6095.939040609537;6135.723892424851;6149.84625384369;6274.090256912813;6279.497640188774;738578;747392;753121;762401;773083;124398;156034.21982890012;157953;158135;164562.1771891157;441.5562359828352;450.63723702419867;966.6133546581283;1036.6319956415514;1043.0091413157531;15141.924290378478;18420.447386578424;18551.2579496824;19726;19727;55072;55635;56522;57072;57961.4203857956;86626;87044.5647771757;88186;89066;90295;7609.923900760921;8045.235702608243;8180.550069746221;8522.957385213034;8543.188397102265;9132.634694612141;11855.34795586251;12402.25586464815;12899.355032248537;12903.741925161632;10689.091427228772;10757.9462102689;10906.237348114888;11037.724056898642;11137.71676806269;10855.131589472665;10898.50956706966;11031.83452248201;11165.050970667584;11284.492197851281;10929.289596176222;11253.1560132992;11264.0425563828;11296.152788541056;11465.656030319104;8200.343972482306;8252.793680158044;8388.245057944814;8483.703070392507;8566;8097.987751531058;8919.598618062073;10888.45557722095;11229.494672739584;11284.830727539258 08:21:43 INFO - PROCESS | 1639 | |3;mootools.html;1382.2881216173673;1425.4013314407948;1431.5848403962846;1434.6054834920396;1445.2123592642008;6469.70886310116;7579.734709285162;8079.838403231932;8537.573121343932;8557.358198135142;6895.896561551568;8068.878966815502;8312.584370781451;8405.831883362329;8445.873311900326;2320.3155069254526;2349.7415284318795;2351.5532048910736;2356.823238257129;2369.277370402027;2099.2442720620566;2186.147402513021;2324.721033475985;2373.6558199061124;2373.821963352747;2255.086689890597;2331.6619090231907;2341.894614742332;2343.1798870395396;2345.3550273674705;2311.1217737259817;2323.8373313868037;2329.1964272325936;2338.7310459297228;2345.0971376020184;2312.8496647717843;2360.9527809443716;2365.219477572397;2389.677393551883;2391.186996421225;8401.705940292122;8429.32565394767;8450.408471407003;8474.576271186477;8481.533515656636;5069.239614057884;5186.7147306898105;5214.921776173361;5217.530422262014;5238.73806309683;3325.1354647791504;3542.1852973815908;3555.377808883461;3573.5175751273505;3627.274545090966;1178.8762179971152;1213.332667033137;1256.114439320277;1260.823484712141;1270.1553466944472;10886.61896833607;10918.836217456745;10939.28894621847;10941.343519388782;10942.17933654971;4623.144718227139;4691.7184968901975;4714.81140754366;4779.4264688236935;4784.091022705675;9565.330426870192;9618.134367906921;9623.230141588656;9629.229661627192;9641.566129524048;5210.505002024802;5310.097283461821;5334.973325133349;5349.732513374316;5352.812651557177;4544.500104988449;4826.938073623867;4837.129316722953;4878.219484882402;4887.486813884562;3890.922181556353;3903.633728195166;3970.980145099256;4027.718059735849;4053.5541090480024;1117.5641499815079;1191.1602320364123;1236.8453943257093;1264.8102784582386;1319.162331919219;859.909709480508;880.6565439478609;881.9162179592928;895.4806212396794;895.6654584668927;5510.283663123849;5521.950829342412;5671.404502527175;5677.545796336366;5760.135979603093;959.822432849911;972.8589354543551;979.3536266064364;995.5320999130397;1002.6190047781796;3384.5430866833153;3597.0827439002887;3617.5116359291687;3730.160713839419;3799.3351163546267;9725.56234969428;10074.546645400975;10076.244281678903;10079.294449388472;10100.797984040279;8051.63767630458;9405.90594094064;9952.00479951999;9954.104130628279;10016;7621.237876212445;7846.176151504124;7858.332041776399;7875.173106823816;7879.527228366202;4568.588827005586;5253.369595648546;5348.1977703343255;5480.972595136999;5592.692401917933;7776.572288524186;9018.68434604812;9065.048169942325;9194.080591940752;9307.301952353737;8982.730518084469;9259.953700231456;9390.154886060287;9475.005124461832;9539.713808585753;7070.186928503288;7292.489525733148;7302.306280903518;7317.5609463432365;7330.120385553768;7258.491905566771;7500.812479688051;7821.256980586835;7904.881426778488;7907.446478746432;5459.945400545944;6783.423409010289;6830.965845170742;6845.14435695538;6872.244053154049;6666.699998499982;6673.699683514351;6697.564658297195;6800.047993280846;6849.212340580897;6133.355997620186;6140.324564298013;6214.098955651496;6219.751209951733;6220.844478888064;3825.2540754552597;3925;4490.685652004328;4645.2335364665805;4742.051589682146;4540.523245059353;4610.631149507964;4751.619870410428;4840.951590484191;4848.369711937426 08:21:43 INFO - PROCESS | 1639 | |4;prototype.html;310.4814959018442;325.76382122960854;357.85685725709715;364.9470826730124;376.52557777200735;4590.908181836361;5135.4351021387665;5148.304978827857;5279.868003299919;5321.920171197426;3959.4456776051375;5305.2942999070465;5418.106012507941;5425.810096646618;5429.891402171954;3229.6447390786993;3787.924241515168;4023.8792836214816;4126.896827579305;4140.544540100602;3409.8124603146816;3771.0006848185117;3778.489903862971;4125.546189919107;4148.771817550033;4090.8159132838946;4092.815823287944;4123.505179378479;4129.442525259082;4129.758139860211;3537.8501986854376;3766.435034744783;4091.7954102294766;4092.754434733896;4131.400946862703;3347.192516041335;3426.648156840798;3495.1087472694553;3508.754387192872;3509.6314886937016;4875.561199492063;5201.271821944931;5214.426413094557;5241.31862857826;5300.24387318596;4660.231061874787;4663.60359369454;4665.043666048452;4708.646851486153;4717.245240761462;4689.616563113889;5263.26314315996;5671.801486947937;5706.543476521868;5708.571857110734;3267.39553182662;3899.2396482685886;3903.8048097595292;3905.9609403905883;3908.2769687607883;5029.597632189452;5564.638298510584;6016.78941237059;6022.307434644984;6038.456538911519;3710.9443358349645;3838.251540949544;3950;3961.861334853324;3992.8203230854683;3398.6261511233743;3677.7793332400142;3992.2215168042535;4023.979880100581;4028.576999415019;3692;4111.437653691638;4331.350297455407;4677.152524752772;4729.9054018920115;4929;5349.973250133725;5522.3649280333275;5672.262605861211;5702.0042984954935;1176.9231153494457;1256.1395444120624;1300.8699130086916;1305.8628843971437;1311.5344052861287;737.0896942276285;823.0329362998452;831.6132998155887;868.8957325121025;876.2114097312342;4685.390899183084;5120.667156634807;5149.922751158736;5157.767900444489;5157.871053223699;4807.4471435785335;5653.381835625203;5683.488486036276;5704.375987045923;5765.509931655773;4323.4003418735265;4439.800208990603;4456.4652241730555;4985.326980857611;5112.539871411516;2502.2359236738057;2939.808912420686;2978.9851050744605;2986;2990.6112205413156;4748.19280722278;5474.7262636868;5576.909637291189;5824.242848429762;5868.799200299887;4489.73061616304;4943.737133491878;5046.722430266371;6035.400618836012;6179.16581261524;5679.290088738908;5867.559933005042;6104.816855494342;6213.844653883599;6259.405356491126;4938.283948827472;5968.910466342922;5981.9401805983125;6004.729787159501;6030.276366835832;4825.6139508839915;5365;5900.017488195365;5915.112733090071;5984.9401505986125;6176.258848938156;6179.5056395489155;6234.345393733593;6244.438000579969;6260.280067792262;3505.5267538881926;3829.9617003829603;3886.9805650971566;4002.9985007496252;4004.4794176756836;5650.519705825051;5715.514181294637;5829.618821083846;5840.007198776133;5852.824415267549;4634.629229661687;5634.605577609528;5787.652740835563;5793.1323994622935;5796.855078623068;4381.780910954503;4967.014747229652;5762.884742305214;5765.7693692253515;5772.845430913918;5431.696392865605;5620.615919582732;5683.261176047087;5690.487856092972;5698.31620205578;5059.296432227387;5638.209086502207;5828.533717302521;5862.677552734641;5876.324222714272;5325.786968521371;5647.15292706081;5692;5704.8606772460325;5763.337216220189 08:21:43 INFO - PROCESS | 1639 | |5;yui.html;731.7585196885028;732.9560226386417;746.9990213114426;814.6458072466852;824.208759590793;14347.928260358696;15192.924035379807;15310.923445382785;15356.155411452366;15363.924525283235;13785.862141378584;14156.71686566268;14378.784318235208;14399.78400323996;14429.42282308709;856.1566856646214;866.9219770220678;867.7526904832124;870.1559487297311;871.4335681806813;691.1222747111166;709.7303024850576;767.57399643198;849.7833052571585;887.525174031893;913.5569248914304;930.4045410937006;935.3031991166556;936.2369668719972;940.1773448232797;932.370649811378;933.5985526223722;935.9797820375755;937.7093101138669;940.8165407745493;697.8778713725078;704.3519961635308;705.5978092487285;705.675389320913;706.7597017014189;14540.854591454055;14982.101073935599;15184.848151518565;15313.387464501406;15341.769873451907;14199.503017394341;14560.927195363955;14568.344424500818;14590.635234119125;14598.34307456167;11457.36984465854;11664.708382290426;11680.70798230051;11733.589324373606;11847.933685968304;3238.6923242291946;3716.1638631307737;3717.8141092945243;3732.4401339798974;3881;109037;109980.4500977498;110494.3425848613;111162;111628;10929.781404372026;10951.671449856518;11125.777484450427;11145.665630031112;11365.829512557319;23319;23723.40691482727;23739.643905341432;23789.92945317465;23899.7610023901;7718.807029824299;7767.495112817649;7807.843843123219;7882.684692612346;7948.801279967932;4008.498937632796;4110.0135967368215;4110.527289361702;4112.856050038235;4157.648764151662;3587.7309201809967;3695.2424752925585;3708.2027364116843;3824.0057585028094;3956.9208615827524;701.849102442967;715.9856802863914;723.4321057969469;729.6607077708891;731.8463122744176;655.8458762190882;668.2348710726192;679.9762008329685;684.7671791590883;726.9927300727031;10082.69751907444;10126.341787783771;10348.637797677045;10355.068043876086;10363.067323940732;675.699313805352;677.762783025937;697.6442014572605;700.3171907390254;714.3749219432996;4639.211334073216;4795.246555096022;4977.925331120036;5061.164907790247;5072.163093089673;106992;107874.46062769636;107918.46040769746;108273;110105.44947275212;91407.62888556677;93756.53121734348;94137.58793618101;94277;97148.0285197139;70030.64984675044;70401;71102.64448677724;72476.63761681158;80389.79415308774;9921.355111917703;10722.73193170177;10895.237333386587;10999.285046471954;11315.660530184108;47506.28740568825;48419.06323747151;50274;51218;51896.48103519068;50295;58000.4199957995;60550;64046;64791;12534.310612916377;12621.87378126207;12726.490940362282;12835.743285134058;13437.596872093853;14180.819850367496;14190.858091418953;14246.715065698836;14434.494792682206;14434.566962991126;13025.804612931002;13264.291961517009;13291.136076155019;13499.122557034154;13793.793093103812;13142.145760525535;13543.661408464866;13560;14023;14035.859641403455;12930.418131184308;12977;13129.212247265195;13162.802557961446;13224.867751322363;8843;10832;10938.289011214245;11017.504212310305;11261.436928153724;10594.947025264824;10731.946340268249;10797.62208322705;10944.179186560881;10974.396408197626 08:21:43 INFO - PROCESS | 1639 | __end_tp_report 08:21:43 INFO - PROCESS | 1639 | __start_cc_report 08:21:43 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,383 08:21:43 INFO - PROCESS | 1639 | __end_cc_report 08:21:43 INFO - PROCESS | 1639 | __startTimestamp1487780503928__endTimestamp 08:21:43 INFO - PROCESS | 1639 | 08:21:43 INFO - PROCESS | 1639 | ------- Summary: start ------- 08:21:43 INFO - PROCESS | 1639 | Number of tests: 6 08:21:43 INFO - PROCESS | 1639 | 08:21:43 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5809.23 Median:6041.97 stddev:647.85 (10.7%) stddev-sans-first:620.91 08:21:43 INFO - PROCESS | 1639 | Values: 3369.3 3372.9 3395.7 3398.1 3406.7 5467.9 5725.7 5787.6 5845.3 5865.3 5289.6 5832.5 5833.9 5921.6 5938.9 5333.3 5351.1 5352.5 5352.6 5408.1 5384.1 5399.9 5416.2 5425.9 5451.7 5190.9 5201.6 5388.6 5402.1 5405.3 5253.0 5282.8 5347.6 5364.8 5403.3 5220.2 5311.2 5324.3 5331.9 5365.0 4778.9 5830.4 5856.4 5898.5 5962.3 5115.9 6187.1 6194.2 6196.5 6263.0 5582.3 6185.1 6330.9 6370.5 6378.3 5957.4 5987.6 5996.9 6001.2 6042.0 6170.3 6242.7 6282.4 6315.4 6328.0 6092.8 6122.1 6139.0 6162.3 6190.5 6225.0 6312.2 6316.1 6316.4 6318.7 6117.7 6180.7 6183.2 6204.6 6244.5 6217.5 6218.7 6224.3 6238.8 6253.5 5024.5 5024.8 5026.6 5033.9 5050.7 4383.5 4392.9 4411.2 4428.2 4478.3 5781.9 5849.1 5893.4 5942.1 5949.1 6274.0 6304.1 6310.2 6324.1 6336.0 5718.3 5751.6 5820.8 5847.5 5855.3 4773.2 5520.0 5532.3 5541.6 5551.5 6447.0 6479.7 6491.6 6497.4 6508.6 6178.0 6181.5 6187.8 6194.8 6346.0 6497.2 6509.6 6519.4 6527.1 6557.0 6255.6 6258.8 6265.6 6266.2 6270.6 6164.0 6184.6 6235.0 6326.9 6337.4 5910.9 6168.2 6174.4 6174.5 6203.8 6030.5 6165.4 6181.5 6187.3 6211.5 5875.1 5887.2 5961.6 6004.3 6084.7 6127.1 6130.4 6188.1 6256.3 6270.7 6122.4 6124.8 6131.0 6132.3 6148.2 08:21:43 INFO - PROCESS | 1639 | 08:21:43 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:67472.47 Median:36125.05 stddev:144679.04 (400.5%) stddev-sans-first:144997.37 08:21:43 INFO - PROCESS | 1639 | Values: 441.8 446.8 491.8 529.5 535.9 37393.6 40128.8 40220.4 40250.4 40402.0 32862.3 40871.4 41484.0 41513.4 41518.4 8329.6 8588.5 8943.6 9223.4 9224.0 10911.2 11192.8 11216.8 11364.4 11389.6 10021.3 10907.9 11305.8 11348.7 11357.0 11271.9 11338.9 11339.5 11352.9 11359.4 11165.5 11236.5 11237.8 11241.0 11270.0 39884.4 40141.6 40192.6 40232.8 40337.0 3857.9 3913.6 3940.7 3953.5 4014.3 27595.9 28419.1 28776.4 28878.3 29152.6 3125.2 3160.3 3244.1 3344.7 3346.2 485434.0 486539.0 488986.0 490720.0 491503.0 48107.5 57207.0 57453.7 57976.7 58008.0 60172.7 60654.4 60739.0 60740.7 60808.1 15228.8 15812.2 15812.8 15827.7 15849.1 11005.7 11293.1 12009.0 12124.8 12381.5 17944.6 18105.8 18119.5 18175.3 18198.9 6522.7 6888.5 7742.8 7772.3 7787.4 839.2 842.4 863.2 867.8 883.6 29503.4 29979.0 29996.4 30031.1 30808.8 927.8 985.7 1010.5 1097.4 1181.4 14720.5 15643.5 15686.8 16099.4 16330.8 628539.0 629869.9 633155.0 635714.0 649286.0 61546.7 62229.0 62229.1 62248.0 62256.7 1413.6 1427.7 1445.3 1446.6 1449.8 29161.9 29736.4 29906.9 30262.5 30283.8 50999.2 51545.0 51557.5 51747.0 51934.2 488146.0 489024.0 489134.0 490473.5 491480.0 35322.8 35958.5 38686.8 39507.8 43359.9 41947.5 41967.4 42111.0 43357.0 43415.8 35023.8 35418.0 35740.0 36537.5 36980.9 35470.1 35474.8 36291.6 36356.5 36623.6 34944.8 35038.5 35305.3 35420.0 35734.6 30486.0 31593.2 32048.0 32087.4 32126.8 23793.0 23955.9 23981.0 24316.3 24322.9 08:21:43 INFO - PROCESS | 1639 | 08:21:43 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:39628.60 Median:399.44 stddev:125530.46 (31426.6%) stddev-sans-first:125848.02 08:21:43 INFO - PROCESS | 1639 | Values: 390.8 394.4 397.8 400.2 426.4 16075.3 19749.9 19823.8 21322.9 21399.7 20931.7 21004.6 21629.1 22159.0 22402.4 5708.9 5896.7 5905.6 5950.6 6011.2 4913.9 5264.5 5465.9 5788.4 5847.7 4620.4 5714.9 5802.6 5810.7 5836.7 5408.5 5637.0 5802.1 5808.9 5821.2 4780.7 5634.8 5679.6 5691.2 5693.7 13493.4 13512.7 13608.5 13704.2 21349.8 2539.7 2567.7 2596.7 2656.8 2710.9 9943.8 9991.2 10101.4 10395.9 10454.7 1768.0 1833.2 1847.9 1849.9 1869.6 101528.0 111011.4 113787.0 121784.0 122743.0 11541.7 11804.6 11818.8 11831.4 11840.0 13416.5 14043.7 15724.5 15743.3 15795.3 8031.6 8633.0 8790.5 8795.6 9007.8 8591.7 8668.3 8671.9 8795.9 8818.9 4760.3 4846.8 4861.4 4865.3 4909.5 2023.1 2058.8 2065.8 2069.0 2071.3 398.7 417.4 428.0 840.9 881.9 11942.2 12036.4 12045.5 12066.9 12279.2 454.3 457.0 459.7 463.9 470.4 6095.9 6135.7 6149.8 6274.1 6279.5 738578.0 747392.0 753121.0 762401.0 773083.0 124398.0 156034.2 157953.0 158135.0 164562.2 441.6 450.6 966.6 1036.6 1043.0 15141.9 18420.4 18551.3 19726.0 19727.0 55072.0 55635.0 56522.0 57072.0 57961.4 86626.0 87044.6 88186.0 89066.0 90295.0 7609.9 8045.2 8180.6 8523.0 8543.2 9132.6 11855.3 12402.3 12899.4 12903.7 10689.1 10757.9 10906.2 11037.7 11137.7 10855.1 10898.5 11031.8 11165.1 11284.5 10929.3 11253.2 11264.0 11296.2 11465.7 8200.3 8252.8 8388.2 8483.7 8566.0 8098.0 8919.6 10888.5 11229.5 11284.8 08:21:43 INFO - PROCESS | 1639 | 08:21:43 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5367.41 Median:5216.23 stddev:2922.05 (56.0%) stddev-sans-first:2914.90 08:21:43 INFO - PROCESS | 1639 | Values: 1382.3 1425.4 1431.6 1434.6 1445.2 6469.7 7579.7 8079.8 8537.6 8557.4 6895.9 8068.9 8312.6 8405.8 8445.9 2320.3 2349.7 2351.6 2356.8 2369.3 2099.2 2186.1 2324.7 2373.7 2373.8 2255.1 2331.7 2341.9 2343.2 2345.4 2311.1 2323.8 2329.2 2338.7 2345.1 2312.8 2361.0 2365.2 2389.7 2391.2 8401.7 8429.3 8450.4 8474.6 8481.5 5069.2 5186.7 5214.9 5217.5 5238.7 3325.1 3542.2 3555.4 3573.5 3627.3 1178.9 1213.3 1256.1 1260.8 1270.2 10886.6 10918.8 10939.3 10941.3 10942.2 4623.1 4691.7 4714.8 4779.4 4784.1 9565.3 9618.1 9623.2 9629.2 9641.6 5210.5 5310.1 5335.0 5349.7 5352.8 4544.5 4826.9 4837.1 4878.2 4887.5 3890.9 3903.6 3971.0 4027.7 4053.6 1117.6 1191.2 1236.8 1264.8 1319.2 859.9 880.7 881.9 895.5 895.7 5510.3 5522.0 5671.4 5677.5 5760.1 959.8 972.9 979.4 995.5 1002.6 3384.5 3597.1 3617.5 3730.2 3799.3 9725.6 10074.5 10076.2 10079.3 10100.8 8051.6 9405.9 9952.0 9954.1 10016.0 7621.2 7846.2 7858.3 7875.2 7879.5 4568.6 5253.4 5348.2 5481.0 5592.7 7776.6 9018.7 9065.0 9194.1 9307.3 8982.7 9260.0 9390.2 9475.0 9539.7 7070.2 7292.5 7302.3 7317.6 7330.1 7258.5 7500.8 7821.3 7904.9 7907.4 5459.9 6783.4 6831.0 6845.1 6872.2 6666.7 6673.7 6697.6 6800.0 6849.2 6133.4 6140.3 6214.1 6219.8 6220.8 3825.3 3925.0 4490.7 4645.2 4742.1 4540.5 4610.6 4751.6 4841.0 4848.4 08:21:43 INFO - PROCESS | 1639 | 08:21:43 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4556.96 Median:5053.01 stddev:1439.21 (28.5%) stddev-sans-first:1407.51 08:21:43 INFO - PROCESS | 1639 | Values: 310.5 325.8 357.9 364.9 376.5 4590.9 5135.4 5148.3 5279.9 5321.9 3959.4 5305.3 5418.1 5425.8 5429.9 3229.6 3787.9 4023.9 4126.9 4140.5 3409.8 3771.0 3778.5 4125.5 4148.8 4090.8 4092.8 4123.5 4129.4 4129.8 3537.9 3766.4 4091.8 4092.8 4131.4 3347.2 3426.6 3495.1 3508.8 3509.6 4875.6 5201.3 5214.4 5241.3 5300.2 4660.2 4663.6 4665.0 4708.6 4717.2 4689.6 5263.3 5671.8 5706.5 5708.6 3267.4 3899.2 3903.8 3906.0 3908.3 5029.6 5564.6 6016.8 6022.3 6038.5 3710.9 3838.3 3950.0 3961.9 3992.8 3398.6 3677.8 3992.2 4024.0 4028.6 3692.0 4111.4 4331.4 4677.2 4729.9 4929.0 5350.0 5522.4 5672.3 5702.0 1176.9 1256.1 1300.9 1305.9 1311.5 737.1 823.0 831.6 868.9 876.2 4685.4 5120.7 5149.9 5157.8 5157.9 4807.4 5653.4 5683.5 5704.4 5765.5 4323.4 4439.8 4456.5 4985.3 5112.5 2502.2 2939.8 2979.0 2986.0 2990.6 4748.2 5474.7 5576.9 5824.2 5868.8 4489.7 4943.7 5046.7 6035.4 6179.2 5679.3 5867.6 6104.8 6213.8 6259.4 4938.3 5968.9 5981.9 6004.7 6030.3 4825.6 5365.0 5900.0 5915.1 5984.9 6176.3 6179.5 6234.3 6244.4 6260.3 3505.5 3830.0 3887.0 4003.0 4004.5 5650.5 5715.5 5829.6 5840.0 5852.8 4634.6 5634.6 5787.7 5793.1 5796.9 4381.8 4967.0 5762.9 5765.8 5772.8 5431.7 5620.6 5683.3 5690.5 5698.3 5059.3 5638.2 5828.5 5862.7 5876.3 5325.8 5647.2 5692.0 5704.9 5763.3 08:21:43 INFO - PROCESS | 1639 | 08:21:43 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20597.43 Median:3701.72 stddev:29935.15 (808.7%) stddev-sans-first:29981.97 08:21:43 INFO - PROCESS | 1639 | Values: 731.8 733.0 747.0 814.6 824.2 14347.9 15192.9 15310.9 15356.2 15363.9 13785.9 14156.7 14378.8 14399.8 14429.4 856.2 866.9 867.8 870.2 871.4 691.1 709.7 767.6 849.8 887.5 913.6 930.4 935.3 936.2 940.2 932.4 933.6 936.0 937.7 940.8 697.9 704.4 705.6 705.7 706.8 14540.9 14982.1 15184.8 15313.4 15341.8 14199.5 14560.9 14568.3 14590.6 14598.3 11457.4 11664.7 11680.7 11733.6 11847.9 3238.7 3716.2 3717.8 3732.4 3881.0 109037.0 109980.5 110494.3 111162.0 111628.0 10929.8 10951.7 11125.8 11145.7 11365.8 23319.0 23723.4 23739.6 23789.9 23899.8 7718.8 7767.5 7807.8 7882.7 7948.8 4008.5 4110.0 4110.5 4112.9 4157.6 3587.7 3695.2 3708.2 3824.0 3956.9 701.8 716.0 723.4 729.7 731.8 655.8 668.2 680.0 684.8 727.0 10082.7 10126.3 10348.6 10355.1 10363.1 675.7 677.8 697.6 700.3 714.4 4639.2 4795.2 4977.9 5061.2 5072.2 106992.0 107874.5 107918.5 108273.0 110105.4 91407.6 93756.5 94137.6 94277.0 97148.0 70030.6 70401.0 71102.6 72476.6 80389.8 9921.4 10722.7 10895.2 10999.3 11315.7 47506.3 48419.1 50274.0 51218.0 51896.5 50295.0 58000.4 60550.0 64046.0 64791.0 12534.3 12621.9 12726.5 12835.7 13437.6 14180.8 14190.9 14246.7 14434.5 14434.6 13025.8 13264.3 13291.1 13499.1 13793.8 13142.1 13543.7 13560.0 14023.0 14035.9 12930.4 12977.0 13129.2 13162.8 13224.9 8843.0 10832.0 10938.3 11017.5 11261.4 10594.9 10731.9 10797.6 10944.2 10974.4 08:21:43 INFO - PROCESS | 1639 | -------- Summary: end -------- 08:21:43 INFO - PROCESS | 1639 | 08:21:44 INFO - TEST-INFO | 1639: exit 0 08:21:44 INFO - TEST-OK | dromaeo_css | took 1115626ms 08:21:44 INFO - TEST-START | kraken 08:21:44 INFO - operating with platform_type : mac_ 08:21:44 INFO - Initialising browser for kraken test... 08:21:44 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmp2ITwL6/profile http://localhost:49241/getInfo.html) 08:21:47 INFO - PROCESS | 1650 | 2017-02-22 08:21:47.429 plugin-container[1651:9803] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 08:21:47 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:21:47 INFO - PROCESS | 1650 | 2017-02-22 08:21:47.432 plugin-container[1651:9803] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 08:21:47 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:21:47 INFO - PROCESS | 1650 | 2017-02-22 08:21:47.432 plugin-container[1651:9803] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:21:47 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 08:21:47 INFO - PROCESS | 1650 | colorDepth:24 08:21:47 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 08:21:47 INFO - PROCESS | 1650 | __metrics 08:21:47 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 08:21:48 INFO - TEST-INFO | 1650: exit 0 08:21:48 INFO - Browser initialized. 08:21:48 INFO - Running cycle 1/1 for kraken test... 08:21:48 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmp2ITwL6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:50 INFO - PROCESS | 1652 | 2017-02-22 08:21:50.727 plugin-container[1653:9935] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a47, name = 'com.apple.tsm.portname' 08:21:50 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:21:50 INFO - PROCESS | 1652 | 2017-02-22 08:21:50.727 plugin-container[1653:9935] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 08:21:50 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:21:50 INFO - PROCESS | 1652 | 2017-02-22 08:21:50.727 plugin-container[1653:9935] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:22:00 INFO - PROCESS | 1652 | RSS: Main: 219340800 08:22:00 INFO - PROCESS | 1652 | 08:22:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 08:22:04 INFO - PROCESS | 1652 | RSS: Main: 233701376 08:22:04 INFO - PROCESS | 1652 | 08:22:07 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 08:22:07 INFO - PROCESS | 1652 | RSS: Main: 241455104 08:22:07 INFO - PROCESS | 1652 | 08:22:11 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 08:22:11 INFO - PROCESS | 1652 | RSS: Main: 245243904 08:22:11 INFO - PROCESS | 1652 | 08:22:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 08:22:14 INFO - PROCESS | 1652 | RSS: Main: 245477376 08:22:14 INFO - PROCESS | 1652 | 08:22:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:22:16 INFO - PROCESS | 1652 | RSS: Main: 245493760 08:22:16 INFO - PROCESS | 1652 | 08:22:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 08:22:20 INFO - PROCESS | 1652 | RSS: Main: 250785792 08:22:20 INFO - PROCESS | 1652 | 08:22:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 08:22:24 INFO - PROCESS | 1652 | RSS: Main: 249860096 08:22:24 INFO - PROCESS | 1652 | 08:22:27 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 08:22:28 INFO - PROCESS | 1652 | RSS: Main: 249810944 08:22:28 INFO - PROCESS | 1652 | 08:22:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:22:30 INFO - PROCESS | 1652 | RSS: Main: 249540608 08:22:30 INFO - PROCESS | 1652 | 08:22:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:22:32 INFO - PROCESS | 1652 | RSS: Main: 249729024 08:22:32 INFO - PROCESS | 1652 | 08:22:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:22:35 INFO - PROCESS | 1652 | RSS: Main: 249643008 08:22:35 INFO - PROCESS | 1652 | 08:22:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:22:39 INFO - PROCESS | 1652 | RSS: Main: 249913344 08:22:39 INFO - PROCESS | 1652 | 08:22:42 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:22:42 INFO - PROCESS | 1652 | RSS: Main: 249724928 08:22:42 INFO - PROCESS | 1652 | 08:22:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 08:22:44 INFO - PROCESS | 1652 | RSS: Main: 251568128 08:22:44 INFO - PROCESS | 1652 | 08:22:44 INFO - PROCESS | 1652 | __start_tp_report 08:22:44 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 08:22:44 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 08:22:44 INFO - PROCESS | 1652 | |i|pagename|runs| 08:22:44 INFO - PROCESS | 1652 | |0;ai-astar;104;121;164;116;115;118;118;117;118;116 08:22:44 INFO - PROCESS | 1652 | |1;audio-beat-detection;143;112;112;146;112;115;125;145;144;114 08:22:44 INFO - PROCESS | 1652 | |2;audio-dft;199;201;196;200;195;194;219;280;243;196 08:22:44 INFO - PROCESS | 1652 | |3;audio-fft;83;67;88;98;60;60;62;76;99;83 08:22:44 INFO - PROCESS | 1652 | |4;audio-oscillator;89;70;87;73;70;72;80;74;106;116 08:22:44 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;139;134;88;86;110;133;88;86;88;85 08:22:44 INFO - PROCESS | 1652 | |6;imaging-darkroom;148;102;98;151;152;104;154;108;152;104 08:22:44 INFO - PROCESS | 1652 | |7;imaging-desaturate;95;95;90;93;95;93;93;95;90;110 08:22:44 INFO - PROCESS | 1652 | |8;json-parse-financial;61;59;59;62;61;63;63;63;65;62 08:22:44 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;71;71;77;86;77;69;68;69;73;70 08:22:44 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;86;85;83;86;84;88;86;84;86;84 08:22:45 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;142;154;139;139;146;145;141;140;211;187 08:22:45 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;198;239;164;215;212;169;171;202;167;169 08:22:45 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;70;83;88;87;66;68;68;66;66;69 08:22:45 INFO - PROCESS | 1652 | __end_tp_report 08:22:45 INFO - PROCESS | 1652 | __start_cc_report 08:22:45 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,970 08:22:45 INFO - PROCESS | 1652 | __end_cc_report 08:22:45 INFO - PROCESS | 1652 | __startTimestamp1487780564991__endTimestamp 08:22:45 INFO - PROCESS | 1652 | 08:22:45 INFO - PROCESS | 1652 | ------- Summary: start ------- 08:22:45 INFO - PROCESS | 1652 | Number of tests: 14 08:22:45 INFO - PROCESS | 1652 | 08:22:45 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:120.70 Median:118.00 stddev:15.87 (13.4%) stddev-sans-first:15.64 08:22:45 INFO - PROCESS | 1652 | Values: 104.0 121.0 164.0 116.0 115.0 118.0 118.0 117.0 118.0 116.0 08:22:45 INFO - PROCESS | 1652 | 08:22:45 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:134.00 stddev:15.71 (11.7%) stddev-sans-first:15.53 08:22:45 INFO - PROCESS | 1652 | Values: 143.0 112.0 112.0 146.0 112.0 115.0 125.0 145.0 144.0 114.0 08:22:45 INFO - PROCESS | 1652 | 08:22:45 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:212.30 Median:200.50 stddev:28.27 (14.1%) stddev-sans-first:29.57 08:22:45 INFO - PROCESS | 1652 | Values: 199.0 201.0 196.0 200.0 195.0 194.0 219.0 280.0 243.0 196.0 08:22:45 INFO - PROCESS | 1652 | 08:22:45 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:77.60 Median:83.00 stddev:14.98 (18.0%) stddev-sans-first:15.76 08:22:45 INFO - PROCESS | 1652 | Values: 83.0 67.0 88.0 98.0 60.0 60.0 62.0 76.0 99.0 83.0 08:22:45 INFO - PROCESS | 1652 | 08:22:45 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:83.70 Median:73.50 stddev:16.04 (21.8%) stddev-sans-first:16.89 08:22:45 INFO - PROCESS | 1652 | Values: 89.0 70.0 87.0 73.0 70.0 72.0 80.0 74.0 106.0 116.0 08:22:45 INFO - PROCESS | 1652 | 08:22:45 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:103.70 Median:86.00 stddev:23.04 (26.8%) stddev-sans-first:20.60 08:22:45 INFO - PROCESS | 1652 | Values: 139.0 134.0 88.0 86.0 110.0 133.0 88.0 86.0 88.0 85.0 08:22:45 INFO - PROCESS | 1652 | 08:22:45 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:127.30 Median:151.50 stddev:25.56 (16.9%) stddev-sans-first:25.99 08:22:45 INFO - PROCESS | 1652 | Values: 148.0 102.0 98.0 151.0 152.0 104.0 154.0 108.0 152.0 104.0 08:22:45 INFO - PROCESS | 1652 | 08:22:45 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.00 stddev:5.65 (6.0%) stddev-sans-first:5.99 08:22:45 INFO - PROCESS | 1652 | Values: 95.0 95.0 90.0 93.0 95.0 93.0 93.0 95.0 90.0 110.0 08:22:45 INFO - PROCESS | 1652 | 08:22:45 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.50 stddev:1.87 (3.0%) stddev-sans-first:1.96 08:22:45 INFO - PROCESS | 1652 | Values: 61.0 59.0 59.0 62.0 61.0 63.0 63.0 63.0 65.0 62.0 08:22:45 INFO - PROCESS | 1652 | 08:22:45 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:72.00 stddev:5.53 (7.7%) stddev-sans-first:5.81 08:22:45 INFO - PROCESS | 1652 | Values: 71.0 71.0 77.0 86.0 77.0 69.0 68.0 69.0 73.0 70.0 08:22:45 INFO - PROCESS | 1652 | 08:22:45 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:86.00 stddev:1.48 (1.7%) stddev-sans-first:1.54 08:22:45 INFO - PROCESS | 1652 | Values: 86.0 85.0 83.0 86.0 84.0 88.0 86.0 84.0 86.0 84.0 08:22:45 INFO - PROCESS | 1652 | 08:22:45 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:154.40 Median:145.50 stddev:24.59 (16.9%) stddev-sans-first:25.67 08:22:45 INFO - PROCESS | 1652 | Values: 142.0 154.0 139.0 139.0 146.0 145.0 141.0 140.0 211.0 187.0 08:22:45 INFO - PROCESS | 1652 | 08:22:45 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.60 Median:200.00 stddev:26.17 (13.1%) stddev-sans-first:27.62 08:22:45 INFO - PROCESS | 1652 | Values: 198.0 239.0 164.0 215.0 212.0 169.0 171.0 202.0 167.0 169.0 08:22:45 INFO - PROCESS | 1652 | 08:22:45 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:69.50 stddev:9.09 (13.1%) stddev-sans-first:9.57 08:22:45 INFO - PROCESS | 1652 | Values: 70.0 83.0 88.0 87.0 66.0 68.0 68.0 66.0 66.0 69.0 08:22:45 INFO - PROCESS | 1652 | -------- Summary: end -------- 08:22:45 INFO - PROCESS | 1652 | 08:22:45 INFO - TEST-INFO | 1652: exit 0 08:22:45 INFO - TEST-OK | kraken | took 61316ms 08:22:45 INFO - SUITE-END | took 1176s 08:22:46 INFO - Completed test suite (00:19:37) 08:22:46 INFO - javascript benchmark 08:22:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7215.055009237818, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3369.275605744765, 3372.9156771080734, 3395.6943875051243, 3398.1334759636297, 3406.6763657452548, 5467.91798123028, 5725.742341594628, 5787.623804452718, 5845.327787304451, 5865.266841644794, 5289.550388217006, 5832.475077243047, 5833.8833223335505, 5921.555883308758, 5938.910916336258, 5333.253344531759, 5351.0903146465, 5352.4915133062495, 5352.625316227865, 5408.0535906216455, 5384.057789886774, 5399.865003374908, 5416.214648875911, 5425.9186112208345, 5451.672899626035, 5190.870228244286, 5201.635885488017, 5388.649737767052, 5402.108652072423, 5405.324334458192, 5253.0, 5282.841514754564, 5347.6256662033675, 5364.785408583652, 5403.297571315704, 5220.216967454912, 5311.2298716686255, 5324.334458192726, 5331.946680533222, 5364.9731751341, 4778.928316075262, 5830.38780928005, 5856.414358564152, 5898.498627616657, 5962.34414214436, 5115.897682046339, 6187.102870083812, 6194.163787888622, 6196.473299769525, 6263.0, 5582.274304340451, 6185.134081228632, 6330.936690633127, 6370.458511026568, 6378.330275321117, 5957.434043765836, 5987.64074155552, 5996.850078747979, 6001.159837622737, 6041.969790151021, 6170.290416602058, 6242.687865606701, 6282.371762823681, 6315.431611155018, 6328.019157030668, 6092.786752463642, 6122.134291015255, 6139.032198454786, 6162.26052873649, 6190.535709821781, 6224.968875155686, 6312.210973628296, 6316.115743795872, 6316.368363163739, 6318.6524741138755, 6117.736059405486, 6180.690965451709, 6183.196184495987, 6204.565680402328, 6244.500439964792, 6217.4715149212825, 6218.689065546704, 6224.346443623445, 6238.844028899314, 6253.53098517613, 5024.522670346311, 5024.79900803971, 5026.572741316956, 5033.949660503421, 5050.722210278396, 4383.473983122046, 4392.934105988413, 4411.18393097278, 4428.202923473741, 4478.305862591304, 5781.884362312814, 5849.064149736022, 5893.44012318829, 5942.078977758454, 5949.077892926603, 6274.027525733427, 6304.148939893147, 6310.211223597051, 6324.08300796382, 6336.04959256106, 5718.313802343745, 5751.568632352507, 5820.796272130455, 5847.502962248256, 5855.268091488564, 4773.212419950739, 5520.0, 5532.336119665666, 5541.5843811714285, 5551.500364967092, 6447.000714889105, 6479.7408103675325, 6491.578047426997, 6497.350264973654, 6508.609483430914, 6178.0, 6181.505479561714, 6187.752489900354, 6194.81415557534, 6346.048092786119, 6497.18785151856, 6509.609423434609, 6519.4132528072705, 6527.05357723137, 6557.0, 6255.593386429868, 6258.780942666985, 6265.561410701207, 6266.216722909637, 6270.623762574261, 6163.96918015425, 6184.628922264678, 6235.0, 6326.905096423466, 6337.429631333202, 5910.911336330045, 6168.19813424252, 6174.413430724074, 6174.475169610633, 6203.7828675996125, 6030.547708921936, 6165.3526379731275, 6181.505479561534, 6187.288461826767, 6211.534134939807, 5875.089361149029, 5887.234659494238, 5961.582689211714, 6004.309504407049, 6084.695765211633, 6127.097902969212, 6130.398136741914, 6188.133661287513, 6256.311805701278, 6270.7491700331475, 6122.448979591858, 6124.785632502841, 6131.019036954066, 6132.325444201224, 6148.231471066117], "value": 5768.242286808766, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.7923575919317, 446.81903828949277, 491.84506880332714, 529.4625954656022, 535.9464053594639, 37393.62606373936, 40128.79935600322, 40220.39669404961, 40250.39624405636, 40401.98995025122, 32862.34275314492, 40871.38692919609, 41484.0, 41513.37729934046, 41518.37722434158, 8329.583520823964, 8588.484690918534, 8943.642254309836, 9223.446593204395, 9223.953880230589, 10911.181661375389, 11192.832107518394, 11216.766155722864, 11364.431778411088, 11389.601363952263, 10021.34861234021, 10907.90920907907, 11305.773884522305, 11348.716282092932, 11357.0, 11271.887281127165, 11338.943305283503, 11339.546418143264, 11352.94323528377, 11359.375234362107, 11165.497552610152, 11236.494357753922, 11237.83143252852, 11241.044511216556, 11270.042046425982, 39884.40173397402, 40141.59858401408, 40192.59807401947, 40232.798836005924, 40337.0, 3857.9228415431535, 3913.6288933330784, 3940.7241493095494, 3953.5058117735284, 4014.2573623879675, 27595.86202068997, 28419.147425577266, 28776.424471510454, 28878.278043048882, 29152.562711559345, 3125.203073216338, 3160.3205310858048, 3244.0916543367657, 3344.715699165574, 3346.2136397946465, 485434.0, 486539.0, 488986.0, 490720.0, 491502.99999999645, 48107.518924810305, 57207.0, 57453.71273143608, 57976.71011644999, 58008.0, 60172.69913650404, 60654.39345606576, 60739.0, 60740.69629651912, 60808.08787868186, 15228.847711522965, 15812.209389530477, 15812.762808557882, 15827.68344633101, 15849.128297943493, 11005.669829905115, 11293.096552275963, 12009.0, 12124.818127728091, 12381.504739810307, 17944.564434845182, 18105.823121497062, 18119.45641630753, 18175.272989080553, 18198.909005454887, 6522.739090436425, 6888.517803753789, 7742.7677169683875, 7772.261635144652, 7787.3770098392, 839.1692224697506, 842.3766412854444, 863.2015385768265, 867.7657032601162, 883.5847151838625, 29503.409931801245, 29979.0, 29996.400071998873, 30031.099067027586, 30808.845955770077, 927.826299730841, 985.7338518599938, 1010.4796030044533, 1097.4238524774557, 1181.4092953523239, 14720.484783032756, 15643.530694078969, 15686.843131568767, 16099.356025759073, 16330.836691633169, 628539.0, 629869.850650753, 633155.0, 635714.0, 649286.0, 61546.69226653838, 62229.0, 62229.06656400158, 62248.0, 62256.68871655613, 1413.6465883529117, 1427.6859090999963, 1445.284584130841, 1446.5732608880405, 1449.8260208775225, 29161.85419072976, 29736.405271894873, 29906.8504657484, 30262.54606180953, 30283.848580756956, 50999.23501147411, 51544.96910061853, 51557.48442515527, 51747.0, 51934.22098668447, 488146.0, 489024.0, 489134.0, 490473.5476322738, 491480.0, 35322.76370327026, 35958.46062309015, 38686.8393948182, 39507.81476555708, 43359.9160021002, 41947.53183638558, 41967.370489443296, 42111.0, 43357.0, 43415.78292108519, 35023.824880875436, 35418.0, 35740.0, 36537.451938220416, 36980.89057328284, 35470.11324716903, 35474.82262588671, 36291.637083628826, 36356.45465318075, 36623.633763663085, 34944.82527587346, 35038.47442288419, 35305.29389412146, 35420.0, 35734.64265357417, 30486.0, 31593.21016974502, 32048.0, 32087.358252835278, 32126.83936580302, 23793.0, 23955.880220598785, 23981.0, 24316.27051188467, 24322.878385607957], "value": 19976.634040750385, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.75773020727155, 394.44580364587756, 397.7692938095903, 400.1876191331598, 426.3902619254467, 16075.276612552434, 19749.901250493745, 19823.801761982377, 21322.89338553307, 21399.67900481492, 20931.686024709605, 21004.57990840182, 21629.134834606597, 22159.00284487198, 22402.43993900149, 5708.857278568027, 5896.734646940877, 5905.557083218776, 5950.642961422307, 6011.188489553898, 4913.9189378336705, 5264.499872512105, 5465.906818636268, 5788.363280039192, 5847.678377689225, 4620.353150558924, 5714.914276285859, 5802.622829516089, 5810.651360918338, 5836.6789826559525, 5408.4591540845995, 5636.971815140898, 5802.12968054791, 5808.854778630526, 5821.214136091637, 4780.665353425262, 5634.830955071355, 5679.630823996427, 5691.231683722686, 5693.715314234313, 13493.392797324144, 13512.662183445394, 13608.523701670394, 13704.24626645534, 21349.82575958322, 2539.746025397464, 2567.7047139579, 2596.7143614202423, 2656.774174195196, 2710.945781084387, 9943.801123977551, 9991.200703943667, 10101.393916365041, 10395.94802025985, 10454.738631534197, 1768.018749593975, 1833.1567478959694, 1847.898365589892, 1849.9445016649522, 1869.5699989002605, 101528.0, 111011.44494277558, 113787.0, 121784.0, 122743.0, 11541.711457213469, 11804.645860624196, 11818.822717659243, 11831.408429578487, 11840.0, 13416.463341466231, 14043.71912561743, 15724.528264152093, 15743.291551879964, 15795.289211985488, 8031.598420078973, 8633.0, 8790.472571645721, 8795.604197811113, 9007.819843603222, 8591.65633374658, 8668.263197628272, 8671.869921951176, 8795.912040879637, 8818.911810881937, 4760.262159365304, 4846.80612775492, 4861.368022157168, 4865.343178670905, 4909.533594308607, 2023.099720624308, 2058.8147066764063, 2065.8450616203845, 2068.979310206879, 2071.306112452345, 398.69300638508184, 417.3781066211323, 427.9507856596469, 840.9075001749802, 881.9382643214914, 11942.164048516694, 12036.398180091135, 12045.457954392074, 12066.939665301792, 12279.2018518796, 454.3253268895687, 456.9885752856139, 459.6690382924289, 463.89098561837943, 470.4284294582031, 6095.939040609537, 6135.723892424851, 6149.84625384369, 6274.090256912813, 6279.497640188774, 738578.0, 747392.0, 753121.0, 762401.0, 773083.0, 124398.0, 156034.21982890012, 157953.0, 158135.0, 164562.1771891157, 441.5562359828352, 450.63723702419867, 966.6133546581283, 1036.6319956415514, 1043.0091413157531, 15141.924290378478, 18420.447386578424, 18551.2579496824, 19726.0, 19727.0, 55072.0, 55635.0, 56522.0, 57072.0, 57961.4203857956, 86626.0, 87044.5647771757, 88186.0, 89066.0, 90295.0, 7609.923900760921, 8045.235702608243, 8180.550069746221, 8522.957385213034, 8543.188397102265, 9132.634694612141, 11855.34795586251, 12402.25586464815, 12899.355032248537, 12903.741925161632, 10689.091427228772, 10757.9462102689, 10906.237348114888, 11037.724056898642, 11137.71676806269, 10855.131589472665, 10898.50956706966, 11031.83452248201, 11165.050970667584, 11284.492197851281, 10929.289596176222, 11253.1560132992, 11264.0425563828, 11296.152788541056, 11465.656030319104, 8200.343972482306, 8252.793680158044, 8388.245057944814, 8483.703070392507, 8566.0, 8097.987751531058, 8919.598618062073, 10888.45557722095, 11229.494672739584, 11284.830727539258], "value": 8971.457289747408, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.2881216173673, 1425.4013314407948, 1431.5848403962846, 1434.6054834920396, 1445.2123592642008, 6469.70886310116, 7579.734709285162, 8079.838403231932, 8537.573121343932, 8557.358198135142, 6895.896561551568, 8068.878966815502, 8312.584370781451, 8405.831883362329, 8445.873311900326, 2320.3155069254526, 2349.7415284318795, 2351.5532048910736, 2356.823238257129, 2369.277370402027, 2099.2442720620566, 2186.147402513021, 2324.721033475985, 2373.6558199061124, 2373.821963352747, 2255.086689890597, 2331.6619090231907, 2341.894614742332, 2343.1798870395396, 2345.3550273674705, 2311.1217737259817, 2323.8373313868037, 2329.1964272325936, 2338.7310459297228, 2345.0971376020184, 2312.8496647717843, 2360.9527809443716, 2365.219477572397, 2389.677393551883, 2391.186996421225, 8401.705940292122, 8429.32565394767, 8450.408471407003, 8474.576271186477, 8481.533515656636, 5069.239614057884, 5186.7147306898105, 5214.921776173361, 5217.530422262014, 5238.73806309683, 3325.1354647791504, 3542.1852973815908, 3555.377808883461, 3573.5175751273505, 3627.274545090966, 1178.8762179971152, 1213.332667033137, 1256.114439320277, 1260.823484712141, 1270.1553466944472, 10886.61896833607, 10918.836217456745, 10939.28894621847, 10941.343519388782, 10942.17933654971, 4623.144718227139, 4691.7184968901975, 4714.81140754366, 4779.4264688236935, 4784.091022705675, 9565.330426870192, 9618.134367906921, 9623.230141588656, 9629.229661627192, 9641.566129524048, 5210.505002024802, 5310.097283461821, 5334.973325133349, 5349.732513374316, 5352.812651557177, 4544.500104988449, 4826.938073623867, 4837.129316722953, 4878.219484882402, 4887.486813884562, 3890.922181556353, 3903.633728195166, 3970.980145099256, 4027.718059735849, 4053.5541090480024, 1117.5641499815079, 1191.1602320364123, 1236.8453943257093, 1264.8102784582386, 1319.162331919219, 859.909709480508, 880.6565439478609, 881.9162179592928, 895.4806212396794, 895.6654584668927, 5510.283663123849, 5521.950829342412, 5671.404502527175, 5677.545796336366, 5760.135979603093, 959.822432849911, 972.8589354543551, 979.3536266064364, 995.5320999130397, 1002.6190047781796, 3384.5430866833153, 3597.0827439002887, 3617.5116359291687, 3730.160713839419, 3799.3351163546267, 9725.56234969428, 10074.546645400975, 10076.244281678903, 10079.294449388472, 10100.797984040279, 8051.63767630458, 9405.90594094064, 9952.00479951999, 9954.104130628279, 10016.0, 7621.237876212445, 7846.176151504124, 7858.332041776399, 7875.173106823816, 7879.527228366202, 4568.588827005586, 5253.369595648546, 5348.1977703343255, 5480.972595136999, 5592.692401917933, 7776.572288524186, 9018.68434604812, 9065.048169942325, 9194.080591940752, 9307.301952353737, 8982.730518084469, 9259.953700231456, 9390.154886060287, 9475.005124461832, 9539.713808585753, 7070.186928503288, 7292.489525733148, 7302.306280903518, 7317.5609463432365, 7330.120385553768, 7258.491905566771, 7500.812479688051, 7821.256980586835, 7904.881426778488, 7907.446478746432, 5459.945400545944, 6783.423409010289, 6830.965845170742, 6845.14435695538, 6872.244053154049, 6666.699998499982, 6673.699683514351, 6697.564658297195, 6800.047993280846, 6849.212340580897, 6133.355997620186, 6140.324564298013, 6214.098955651496, 6219.751209951733, 6220.844478888064, 3825.2540754552597, 3925.0, 4490.685652004328, 4645.2335364665805, 4742.051589682146, 4540.523245059353, 4610.631149507964, 4751.619870410428, 4840.951590484191, 4848.369711937426], "value": 4383.552157921011, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.4814959018442, 325.76382122960854, 357.85685725709715, 364.9470826730124, 376.52557777200735, 4590.908181836361, 5135.4351021387665, 5148.304978827857, 5279.868003299919, 5321.920171197426, 3959.4456776051375, 5305.2942999070465, 5418.106012507941, 5425.810096646618, 5429.891402171954, 3229.6447390786993, 3787.924241515168, 4023.8792836214816, 4126.896827579305, 4140.544540100602, 3409.8124603146816, 3771.0006848185117, 3778.489903862971, 4125.546189919107, 4148.771817550033, 4090.8159132838946, 4092.815823287944, 4123.505179378479, 4129.442525259082, 4129.758139860211, 3537.8501986854376, 3766.435034744783, 4091.7954102294766, 4092.754434733896, 4131.400946862703, 3347.192516041335, 3426.648156840798, 3495.1087472694553, 3508.754387192872, 3509.6314886937016, 4875.561199492063, 5201.271821944931, 5214.426413094557, 5241.31862857826, 5300.24387318596, 4660.231061874787, 4663.60359369454, 4665.043666048452, 4708.646851486153, 4717.245240761462, 4689.616563113889, 5263.26314315996, 5671.801486947937, 5706.543476521868, 5708.571857110734, 3267.39553182662, 3899.2396482685886, 3903.8048097595292, 3905.9609403905883, 3908.2769687607883, 5029.597632189452, 5564.638298510584, 6016.78941237059, 6022.307434644984, 6038.456538911519, 3710.9443358349645, 3838.251540949544, 3950.0, 3961.861334853324, 3992.8203230854683, 3398.6261511233743, 3677.7793332400142, 3992.2215168042535, 4023.979880100581, 4028.576999415019, 3692.0, 4111.437653691638, 4331.350297455407, 4677.152524752772, 4729.9054018920115, 4929.0, 5349.973250133725, 5522.3649280333275, 5672.262605861211, 5702.0042984954935, 1176.9231153494457, 1256.1395444120624, 1300.8699130086916, 1305.8628843971437, 1311.5344052861287, 737.0896942276285, 823.0329362998452, 831.6132998155887, 868.8957325121025, 876.2114097312342, 4685.390899183084, 5120.667156634807, 5149.922751158736, 5157.767900444489, 5157.871053223699, 4807.4471435785335, 5653.381835625203, 5683.488486036276, 5704.375987045923, 5765.509931655773, 4323.4003418735265, 4439.800208990603, 4456.4652241730555, 4985.326980857611, 5112.539871411516, 2502.2359236738057, 2939.808912420686, 2978.9851050744605, 2986.0, 2990.6112205413156, 4748.19280722278, 5474.7262636868, 5576.909637291189, 5824.242848429762, 5868.799200299887, 4489.73061616304, 4943.737133491878, 5046.722430266371, 6035.400618836012, 6179.16581261524, 5679.290088738908, 5867.559933005042, 6104.816855494342, 6213.844653883599, 6259.405356491126, 4938.283948827472, 5968.910466342922, 5981.9401805983125, 6004.729787159501, 6030.276366835832, 4825.6139508839915, 5365.0, 5900.017488195365, 5915.112733090071, 5984.9401505986125, 6176.258848938156, 6179.5056395489155, 6234.345393733593, 6244.438000579969, 6260.280067792262, 3505.5267538881926, 3829.9617003829603, 3886.9805650971566, 4002.9985007496252, 4004.4794176756836, 5650.519705825051, 5715.514181294637, 5829.618821083846, 5840.007198776133, 5852.824415267549, 4634.629229661687, 5634.605577609528, 5787.652740835563, 5793.1323994622935, 5796.855078623068, 4381.780910954503, 4967.014747229652, 5762.884742305214, 5765.7693692253515, 5772.845430913918, 5431.696392865605, 5620.615919582732, 5683.261176047087, 5690.487856092972, 5698.31620205578, 5059.296432227387, 5638.209086502207, 5828.533717302521, 5862.677552734641, 5876.324222714272, 5325.786968521371, 5647.15292706081, 5692.0, 5704.8606772460325, 5763.337216220189], "value": 4106.826825509124, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.7585196885028, 732.9560226386417, 746.9990213114426, 814.6458072466852, 824.208759590793, 14347.928260358696, 15192.924035379807, 15310.923445382785, 15356.155411452366, 15363.924525283235, 13785.862141378584, 14156.71686566268, 14378.784318235208, 14399.78400323996, 14429.42282308709, 856.1566856646214, 866.9219770220678, 867.7526904832124, 870.1559487297311, 871.4335681806813, 691.1222747111166, 709.7303024850576, 767.57399643198, 849.7833052571585, 887.525174031893, 913.5569248914304, 930.4045410937006, 935.3031991166556, 936.2369668719972, 940.1773448232797, 932.370649811378, 933.5985526223722, 935.9797820375755, 937.7093101138669, 940.8165407745493, 697.8778713725078, 704.3519961635308, 705.5978092487285, 705.675389320913, 706.7597017014189, 14540.854591454055, 14982.101073935599, 15184.848151518565, 15313.387464501406, 15341.769873451907, 14199.503017394341, 14560.927195363955, 14568.344424500818, 14590.635234119125, 14598.34307456167, 11457.36984465854, 11664.708382290426, 11680.70798230051, 11733.589324373606, 11847.933685968304, 3238.6923242291946, 3716.1638631307737, 3717.8141092945243, 3732.4401339798974, 3881.0, 109037.0, 109980.4500977498, 110494.3425848613, 111162.0, 111628.0, 10929.781404372026, 10951.671449856518, 11125.777484450427, 11145.665630031112, 11365.829512557319, 23319.0, 23723.40691482727, 23739.643905341432, 23789.92945317465, 23899.7610023901, 7718.807029824299, 7767.495112817649, 7807.843843123219, 7882.684692612346, 7948.801279967932, 4008.498937632796, 4110.0135967368215, 4110.527289361702, 4112.856050038235, 4157.648764151662, 3587.7309201809967, 3695.2424752925585, 3708.2027364116843, 3824.0057585028094, 3956.9208615827524, 701.849102442967, 715.9856802863914, 723.4321057969469, 729.6607077708891, 731.8463122744176, 655.8458762190882, 668.2348710726192, 679.9762008329685, 684.7671791590883, 726.9927300727031, 10082.69751907444, 10126.341787783771, 10348.637797677045, 10355.068043876086, 10363.067323940732, 675.699313805352, 677.762783025937, 697.6442014572605, 700.3171907390254, 714.3749219432996, 4639.211334073216, 4795.246555096022, 4977.925331120036, 5061.164907790247, 5072.163093089673, 106992.0, 107874.46062769636, 107918.46040769746, 108273.0, 110105.44947275212, 91407.62888556677, 93756.53121734348, 94137.58793618101, 94277.0, 97148.0285197139, 70030.64984675044, 70401.0, 71102.64448677724, 72476.63761681158, 80389.79415308774, 9921.355111917703, 10722.73193170177, 10895.237333386587, 10999.285046471954, 11315.660530184108, 47506.28740568825, 48419.06323747151, 50274.0, 51218.0, 51896.48103519068, 50295.0, 58000.4199957995, 60550.0, 64046.0, 64791.0, 12534.310612916377, 12621.87378126207, 12726.490940362282, 12835.743285134058, 13437.596872093853, 14180.819850367496, 14190.858091418953, 14246.715065698836, 14434.494792682206, 14434.566962991126, 13025.804612931002, 13264.291961517009, 13291.136076155019, 13499.122557034154, 13793.793093103812, 13142.145760525535, 13543.661408464866, 13560.0, 14023.0, 14035.859641403455, 12930.418131184308, 12977.0, 13129.212247265195, 13162.802557961446, 13224.867751322363, 8843.0, 10832.0, 10938.289011214245, 11017.504212310305, 11261.436928153724, 10594.947025264824, 10731.946340268249, 10797.62208322705, 10944.179186560881, 10974.396408197626], "value": 7579.317790898763, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 121.0, 164.0, 116.0, 115.0, 118.0, 118.0, 117.0, 118.0, 116.0], "value": 120.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 112.0, 112.0, 146.0, 112.0, 115.0, 125.0, 145.0, 144.0, 114.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 201.0, 196.0, 200.0, 195.0, 194.0, 219.0, 280.0, 243.0, 196.0], "value": 212.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 67.0, 88.0, 98.0, 60.0, 60.0, 62.0, 76.0, 99.0, 83.0], "value": 77.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 87.0, 73.0, 70.0, 72.0, 80.0, 74.0, 106.0, 116.0], "value": 83.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 134.0, 88.0, 86.0, 110.0, 133.0, 88.0, 86.0, 88.0, 85.0], "value": 103.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 102.0, 98.0, 151.0, 152.0, 104.0, 154.0, 108.0, 152.0, 104.0], "value": 127.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 90.0, 93.0, 95.0, 93.0, 93.0, 95.0, 90.0, 110.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 62.0, 61.0, 63.0, 63.0, 63.0, 65.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 77.0, 86.0, 77.0, 69.0, 68.0, 69.0, 73.0, 70.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 83.0, 86.0, 84.0, 88.0, 86.0, 84.0, 86.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 154.0, 139.0, 139.0, 146.0, 145.0, 141.0, 140.0, 211.0, 187.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 239.0, 164.0, 215.0, 212.0, 169.0, 171.0, 202.0, 167.0, 169.0], "value": 190.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 83.0, 88.0, 87.0, 66.0, 68.0, 68.0, 66.0, 66.0, 69.0], "value": 73.1, "unit": "score"}]}]} 08:22:46 INFO - Return code: 0 08:22:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:22:46 ERROR - # TBPL SUCCESS # 08:22:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:22:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:22:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:22:46 INFO - 2017-02-22 08:22:46.329 screenresolution[1657:10328] starting screenresolution argv=screenresolution get 08:22:46 INFO - 2017-02-22 08:22:46.332 screenresolution[1657:10328] Display 0: 1600x1200x32@60 08:22:46 INFO - 2017-02-22 08:22:46.338 screenresolution[1658:10331] starting screenresolution argv=screenresolution list 08:22:46 INFO - Available Modes on Display 0 08:22:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:22:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:22:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:22:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:22:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:22:46 INFO - Intel Iris: 08:22:46 INFO - Chipset Model: Intel Iris 08:22:46 INFO - Type: GPU 08:22:46 INFO - Bus: Built-In 08:22:46 INFO - VRAM (Dynamic, Max): 1536 MB 08:22:46 INFO - Vendor: Intel (0x8086) 08:22:46 INFO - Device ID: 0x0a2e 08:22:46 INFO - Revision ID: 0x0009 08:22:46 INFO - Displays: 08:22:46 INFO - Display: 08:22:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:22:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:22:46 INFO - Display Serial Number: 1600x1200 60 08:22:46 INFO - Main Display: Yes 08:22:46 INFO - Mirror: Off 08:22:46 INFO - Online: Yes 08:22:46 INFO - Rotation: Supported 08:22:46 INFO - Return code: 0 08:22:46 INFO - Running post-action listener: _resource_record_post_action 08:22:46 INFO - [mozharness: 2017-02-22 16:22:46.574627Z] Finished run-tests step (success) 08:22:46 INFO - Running post-run listener: _resource_record_post_run 08:22:46 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 39664128; Write bytes: 512069632; Read time: 381; Write time: 1716 08:22:46 INFO - TinderboxPrint: CPU usage
54.3% 08:22:46 INFO - TinderboxPrint: I/O read bytes / time
39,664,128 / 381 08:22:46 INFO - TinderboxPrint: I/O write bytes / time
512,069,632 / 1,716 08:22:46 INFO - TinderboxPrint: CPU idle
2,191.2 (45.7%) 08:22:46 INFO - TinderboxPrint: CPU system
964.3 (20.1%) 08:22:46 INFO - TinderboxPrint: CPU user
1,634.3 (34.1%) 08:22:46 INFO - TinderboxPrint: Swap in / out
247,812,096 / 0 08:22:46 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 196016640; Write bytes: 188379136; Read time: 14795; Write time: 432 08:22:46 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 38730240; Write bytes: 300484608; Read time: 367; Write time: 1159 08:22:47 INFO - Running post-run listener: _upload_blobber_files 08:22:47 INFO - Blob upload gear active. 08:22:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:22:47 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 08:22:47 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'] 08:22:47 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 08:22:47 INFO - (blobuploader) - INFO - Open directory for files ... 08:22:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:22:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:22:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:48 INFO - (blobuploader) - INFO - Done attempting. 08:22:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:22:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:22:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:50 INFO - (blobuploader) - INFO - Done attempting. 08:22:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:22:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:22:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:51 INFO - (blobuploader) - INFO - Done attempting. 08:22:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:22:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:22:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:53 INFO - (blobuploader) - INFO - Done attempting. 08:22:53 INFO - (blobuploader) - INFO - Iteration through files over. 08:22:53 INFO - Return code: 0 08:22:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:22:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:22:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46a6c22b34ae76e730304d47724eabf06009f8bf032efed2118bfc99f9cbefb541bcd957688feec6cc47df4b14cd85749ad00246f1611ab98ef27a7d2c366441", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74f4464e3602e4b0f5f827040e77ae762206bc5cb9c163fbf3a03a00c58f1903a5e0cae523f46a3e128a49e1c583c49dcc2f6bf11d63310006c1831b1fe93c56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00b0f06197f8c83d495268f6aeeff5feef17cd9ac8f259f90f8dd85c621696b28413286c4fb0abc6910f4fef5d5742a990780c8de6697c0d4e05b9cd250018eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2d359dae59d4f13700dd04e0fff73313a86af1023ed60c0cf505ff4102a93d44cf35944ad48bcbb42aa684bbd5a9dd6fe39dccb9704acd24f63e7ce7735731d"} 08:22:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:22:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:22:53 INFO - Contents: 08:22:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46a6c22b34ae76e730304d47724eabf06009f8bf032efed2118bfc99f9cbefb541bcd957688feec6cc47df4b14cd85749ad00246f1611ab98ef27a7d2c366441", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74f4464e3602e4b0f5f827040e77ae762206bc5cb9c163fbf3a03a00c58f1903a5e0cae523f46a3e128a49e1c583c49dcc2f6bf11d63310006c1831b1fe93c56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00b0f06197f8c83d495268f6aeeff5feef17cd9ac8f259f90f8dd85c621696b28413286c4fb0abc6910f4fef5d5742a990780c8de6697c0d4e05b9cd250018eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2d359dae59d4f13700dd04e0fff73313a86af1023ed60c0cf505ff4102a93d44cf35944ad48bcbb42aa684bbd5a9dd6fe39dccb9704acd24f63e7ce7735731d"} 08:22:53 INFO - Running post-run listener: copy_logs_to_upload_dir 08:22:53 INFO - Copying logs to upload dir... 08:22:53 INFO - mkdir: /builds/slave/test/build/upload/logs 08:22:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.753014 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-22 08:22:53.438323) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 08:22:53.442025) ========= 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.8z3elPPQfl/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.gGH4zlYLE6/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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/46a6c22b34ae76e730304d47724eabf06009f8bf032efed2118bfc99f9cbefb541bcd957688feec6cc47df4b14cd85749ad00246f1611ab98ef27a7d2c366441", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74f4464e3602e4b0f5f827040e77ae762206bc5cb9c163fbf3a03a00c58f1903a5e0cae523f46a3e128a49e1c583c49dcc2f6bf11d63310006c1831b1fe93c56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00b0f06197f8c83d495268f6aeeff5feef17cd9ac8f259f90f8dd85c621696b28413286c4fb0abc6910f4fef5d5742a990780c8de6697c0d4e05b9cd250018eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2d359dae59d4f13700dd04e0fff73313a86af1023ed60c0cf505ff4102a93d44cf35944ad48bcbb42aa684bbd5a9dd6fe39dccb9704acd24f63e7ce7735731d"} build_url:https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009950 build_url: 'https://queue.taskcluster.net/v1/task/Sn0opTNLTCCzQfBG8G-jAw/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/46a6c22b34ae76e730304d47724eabf06009f8bf032efed2118bfc99f9cbefb541bcd957688feec6cc47df4b14cd85749ad00246f1611ab98ef27a7d2c366441", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74f4464e3602e4b0f5f827040e77ae762206bc5cb9c163fbf3a03a00c58f1903a5e0cae523f46a3e128a49e1c583c49dcc2f6bf11d63310006c1831b1fe93c56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00b0f06197f8c83d495268f6aeeff5feef17cd9ac8f259f90f8dd85c621696b28413286c4fb0abc6910f4fef5d5742a990780c8de6697c0d4e05b9cd250018eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2d359dae59d4f13700dd04e0fff73313a86af1023ed60c0cf505ff4102a93d44cf35944ad48bcbb42aa684bbd5a9dd6fe39dccb9704acd24f63e7ce7735731d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 08:22:53.471589) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:22:53.471912) ========= 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.8z3elPPQfl/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.gGH4zlYLE6/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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.005002 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:22:53.520851) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 08:22:53.521176) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 08:22:53.521555) ========= ========= Total master_lag: 0.17 =========