builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0098 starttime: 1484579398.72 results: success (0) buildid: 20170116055525 builduid: 4297465955b84599959df4d9ad5944c7 revision: 100c34ac81052ad03e9ea0bb68c66df175202280 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 07:09:58.722828) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 07:09:58.723497) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 07:09:58.723914) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 07:09:58.759362) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 07:09:58.759777) ========= 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.Cm3zIJ4qDV/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.VUnXXWBzNA/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-01-16 07:09:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.14M=0.001s 2017-01-16 07:09:59 (9.14 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.462188 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 07:09:59.250003) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 07:09:59.250505) ========= 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.Cm3zIJ4qDV/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.VUnXXWBzNA/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.026729 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 07:09:59.303218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-16 07:09:59.306621) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 100c34ac81052ad03e9ea0bb68c66df175202280 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 100c34ac81052ad03e9ea0bb68c66df175202280 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Cm3zIJ4qDV/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.VUnXXWBzNA/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-01-16 07:09:59,401 truncating revision to first 12 chars 2017-01-16 07:09:59,401 Setting DEBUG logging. 2017-01-16 07:09:59,401 attempt 1/10 2017-01-16 07:09:59,401 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/100c34ac8105?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-16 07:10:01,187 unpacking tar archive at: graphics-100c34ac8105/testing/mozharness/ program finished with exit code 0 elapsedTime=2.054871 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-16 07:10:01.387269) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 07:10:01.387762) ========= script_repo_revision: 100c34ac81052ad03e9ea0bb68c66df175202280 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 07:10:01.388347) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 07:10:01.388790) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 07:10:01.413822) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-16 07:10:01.414248) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Cm3zIJ4qDV/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.VUnXXWBzNA/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 07:10:01 INFO - MultiFileLogger online at 20170116 07:10:01 in /builds/slave/test 07:10:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 07:10:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:10:01 INFO - {'append_to_log': False, 07:10:01 INFO - 'base_work_dir': '/builds/slave/test', 07:10:01 INFO - 'blob_upload_branch': 'Graphics', 07:10:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:10:01 INFO - 'branch': 'Graphics', 07:10:01 INFO - 'buildbot_json_path': 'buildprops.json', 07:10:01 INFO - 'config_files': ('talos/mac_config.py',), 07:10:01 INFO - 'default_actions': ('clobber', 07:10:01 INFO - 'read-buildbot-config', 07:10:01 INFO - 'download-and-extract', 07:10:01 INFO - 'populate-webroot', 07:10:01 INFO - 'create-virtualenv', 07:10:01 INFO - 'install', 07:10:01 INFO - 'run-tests'), 07:10:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:10:01 INFO - 'download_minidump_stackwalk': True, 07:10:01 INFO - 'download_symbols': 'ondemand', 07:10:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:10:01 INFO - 'tooltool.py': '/tools/tooltool.py', 07:10:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:10:01 INFO - '/tools/misc-python/virtualenv.py')}, 07:10:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:10:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:10:01 INFO - 'installer_path': 'installer.exe', 07:10:01 INFO - 'log_level': 'info', 07:10:01 INFO - 'log_name': 'talos', 07:10:01 INFO - 'log_to_console': True, 07:10:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:10:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:10:01 INFO - 'opt_config_files': (), 07:10:01 INFO - 'pip_index': False, 07:10:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:10:01 INFO - 'cmd': ('bash', 07:10:01 INFO - '-c', 07:10:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:10:01 INFO - 'enabled': True, 07:10:01 INFO - 'halt_on_failure': False, 07:10:01 INFO - 'name': 'check_screen_resolution'},), 07:10:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:10:01 INFO - 'cmd': ('bash', 07:10:01 INFO - '-c', 07:10:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:10:01 INFO - 'enabled': True, 07:10:01 INFO - 'halt_on_failure': False, 07:10:01 INFO - 'name': 'check_screen_resolution'},), 07:10:01 INFO - 'run_cmd_checks_enabled': True, 07:10:01 INFO - 'sps_profile': False, 07:10:01 INFO - 'sps_profile_interval': 0, 07:10:01 INFO - 'suite': 'dromaeojs', 07:10:01 INFO - 'system_bits': '32', 07:10:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:10:01 INFO - 'title': 't-yosemite-r7-0098', 07:10:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:10:01 INFO - 'use_talos_json': True, 07:10:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:10:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:10:01 INFO - 'work_dir': 'build'} 07:10:01 INFO - [mozharness: 2017-01-16 15:10:01.623158Z] Running clobber step. 07:10:01 INFO - Running pre-action listener: _resource_record_pre_action 07:10:01 INFO - Running main action method: clobber 07:10:01 INFO - rmtree: /builds/slave/test/build 07:10:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:10:04 INFO - Running post-action listener: _resource_record_post_action 07:10:04 INFO - [mozharness: 2017-01-16 15:10:04.073675Z] Finished clobber step (success) 07:10:04 INFO - [mozharness: 2017-01-16 15:10:04.073804Z] Running read-buildbot-config step. 07:10:04 INFO - Running pre-action listener: _resource_record_pre_action 07:10:04 INFO - Running main action method: read_buildbot_config 07:10:04 INFO - Using buildbot properties: 07:10:04 INFO - { 07:10:04 INFO - "project": "", 07:10:04 INFO - "product": "firefox", 07:10:04 INFO - "script_repo_revision": "default", 07:10:04 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 07:10:04 INFO - "repository": "", 07:10:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 07:10:04 INFO - "buildid": "20170116055525", 07:10:04 INFO - "pgo_build": "False", 07:10:04 INFO - "basedir": "/builds/slave/test", 07:10:04 INFO - "buildnumber": 6, 07:10:04 INFO - "slavename": "t-yosemite-r7-0098", 07:10:04 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 07:10:04 INFO - "platform": "yosemite_r7", 07:10:04 INFO - "scheduler": "tests-graphics-macosx64-talos", 07:10:04 INFO - "branch": "graphics", 07:10:04 INFO - "repo_path": "projects/graphics", 07:10:04 INFO - "revision": "100c34ac81052ad03e9ea0bb68c66df175202280", 07:10:04 INFO - "stage_platform": "macosx64", 07:10:04 INFO - "builduid": "4297465955b84599959df4d9ad5944c7", 07:10:04 INFO - "slavebuilddir": "test" 07:10:04 INFO - } 07:10:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:10:04 INFO - Running post-action listener: _resource_record_post_action 07:10:04 INFO - [mozharness: 2017-01-16 15:10:04.077237Z] Finished read-buildbot-config step (success) 07:10:04 INFO - [mozharness: 2017-01-16 15:10:04.077373Z] Running download-and-extract step. 07:10:04 INFO - Running pre-action listener: _resource_record_pre_action 07:10:04 INFO - Running main action method: download_and_extract 07:10:04 INFO - mkdir: /builds/slave/test/build/tests 07:10:04 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')]} 07:10:04 INFO - trying https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:10:04 INFO - Downloading https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:10:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 07:10:04 INFO - Downloaded 1199 bytes. 07:10:04 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:10:04 INFO - Using the following test package requirements: 07:10:04 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:10:04 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:10:04 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:10:04 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:10:04 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:10:04 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:10:04 INFO - u'jsshell-mac.zip'], 07:10:04 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:10:04 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:10:04 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:10:04 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:10:04 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:10:04 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:10:04 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:10:04 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:10:04 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:10:04 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:10:04 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:10:04 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:10:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:10:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:10:04 INFO - Fetch https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:10:05 INFO - Expected file size: 16324398 07:10:05 INFO - Obtained file size: 16324398 07:10:12 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:10:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:10:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:10:12 INFO - Fetch https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:10:13 INFO - Expected file size: 16324398 07:10:13 INFO - Obtained file size: 16324398 07:10:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:10:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:10:19 INFO - Fetch https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:10:20 INFO - Expected file size: 14403463 07:10:20 INFO - Obtained file size: 14403463 07:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:20 INFO - trying https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:10:20 INFO - Downloading https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:10:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 07:10:22 INFO - Downloaded 70261478 bytes. 07:10:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:10:22 INFO - mkdir: /builds/slave/test/properties 07:10:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:10:22 INFO - Writing to file /builds/slave/test/properties/build_url 07:10:22 INFO - Contents: 07:10:22 INFO - build_url:https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:10:23 INFO - Running post-action listener: _resource_record_post_action 07:10:23 INFO - Running post-action listener: set_extra_try_arguments 07:10:23 INFO - [mozharness: 2017-01-16 15:10:23.352833Z] Finished download-and-extract step (success) 07:10:23 INFO - [mozharness: 2017-01-16 15:10:23.352953Z] Running populate-webroot step. 07:10:23 INFO - Running pre-action listener: _resource_record_pre_action 07:10:23 INFO - Running main action method: populate_webroot 07:10:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:10:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:10:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:10:23 INFO - '--tppagecycles', 07:10:23 INFO - '7'], 07:10:23 INFO - 'tests': ['tsvgm']}}, 07:10:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:10:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:10:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:10:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:10:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:10:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:10:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:10:23 INFO - 'talos_options': ['--disable-e10s'], 07:10:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:10:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:10:23 INFO - 'talos_options': ['--disable-e10s'], 07:10:23 INFO - 'tests': ['damp', 'tps']}, 07:10:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:10:23 INFO - 'tests': ['damp', 'tps']}, 07:10:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:10:23 INFO - 'tests': ['dromaeo_dom']}, 07:10:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:10:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:10:23 INFO - 'tests': ['basic_compositor_video']}, 07:10:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:10:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:10:23 INFO - 'tests': ['a11yr', 07:10:23 INFO - 'ts_paint', 07:10:23 INFO - 'tpaint', 07:10:23 INFO - 'sessionrestore', 07:10:23 INFO - 'sessionrestore_no_auto_restore', 07:10:23 INFO - 'tabpaint']}, 07:10:23 INFO - 'other-e10s': {'tests': ['a11yr', 07:10:23 INFO - 'ts_paint', 07:10:23 INFO - 'tpaint', 07:10:23 INFO - 'sessionrestore', 07:10:23 INFO - 'sessionrestore_no_auto_restore', 07:10:23 INFO - 'tabpaint']}, 07:10:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:10:23 INFO - 'ts_paint', 07:10:23 INFO - 'tpaint', 07:10:23 INFO - 'sessionrestore', 07:10:23 INFO - 'sessionrestore_no_auto_restore', 07:10:23 INFO - 'tabpaint']}, 07:10:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:10:23 INFO - 'ts_paint', 07:10:23 INFO - 'tpaint', 07:10:23 INFO - 'sessionrestore', 07:10:23 INFO - 'sessionrestore_no_auto_restore', 07:10:23 INFO - 'tabpaint']}, 07:10:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:10:23 INFO - 'tests': ['a11yr', 07:10:23 INFO - 'ts_paint', 07:10:23 INFO - 'tpaint', 07:10:23 INFO - 'sessionrestore', 07:10:23 INFO - 'sessionrestore_no_auto_restore', 07:10:23 INFO - 'tabpaint']}, 07:10:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:10:23 INFO - 'tests': ['a11yr', 07:10:23 INFO - 'ts_paint', 07:10:23 INFO - 'tpaint', 07:10:23 INFO - 'sessionrestore', 07:10:23 INFO - 'sessionrestore_no_auto_restore', 07:10:23 INFO - 'tabpaint']}, 07:10:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:10:23 INFO - 'tests': ['tsvgx', 07:10:23 INFO - 'tsvgr_opacity', 07:10:23 INFO - 'tart', 07:10:23 INFO - 'tscrollx', 07:10:23 INFO - 'cart', 07:10:23 INFO - 'tsvg_static']}, 07:10:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:10:23 INFO - 'tsvgr_opacity', 07:10:23 INFO - 'tart', 07:10:23 INFO - 'tscrollx', 07:10:23 INFO - 'cart', 07:10:23 INFO - 'tsvg_static']}, 07:10:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:10:23 INFO - 'talos_options': ['--disable-e10s'], 07:10:23 INFO - 'tests': ['tp5o']}, 07:10:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:10:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:10:23 INFO - 'talos_options': ['--disable-e10s', 07:10:23 INFO - '--xperf_path', 07:10:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:23 INFO - 'tests': ['tp5n']}, 07:10:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:10:23 INFO - 'talos_options': ['--xperf_path', 07:10:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:23 INFO - 'tests': ['tp5n']}}, 07:10:23 INFO - 'talos.zip': {'path': '', 07:10:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:10:23 INFO - Running post-action listener: _resource_record_post_action 07:10:23 INFO - [mozharness: 2017-01-16 15:10:23.371686Z] Finished populate-webroot step (success) 07:10:23 INFO - [mozharness: 2017-01-16 15:10:23.371816Z] Running create-virtualenv step. 07:10:23 INFO - Running pre-action listener: _resource_record_pre_action 07:10:23 INFO - Running main action method: create_virtualenv 07:10:23 INFO - Creating virtualenv /builds/slave/test/build/venv 07:10:23 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 07:10:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:10:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:10:23 INFO - Using real prefix '/tools/python27' 07:10:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:10:24 INFO - Installing distribute.............................................................................................................................................................................................done. 07:10:27 INFO - Installing pip.................done. 07:10:27 INFO - Return code: 0 07:10:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:10:27 INFO - Reading from file tmpfile_stdout 07:10:27 INFO - Output received: 07:10:27 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) 07:10:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:10: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')]} 07:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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')]} 07:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b695d30>, '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 0x10b5bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68abe8>, '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.Cm3zIJ4qDV/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.VUnXXWBzNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 07:10: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', 'pip>=1.5'] in /builds/slave/test/build 07:10: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 pip>=1.5 07:10:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cm3zIJ4qDV/Render', 07:10:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:27 INFO - 'HOME': '/Users/cltbld', 07:10:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:27 INFO - 'LOGNAME': 'cltbld', 07:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:27 INFO - 'MOZ_NO_REMOTE': '1', 07:10:27 INFO - 'NO_EM_RESTART': '1', 07:10:27 INFO - 'PAGER': '/bin/cat', 07:10:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:27 INFO - 'PWD': '/builds/slave/test', 07:10:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:27 INFO - 'SHELL': '/bin/bash', 07:10:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUnXXWBzNA/Listeners', 07:10:27 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 07:10:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:27 INFO - 'USER': 'cltbld', 07:10:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:27 INFO - 'XPC_FLAGS': '0x0', 07:10:27 INFO - 'XPC_SERVICE_NAME': '0', 07:10:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:27 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 07:10:27 INFO - Cleaning up... 07:10:27 INFO - Return code: 0 07:10:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:10: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')]} 07:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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')]} 07:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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', '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 0x10b8b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b695d30>, '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 0x10b5bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68abe8>, '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.Cm3zIJ4qDV/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.VUnXXWBzNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 07:10: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:10: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 psutil>=3.1.1 07:10:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cm3zIJ4qDV/Render', 07:10:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:27 INFO - 'HOME': '/Users/cltbld', 07:10:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:27 INFO - 'LOGNAME': 'cltbld', 07:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:27 INFO - 'MOZ_NO_REMOTE': '1', 07:10:27 INFO - 'NO_EM_RESTART': '1', 07:10:27 INFO - 'PAGER': '/bin/cat', 07:10:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:27 INFO - 'PWD': '/builds/slave/test', 07:10:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:27 INFO - 'SHELL': '/bin/bash', 07:10:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUnXXWBzNA/Listeners', 07:10:27 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 07:10:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:27 INFO - 'USER': 'cltbld', 07:10:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:27 INFO - 'XPC_FLAGS': '0x0', 07:10:27 INFO - 'XPC_SERVICE_NAME': '0', 07:10:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:27 INFO - Downloading/unpacking psutil>=3.1.1 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:10:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:32 INFO - Installing collected packages: psutil 07:10:32 INFO - Running setup.py install for psutil 07:10:32 INFO - building 'psutil._psutil_osx' extension 07:10:32 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 07:10:32 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 07:10:32 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 07:10:32 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 07:10:33 INFO - building 'psutil._psutil_posix' extension 07:10:33 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 07:10:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:10:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:10:33 INFO - ^ 07:10:33 INFO - 1 warning generated. 07:10:33 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 07:10:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:33 INFO - Successfully installed psutil 07:10:33 INFO - Cleaning up... 07:10:33 INFO - Return code: 0 07:10:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b695d30>, '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 0x10b5bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68abe8>, '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.Cm3zIJ4qDV/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.VUnXXWBzNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 07:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:10:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cm3zIJ4qDV/Render', 07:10:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:33 INFO - 'HOME': '/Users/cltbld', 07:10:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:33 INFO - 'LOGNAME': 'cltbld', 07:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:33 INFO - 'MOZ_NO_REMOTE': '1', 07:10:33 INFO - 'NO_EM_RESTART': '1', 07:10:33 INFO - 'PAGER': '/bin/cat', 07:10:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:33 INFO - 'PWD': '/builds/slave/test', 07:10:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:33 INFO - 'SHELL': '/bin/bash', 07:10:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUnXXWBzNA/Listeners', 07:10:33 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 07:10:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:33 INFO - 'USER': 'cltbld', 07:10:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:33 INFO - 'XPC_FLAGS': '0x0', 07:10:33 INFO - 'XPC_SERVICE_NAME': '0', 07:10:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:10:36 INFO - Installing collected packages: mozsystemmonitor 07:10:36 INFO - Running setup.py install for mozsystemmonitor 07:10:36 INFO - Successfully installed mozsystemmonitor 07:10:36 INFO - Cleaning up... 07:10:36 INFO - Return code: 0 07:10:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:10: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')]} 07:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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')]} 07:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:36 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 0x10b8b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b695d30>, '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 0x10b5bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68abe8>, '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.Cm3zIJ4qDV/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.VUnXXWBzNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 07:10:36 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 07:10:36 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 07:10:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cm3zIJ4qDV/Render', 07:10:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:36 INFO - 'HOME': '/Users/cltbld', 07:10:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:36 INFO - 'LOGNAME': 'cltbld', 07:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:36 INFO - 'MOZ_NO_REMOTE': '1', 07:10:36 INFO - 'NO_EM_RESTART': '1', 07:10:36 INFO - 'PAGER': '/bin/cat', 07:10:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:36 INFO - 'PWD': '/builds/slave/test', 07:10:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:36 INFO - 'SHELL': '/bin/bash', 07:10:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUnXXWBzNA/Listeners', 07:10:36 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 07:10:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:36 INFO - 'USER': 'cltbld', 07:10:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:36 INFO - 'XPC_FLAGS': '0x0', 07:10:36 INFO - 'XPC_SERVICE_NAME': '0', 07:10:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:36 INFO - Downloading/unpacking jsonschema==2.5.1 07:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:10:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:10:39 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 07:10:39 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 07:10:39 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 07:10:39 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 07:10:39 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 07:10:39 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 07:10:39 INFO - Downloading functools32-3.2.3-2.tar.gz 07:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:10:39 INFO - warning: no files found matching '*.txt' 07:10:39 INFO - no previously-included directories found matching 'build' 07:10:39 INFO - no previously-included directories found matching 'dist' 07:10:39 INFO - no previously-included directories found matching '.git*' 07:10:39 INFO - Installing collected packages: jsonschema, functools32 07:10:40 INFO - Running setup.py install for functools32 07:10:40 INFO - warning: no files found matching '*.txt' 07:10:40 INFO - no previously-included directories found matching 'build' 07:10:40 INFO - no previously-included directories found matching 'dist' 07:10:40 INFO - no previously-included directories found matching '.git*' 07:10:40 INFO - Successfully installed jsonschema functools32 07:10:40 INFO - Cleaning up... 07:10:40 INFO - Return code: 0 07:10:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b8b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b695d30>, '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 0x10b5bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68abe8>, '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.Cm3zIJ4qDV/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.VUnXXWBzNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 07:10:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:10:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cm3zIJ4qDV/Render', 07:10:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:40 INFO - 'HOME': '/Users/cltbld', 07:10:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:40 INFO - 'LOGNAME': 'cltbld', 07:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:40 INFO - 'MOZ_NO_REMOTE': '1', 07:10:40 INFO - 'NO_EM_RESTART': '1', 07:10:40 INFO - 'PAGER': '/bin/cat', 07:10:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:40 INFO - 'PWD': '/builds/slave/test', 07:10:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:40 INFO - 'SHELL': '/bin/bash', 07:10:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUnXXWBzNA/Listeners', 07:10:40 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 07:10:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:40 INFO - 'USER': 'cltbld', 07:10:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:40 INFO - 'XPC_FLAGS': '0x0', 07:10:40 INFO - 'XPC_SERVICE_NAME': '0', 07:10:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:10:40 INFO - Cleaning up... 07:10:40 INFO - Return code: 0 07:10:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b8b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b695d30>, '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 0x10b5bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68abe8>, '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.Cm3zIJ4qDV/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.VUnXXWBzNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 07:10:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:10:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cm3zIJ4qDV/Render', 07:10:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:40 INFO - 'HOME': '/Users/cltbld', 07:10:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:40 INFO - 'LOGNAME': 'cltbld', 07:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:40 INFO - 'MOZ_NO_REMOTE': '1', 07:10:40 INFO - 'NO_EM_RESTART': '1', 07:10:40 INFO - 'PAGER': '/bin/cat', 07:10:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:40 INFO - 'PWD': '/builds/slave/test', 07:10:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:40 INFO - 'SHELL': '/bin/bash', 07:10:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUnXXWBzNA/Listeners', 07:10:40 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 07:10:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:40 INFO - 'USER': 'cltbld', 07:10:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:40 INFO - 'XPC_FLAGS': '0x0', 07:10:40 INFO - 'XPC_SERVICE_NAME': '0', 07:10:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:40 INFO - Downloading/unpacking blobuploader==1.2.4 07:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:43 INFO - Downloading blobuploader-1.2.4.tar.gz 07:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:10:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:10:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10:44 INFO - Downloading docopt-0.6.1.tar.gz 07:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:10:44 INFO - Installing collected packages: blobuploader, requests, docopt 07:10:44 INFO - Running setup.py install for blobuploader 07:10:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:10:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:10:44 INFO - Running setup.py install for requests 07:10:45 INFO - Running setup.py install for docopt 07:10:45 INFO - Successfully installed blobuploader requests docopt 07:10:45 INFO - Cleaning up... 07:10:45 INFO - Return code: 0 07:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:45 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 0x10b8b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b695d30>, '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 0x10b5bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68abe8>, '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.Cm3zIJ4qDV/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.VUnXXWBzNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 07:10:45 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 07:10:45 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 07:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cm3zIJ4qDV/Render', 07:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:45 INFO - 'HOME': '/Users/cltbld', 07:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:45 INFO - 'LOGNAME': 'cltbld', 07:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:45 INFO - 'MOZ_NO_REMOTE': '1', 07:10:45 INFO - 'NO_EM_RESTART': '1', 07:10:45 INFO - 'PAGER': '/bin/cat', 07:10:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:45 INFO - 'PWD': '/builds/slave/test', 07:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:45 INFO - 'SHELL': '/bin/bash', 07:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUnXXWBzNA/Listeners', 07:10:45 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 07:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:45 INFO - 'USER': 'cltbld', 07:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:45 INFO - 'XPC_FLAGS': '0x0', 07:10:45 INFO - 'XPC_SERVICE_NAME': '0', 07:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:45 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-Vn3qBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:45 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-OavHXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-XdSccj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-TZwdNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-pB5eHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-xn_zWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-BYYjEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-_HsEEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-KN0zVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-O8BCOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-MgQd8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-6QFE3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-iCy1qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-dQqfwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-Eec39X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-f9yN9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-1JLeZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:10:47 INFO - Running setup.py install for manifestparser 07:10:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:10:47 INFO - Running setup.py install for mozcrash 07:10:47 INFO - Running setup.py install for mozdebug 07:10:47 INFO - Running setup.py install for mozdevice 07:10:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:10:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:10:48 INFO - Running setup.py install for mozfile 07:10:48 INFO - Running setup.py install for mozhttpd 07:10:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:10:48 INFO - Running setup.py install for mozinfo 07:10:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:10:48 INFO - Running setup.py install for mozInstall 07:10:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:10:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:10:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:10:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:10:48 INFO - Running setup.py install for mozleak 07:10:48 INFO - Running setup.py install for mozlog 07:10:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:10:49 INFO - Running setup.py install for moznetwork 07:10:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:10:49 INFO - Running setup.py install for mozprocess 07:10:49 INFO - Running setup.py install for mozprofile 07:10:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:10:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:10:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:10:49 INFO - Running setup.py install for mozrunner 07:10:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:10:49 INFO - Running setup.py install for mozscreenshot 07:10:49 INFO - Running setup.py install for moztest 07:10:49 INFO - Running setup.py install for mozversion 07:10:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:10:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:10:50 INFO - Cleaning up... 07:10:50 INFO - Return code: 0 07:10:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:50 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')]} 07:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:50 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')]} 07:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:50 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 0x10b8b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b695d30>, '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 0x10b5bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68abe8>, '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.Cm3zIJ4qDV/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.VUnXXWBzNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 07:10:50 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 07:10:50 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 07:10:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cm3zIJ4qDV/Render', 07:10:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:50 INFO - 'HOME': '/Users/cltbld', 07:10:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:50 INFO - 'LOGNAME': 'cltbld', 07:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:50 INFO - 'MOZ_NO_REMOTE': '1', 07:10:50 INFO - 'NO_EM_RESTART': '1', 07:10:50 INFO - 'PAGER': '/bin/cat', 07:10:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:50 INFO - 'PWD': '/builds/slave/test', 07:10:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:50 INFO - 'SHELL': '/bin/bash', 07:10:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUnXXWBzNA/Listeners', 07:10:50 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 07:10:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:50 INFO - 'USER': 'cltbld', 07:10:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:50 INFO - 'XPC_FLAGS': '0x0', 07:10:50 INFO - 'XPC_SERVICE_NAME': '0', 07:10:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:50 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-_ZVbkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:50 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)) 07:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:50 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-cqzi5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:50 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)) 07:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:50 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-TrvClX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:50 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)) 07:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:50 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-RHmhj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:50 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)) 07:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:50 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-yEeZ12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:50 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)) 07:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:50 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-bPmMlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:51 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)) 07:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-DzJCxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:51 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)) 07:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-mUneyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:51 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)) 07:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-PHUD6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:51 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)) 07:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-rSxFVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:51 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)) 07:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-nLXwOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:51 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)) 07:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-xtEps5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:51 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)) 07:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-Wf9tOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:51 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)) 07:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-UpWiQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:51 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)) 07:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:51 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-BpQNqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:52 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-_T0hLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:52 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)) 07:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:52 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-FX1Zuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:52 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)) 07:10:52 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)) 07:10:52 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)) 07:10:52 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)) 07:10:52 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)) 07:10:52 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)) 07:10:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:54 INFO - Downloading blessings-1.6.tar.gz 07:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:10:54 INFO - Installing collected packages: blessings 07:10:54 INFO - Running setup.py install for blessings 07:10:55 INFO - Successfully installed blessings 07:10:55 INFO - Cleaning up... 07:10:55 INFO - Return code: 0 07:10:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:10:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:55 INFO - Reading from file tmpfile_stdout 07:10:55 INFO - Current package versions: 07:10:55 INFO - blessings == 1.6 07:10:55 INFO - blobuploader == 1.2.4 07:10:55 INFO - docopt == 0.6.1 07:10:55 INFO - functools32 == 3.2.3-2 07:10:55 INFO - jsonschema == 2.5.1 07:10:55 INFO - manifestparser == 1.1 07:10:55 INFO - mozInstall == 1.12 07:10:55 INFO - mozcrash == 1.0 07:10:55 INFO - mozdebug == 0.1 07:10:55 INFO - mozdevice == 0.49 07:10:55 INFO - mozfile == 1.2 07:10:55 INFO - mozhttpd == 0.7 07:10:55 INFO - mozinfo == 0.9 07:10:55 INFO - mozleak == 0.1 07:10:55 INFO - mozlog == 3.4 07:10:55 INFO - moznetwork == 0.27 07:10:55 INFO - mozprocess == 0.24 07:10:55 INFO - mozprofile == 0.28 07:10:55 INFO - mozrunner == 6.13 07:10:55 INFO - mozscreenshot == 0.1 07:10:55 INFO - mozsystemmonitor == 0.3 07:10:55 INFO - moztest == 0.8 07:10:55 INFO - mozversion == 1.4 07:10:55 INFO - psutil == 3.1.1 07:10:55 INFO - requests == 1.2.3 07:10:55 INFO - wsgiref == 0.1.2 07:10:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:55 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 0x10b8b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b695d30>, '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 0x10b5bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68abe8>, '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.Cm3zIJ4qDV/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.VUnXXWBzNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 07:10:55 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 07:10:55 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 07:10:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cm3zIJ4qDV/Render', 07:10:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:55 INFO - 'HOME': '/Users/cltbld', 07:10:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:55 INFO - 'LOGNAME': 'cltbld', 07:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:55 INFO - 'MOZ_NO_REMOTE': '1', 07:10:55 INFO - 'NO_EM_RESTART': '1', 07:10:55 INFO - 'PAGER': '/bin/cat', 07:10:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:55 INFO - 'PWD': '/builds/slave/test', 07:10:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:55 INFO - 'SHELL': '/bin/bash', 07:10:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUnXXWBzNA/Listeners', 07:10:55 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 07:10:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:55 INFO - 'USER': 'cltbld', 07:10:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:55 INFO - 'XPC_FLAGS': '0x0', 07:10:55 INFO - 'XPC_SERVICE_NAME': '0', 07:10:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:55 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)) 07:10:55 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)) 07:10:55 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)) 07:10:55 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)) 07:10:55 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)) 07:10:55 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)) 07:10:55 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)) 07:10:55 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)) 07:10:55 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)) 07:10:55 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)) 07:10:55 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)) 07:10:55 INFO - Cleaning up... 07:10:55 INFO - Return code: 0 07:10:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814969a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b695d30>, '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 0x10b5bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68abe8>, '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.Cm3zIJ4qDV/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.VUnXXWBzNA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 07:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:10:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cm3zIJ4qDV/Render', 07:10:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:55 INFO - 'HOME': '/Users/cltbld', 07:10:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:55 INFO - 'LOGNAME': 'cltbld', 07:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:55 INFO - 'MOZ_NO_REMOTE': '1', 07:10:55 INFO - 'NO_EM_RESTART': '1', 07:10:55 INFO - 'PAGER': '/bin/cat', 07:10:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:55 INFO - 'PWD': '/builds/slave/test', 07:10:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:55 INFO - 'SHELL': '/bin/bash', 07:10:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUnXXWBzNA/Listeners', 07:10:55 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 07:10:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:55 INFO - 'USER': 'cltbld', 07:10:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:55 INFO - 'XPC_FLAGS': '0x0', 07:10:55 INFO - 'XPC_SERVICE_NAME': '0', 07:10:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:10:55 INFO - Cleaning up... 07:10:55 INFO - Return code: 0 07:10:55 INFO - Running post-action listener: _resource_record_post_action 07:10:55 INFO - Running post-action listener: _start_resource_monitoring 07:10:56 INFO - Starting resource monitoring. 07:10:56 INFO - [mozharness: 2017-01-16 15:10:56.025007Z] Finished create-virtualenv step (success) 07:10:56 INFO - [mozharness: 2017-01-16 15:10:56.025959Z] Running install step. 07:10:56 INFO - Running pre-action listener: _resource_record_pre_action 07:10:56 INFO - Running main action method: install 07:10:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:56 INFO - Reading from file tmpfile_stdout 07:10:56 INFO - Detecting whether we're running mozinstall >=1.0... 07:10:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:10:56 INFO - Reading from file tmpfile_stdout 07:10:56 INFO - Output received: 07:10:56 INFO - Usage: mozinstall [options] installer 07:10:56 INFO - Options: 07:10:56 INFO - -h, --help show this help message and exit 07:10:56 INFO - -d DEST, --destination=DEST 07:10:56 INFO - Directory to install application into. [default: 07:10:56 INFO - "/builds/slave/test"] 07:10:56 INFO - --app=APP Application being installed. [default: firefox] 07:10:56 INFO - mkdir: /builds/slave/test/build/application 07:10:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:11:18 INFO - Reading from file tmpfile_stdout 07:11:18 INFO - Output received: 07:11:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:11:18 INFO - Running post-action listener: _resource_record_post_action 07:11:18 INFO - [mozharness: 2017-01-16 15:11:18.461359Z] Finished install step (success) 07:11:18 INFO - [mozharness: 2017-01-16 15:11:18.461490Z] Running run-tests step. 07:11:18 INFO - Running pre-action listener: _resource_record_pre_action 07:11:18 INFO - Running main action method: run_tests 07:11:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:11:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:11:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:11:18 INFO - 2017-01-16 07:11:18.475 screenresolution[1636:8793] starting screenresolution argv=screenresolution get 07:11:18 INFO - 2017-01-16 07:11:18.478 screenresolution[1636:8793] Display 0: 1600x1200x32@60 07:11:18 INFO - 2017-01-16 07:11:18.484 screenresolution[1637:8796] starting screenresolution argv=screenresolution list 07:11:18 INFO - Available Modes on Display 0 07:11:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:11:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:11:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:11:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:11:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:11:18 INFO - Intel Iris: 07:11:18 INFO - Chipset Model: Intel Iris 07:11:18 INFO - Type: GPU 07:11:18 INFO - Bus: Built-In 07:11:18 INFO - VRAM (Dynamic, Max): 1536 MB 07:11:18 INFO - Vendor: Intel (0x8086) 07:11:18 INFO - Device ID: 0x0a2e 07:11:18 INFO - Revision ID: 0x0009 07:11:18 INFO - Displays: 07:11:18 INFO - Display: 07:11:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:11:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:11:18 INFO - Display Serial Number: 1600x1200 60 07:11:18 INFO - Main Display: Yes 07:11:18 INFO - Mirror: Off 07:11:18 INFO - Online: Yes 07:11:18 INFO - Rotation: Supported 07:11:18 INFO - Return code: 0 07:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:11:18 INFO - Python 2.7.3 07:11:18 INFO - Return code: 0 07:11:18 INFO - grabbing minidump binary from tooltool 07:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:18 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 0x10b695d30>, '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 0x10b5bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:11:18 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 07:11:18 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 07:11:18 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 07:11:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:11:18 INFO - Return code: 0 07:11:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:11:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:11:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:11:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:11:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0098', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0098 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:11:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cm3zIJ4qDV/Render', 07:11:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:18 INFO - 'HOME': '/Users/cltbld', 07:11:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:18 INFO - 'LOGNAME': 'cltbld', 07:11:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:11:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:18 INFO - 'MOZ_NO_REMOTE': '1', 07:11:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:11:18 INFO - 'NO_EM_RESTART': '1', 07:11:18 INFO - 'PAGER': '/bin/cat', 07:11:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:18 INFO - 'PWD': '/builds/slave/test', 07:11:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:11:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:18 INFO - 'SHELL': '/bin/bash', 07:11:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUnXXWBzNA/Listeners', 07:11:18 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 07:11:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:18 INFO - 'USER': 'cltbld', 07:11:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:18 INFO - 'XPC_FLAGS': '0x0', 07:11:18 INFO - 'XPC_SERVICE_NAME': '0', 07:11:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0098', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:11:19 INFO - mozversion application_buildid: 20170116055525 07:11:19 INFO - mozversion application_changeset: 100c34ac81052ad03e9ea0bb68c66df175202280 07:11:19 INFO - mozversion application_display_name: Nightly 07:11:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:11:19 INFO - mozversion application_name: Firefox 07:11:19 INFO - mozversion application_remotingname: firefox 07:11:19 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 07:11:19 INFO - mozversion application_vendor: Mozilla 07:11:19 INFO - mozversion application_version: 53.0a1 07:11:19 INFO - mozversion platform_buildid: 20170116055525 07:11:19 INFO - mozversion platform_changeset: 100c34ac81052ad03e9ea0bb68c66df175202280 07:11:19 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 07:11:19 INFO - mozversion platform_version: 53.0a1 07:11:19 INFO - using testdate: 1484579479 07:11:19 INFO - actual date: 1484579479 07:11:19 INFO - starting webserver on 'localhost:49242' 07:11:19 INFO - SUITE-START | Running 2 tests 07:11:19 INFO - TEST-START | dromaeo_css 07:11:19 INFO - operating with platform_type : mac_ 07:11:19 INFO - Initialising browser for dromaeo_css test... 07:11:19 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpy4xUuD/profile http://localhost:49242/getInfo.html) 07:11:21 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 07:11:21 INFO - PROCESS | 1647 | colorDepth:24 07:11:21 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 07:11:21 INFO - PROCESS | 1647 | __metrics 07:11:21 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:11:21 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:11:22 INFO - TEST-INFO | 1647: exit 0 07:11:22 INFO - Browser initialized. 07:11:22 INFO - Running cycle 1/1 for dromaeo_css test... 07:11:22 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpy4xUuD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:34 INFO - PROCESS | 1650 | RSS: Main: 235077632 07:11:34 INFO - PROCESS | 1650 | 07:14:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 07:14:39 INFO - PROCESS | 1650 | RSS: Main: 351182848 07:14:39 INFO - PROCESS | 1650 | 07:16:23 INFO - PROCESS | 1650 | ************************* 07:16:23 INFO - PROCESS | 1650 | A coding exception was thrown and uncaught in a Task. 07:16:23 INFO - PROCESS | 1650 | 07:16:23 ERROR - PROCESS | 1650 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:16:23 INFO - PROCESS | 1650 | Full stack: 07:16:23 INFO - PROCESS | 1650 | ************************* 07:17:42 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 07:17:43 INFO - PROCESS | 1650 | RSS: Main: 366485504 07:17:43 INFO - PROCESS | 1650 | 07:20:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 07:20:46 INFO - PROCESS | 1650 | RSS: Main: 341532672 07:20:46 INFO - PROCESS | 1650 | 07:23:48 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 07:23:49 INFO - PROCESS | 1650 | RSS: Main: 336125952 07:23:49 INFO - PROCESS | 1650 | 07:26:53 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 07:26:53 INFO - PROCESS | 1650 | RSS: Main: 330059776 07:26:53 INFO - PROCESS | 1650 | 07:29:56 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 07:29:56 INFO - PROCESS | 1650 | RSS: Main: 425447424 07:29:56 INFO - PROCESS | 1650 | 07:29:56 INFO - PROCESS | 1650 | __start_tp_report 07:29:56 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 07:29:56 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 07:29:56 INFO - PROCESS | 1650 | |i|pagename|runs| 07:29:56 INFO - PROCESS | 1650 | |0;dojo.html;3113.470709979303;3334.3998080345527;3341.3150304187643;3342.231286804036;3390.64398238185;4847.733374664392;5555.527780138693;5647.915281270779;5651.971740141294;5690.51630611398;5647.322321321447;5662.745176467059;5695.373508914026;5704.429557044294;5707.65754054756;5190.8702282443055;5230.293910322115;5263.289455923459;5266.52601265886;5285.762140703678;5136.8972620547565;5299.814506492274;5318.494742999409;5318.787248510055;5319.148936170213;5260.789568417259;5291.968066227088;5303.814366497154;5304.336957880265;5307.840764777063;5119.10415677255;5157.767900444489;5160.974195129038;5279.86800329991;5284.022455845681;5160.174372100483;5178.689278643255;5219.060569097561;5261.210818377236;5266;5691.8292451226525;5727.684977326246;5736.053551164053;5761.423857614247;5763.106718458604;6294;6306.779262725829;6317.147185129995;6318.273398559132;6326.177596912418;6134.632471123831;6176.536759742992;6203.875922481525;6301.747930082791;6305.464035556983;4896.975515122473;5872.412758724179;5900.350961394201;5915.792947246911;5943.821685349447;6215.627062376272;6287.591306565058;6308.432241098323;6310.779122730774;6333.588316759396;6032.607880487842;6083.148359229712;6089.48239399656;6207.751689932352;6229.813105606839;6192;6239.06414037898;6268.874622507525;6324.936750632527;6337.714802833883;6130.386961303834;6133.365267548864;6245.75016999324;6268.153799237045;6268.968655156695;6109.694515274218;6204.286507051746;6252.218472690914;6276.748930042839;6324.841878953063;4894.486078961729;5001.549860512571;5008.57427118699;5009.774560144802;5039.042581909425;3700.5374328208973;4409.647228221735;4422.159789639958;4428.31361139024;4470;5785.942140578624;5794.0439827428845;5794.507466865363;5803.912941305884;5819.301683797887;6318.4313411793155;6323.968380158161;6332.651704156224;6342.365763423621;6348.968255158787;5618.4662457066515;5667.1782591524825;5678.829635110871;5709.714514274269;5783;5434.809781657623;5452.154915987949;5458.372287186945;5503.724813759376;5515.420880807537;6310.7475700971445;6316.778912738032;6324.525660575568;6328.430441260124;6333.778317758856;6158.353372895782;6197.225346831646;6218.595791273553;6338.841528961812;6349.555531112777;5304.23088652151;6240.063990401476;6279.1209230708655;6306.590071645328;6318.715657795502;6238.968805155945;6242.875142497215;6252.968735156477;6271.937280627318;6279.434850863444;5315.2292917525965;6150.723217455135;6288.339724329063;6342.429181373698;6355.650439225887;4780.211265141213;6029.457348838626;6114.723190878535;6126.5711400203345;6128.080787881853;6176.474999625082;6177.536684748572;6181.660008699565;6189.288231853395;6191.659458729813;4939.234418665113;5834.795782147605;5901.996660567628;5907.084401917709;6038.124471951454;6032.245969253843;6195.96902015487;6210.441060304594;6215.254169499689;6223.37766223374;5837.6497410153825;5894.498967587803;5901.380355062656;5988.760449581968;5990.131430942576 07:29:56 INFO - PROCESS | 1650 | |1;ext.html;477.9713217206968;496.1317694035438;497.89793092416056;499.3608181527641;502.32688197814934;29561.55657665137;38496.230075398475;43477.91305217371;43613.56386436135;43625;44144;44518.55481445185;44548.3317750234;44562.440314588996;44576;8334.166583341677;9257.53712314385;9492;9492.098250666175;9510.191633711143;8355.749327520183;9651.855222171673;11231.719207019809;11470.885291147066;11644.068474522019;11268.211225214238;11281;11384.260023098514;11396.601118960838;11474.311541307507;8397.496150231005;8631.611577479029;11390.03184729299;11472.885271147265;11483.942580287045;11052.557897684082;11357.920997505224;11364.715882102932;11560.364179970098;11567.595134170348;42413;42699.57300426987;42776.3583546247;42849;42875;4048.332025215836;4055.3916912463073;4061.512618485771;4084.65280451162;4143.81352839123;29952.40095198084;30250;31482.527762083588;31515.054548363587;31519.527207091684;3112.548680441346;3187.0757480330676;3258.5112233164978;3285.178705323669;3342.7660063795543;494641.52679236734;495621;495708;496165;500339.99999999633;64248.67875660592;64501.354986450475;64587.03119453212;64616;64778;69766;69978;69985.60028799395;70247.2975270251;70275.94586081213;16116.516504504883;16396.590085247964;16402.343906243615;16410;16420.425285114965;11212.831807522894;11554.42227888619;11556.248843825124;12568.622941311774;12655.11414200997;15624.687506249811;18380.35668751614;18744.87530748132;18838.529036773914;19471.513212169808;7297.744578939712;7381.704731810667;7398.445116616168;7434.888476672854;7455.813604659818;749.916370844125;848.6435697007272;905.185333200112;907.3648446087765;909.8771665825029;29261.56107658387;30433.695663043087;30508.23729406738;30819.22626963584;31089.689103108678;1063.7447012717048;1069.1340014588209;1098.6594155811565;1117.5250518529592;1172.6716519374588;15898.35073369738;15923.44267950616;16002.9598076127;16306.021638701479;16425.425110121087;604489;609335;610439;610518;610657;62730;62942.37057629457;62953.370466295666;63075.36924630695;63136.684316578125;1406.2546850169426;1452.0416525093387;1471.374665767066;1472.926353682333;1476.8301645310926;28984.985525506505;29729.85135074311;29946.101616951528;30574.929877454182;30911.84544077355;53694;53803;54159;54274;54343.72828135834;469952;473845;476332;477234;478712;41031;41795.1640967185;41824.3726344099;41911.161776763685;42254;46491;47364.05271894612;47409.05181896274;47550;48006;38622.6137738619;39476;39617.60382396139;40482.1903561933;40536.1892762149;30712.539311910787;38794;38875.444982200395;39019;40020.79989600033;32798.01605951825;33065.338693226484;34522;36629.81685091557;38287.42568861525;31244.68755312418;32556.186095347806;32566;32658.183545411553;33233.33533329368;24547;24557.87721061383;24827.013838893206;24837.627435588118;24909.626355605043 07:29:56 INFO - PROCESS | 1650 | |2;jquery.html;367.49285985340225;387.5756047128395;391.99216015679684;396.2866839688561;416.9728967617107;14888.181150036744;14993;17728.113594320297;20321.796782032176;20806.791932080712;20330;21061.473463163427;21382.89308553455;21945.341639750794;21996;4625.4911959684405;5157.994191132711;5262.973720124568;5435.864103397407;5446.2647542581835;4200.222958752641;5247.685138891659;5357.249985002103;5359.866003349928;5362.544183744387;4374.993751437171;6332.556721029529;6577.769778057769;6618.669066546678;6676.232233293161;5222.6682196039765;5959.463648271633;6149.446549810494;6656.633885136315;6669.5331326807145;5788.305403351583;5862.912056319158;5870.236869207019;5870.853228669317;5878.2064421303;13354.465821367134;13460.528881489101;13572;13691.110077845007;13695.178289302574;2586.4956333514974;2595.5068536977915;2637.1561100447866;2647.0999860047677;2698.6896506901567;9301.88377394717;9983.251256155745;10431.947840260826;11519.712007199803;16098.5975350616;1769.3188122572901;1808.3489943620286;1813.4197056941784;1816.8092350303293;1818.7180986947044;94690.52654736751;101294.49352753189;113349.4332528332;117285.41357293159;143921.56078439186;10728.409937453514;11591.478383472764;11769.52921883115;11807.114466415052;11997.520099195934;15607.531774046796;15620.453284135228;15628.765568516481;15633;15654.217289135499;8203.21090829121;8550.444221125606;8551.572421378905;8673.739787806377;8679.17547832955;8198.83602327962;8210.137935516805;8243.546604936786;8396.328293736486;8400.957995209985;3339.532465454838;4668.019715859639;4675.859724208279;4756.809727610926;4788.23388257884;1960.6764883794015;2017.1326329678086;2025.6151331247015;2028.7117680272838;2029.8071683190074;860.9741707748777;876.6230520876085;887.454215657366;889.2041622747605;911.2391153386997;18964.336248231244;20529.89735051315;21192.046357913932;21342.89328553347;21412.678809817866;892.1747383670208;894.8702438146432;916.5692124701379;917.3807679816231;925.5511077127587;10264.486775661187;10667.466626668636;10902.182336324808;11026.228164028442;11032.172587056002;357900;556131;711670;717770;741496;156659.21670391576;160721.39278607297;160909;162706.18646906927;165005.3499465014;758.6206896551724;911.996803516127;922.9169374756304;999.0409207161061;1019.3068713274896;16123.435679751152;18939.62120757605;20100;20159.39521814348;20206.19175233033;47203.29195062008;57186.99845505387;59015;60358.698206508685;60870;88542;91185;92262.53868730614;93022.53488732514;93561.06438935795;7442.776716698508;7598.202188770099;8080;8289.917100828914;8629.611667475105;11364.886351136383;12687.746245075232;12743.87256127427;13135.949124070243;13167;11258.09935205198;11447.828282575601;11454.656360309204;11630.88369116298;11634.418279086181;10984.615538456115;11024.779504410028;11242.269252498561;11313.886861131283;11480.425978700865;11229.38238396896;11523;11729.003034742142;11811.877871602184;11898.22661526998;8132.796680083045;8341.95829020851;8412.831743365221;8424.83150337002;8430.367722420966;10181.33821301613;11189.04893084097;11476.02453791437;11479.827802583135;11521.53913843437 07:29:56 INFO - PROCESS | 1650 | |3;mootools.html;1274.6877015131292;1335.8378210956464;1403.2913378743733;1479.1938393575501;1488.784126301686;6583.473322134229;8345.499270043802;8355.665773369057;8361.456505327165;8380.916190838083;7394.70421183152;7637.694492220305;7641.12127105383;7901.130875603679;8170.754877353674;2258.119333459952;2302.896369663361;2303.424143964009;2305.043406986099;2307.157887371114;2040.479677682189;2282.600544904635;2313.155698170164;2320.6867072945106;2324.476992676651;2004.4688157638238;2073.0567591745794;2223.7776222377715;2278.908843646252;2285.6228722260807;1959.8040195980288;2285.245868863271;2300.608896487601;2301.355620426283;2304.5390921815706;2227.6992605998307;2276.408133885185;2279.726432828055;2307.676925230469;2315.351701523576;8263;8352.03951545574;8354.540500272482;8358.122397148334;8367.28878045367;4191.497020357546;5180.559652429548;5182.5594824439595;5187.792488300463;5188.092083885305;3271.770976031679;3432.5022871683714;3463.5670541182353;3508.438649816043;3523.242502861897;1161.2451906260999;1218.287301928373;1236;1251.1304643272929;1258.7922992706192;10279.691609251735;10699.83950240747;10705.892941070568;10714.78570428587;10717.624883129052;4021.3163762160502;4341.261985462415;4492.236319825637;4503.909921801611;4509.526499717548;7395;8661.177188167114;8678.435901666371;8678.566071696516;8694.087120852346;5066.240063990357;5078.13671675816;5078.695278283315;5086.415062267813;5087.389513258433;4562.954370456253;4726.740029298353;4736.7631618418945;4789.137955168103;4800.35195248644;2997.3705521840657;3651.561812582454;3652.6895213906582;3721.888343349704;3728.440733889938;1045.6235755128148;1146.4554336690005;1149.373591392693;1159.1422347462985;1165.341582006164;782.2138750555655;842.928351090152;882.6248844241172;892.8526793079199;927.4481683398367;5292.629515933924;5387.892242155135;5537.501624853782;5638.154276858504;5678.296511046752;961.3703024518951;967.6613185385058;982.4203719805349;996.7059717383389;1035.5236591168148;2957.290250339946;3615.7887107819174;3658.5975542690285;3732.757370770891;3795.4306853972125;9654.806903861883;9940.850887236553;9973.301868869255;9981.900180998096;9993.550290236957;9803.852942205873;9903.80192396148;9912.256580756472;9920.355176913621;9928.007199280015;7328.487005909642;7554.66004029809;7655.50239234448;7821.296083352526;7843.450958432969;5573.470520300565;5613.607047506799;5708.8572785679025;5752.395998420273;5955.702214889152;9008.32437567172;9052.90947090547;9173.44959302444;9231.58457869384;9358.953205233931;8031.277185053374;8216.671333146607;9344.15902568772;9550.283728720235;9552.188064014359;6399.296077431572;7084.043654106629;7172.0676312079095;7254.093238345207;7267.200607933018;6825.726970921306;7257.455690823103;7880.684772609032;7961.482503637245;8036.316913062456;7072.469564782765;7151.570905745672;7187.604681742554;7288.927110728825;7340.605284995834;5882.499987500939;7000.964995175195;7015.2283248843605;7024.5434046786795;7056.223815380406;6304.495640348669;6312.621242725451;6315.336889626707;6393.104965304954;6400.263969643551;4906.730129842893;4945.109880221595;4947.45577986414;4973.35346404965;5045.798168073383;4870.220764677634;5019.62352823547;5042.899142017212;5078.619103567321;5133.460986596354 07:29:56 INFO - PROCESS | 1650 | |4;prototype.html;353.41509801278886;362.68627637093914;364.9872254471094;368.7124043246269;373.70664028737446;4645.9535404645985;5337.7598008089635;5346.545543628797;5358.517733403993;5368.973155134224;4955.405351357833;5106.872328191797;5207.463798179537;5270.707242349571;5290.973545132279;3611.819409029538;3983.4622325986056;4097.606813683347;4119.176164767044;4134.875953721393;3510.3330367230146;4112.506499220098;4133.6693064554765;4144.8134833932545;4154.958450415503;3179.6820317968136;3393.372226138172;4135.896602584944;4145.3781932710035;4157.189348077126;3754.399296112636;3829.6553310202216;3870.670992965587;4057.69567282455;4189.664826813862;3632.9273414531563;3650.3064417760543;3651.8904432867057;3656.8720094796554;3680.6687398134295;4296.548862369469;5189.273501709764;5196.570942990707;5215.269862219292;5225.895482090337;4125.009997600584;4600.895785011607;4702.623790096784;4782.426108866924;4809.759512024385;4500.707454015478;4507.867032412475;5498.560115190775;5593.776248950077;5624.425160954939;3372.6846529853133;3854.9421758673643;4049.817758200888;4063.6545893599077;4066.6136717011836;5306.283651707047;5549.250851135126;5795.478406943395;5849.678267695275;5895.941040589582;3399.6260411354733;4090.8363665453644;4106.568810274938;4121.402396652528;4162.979185104055;3544;3709.4250391189407;4148.274052040881;4160.169525408811;4168.520620128664;4022.6781857451333;4113.1568028554075;4406.493253275914;4704.553067458586;4763.237322353027;5550.666959982414;5559;5576.525995290364;5596.278474814203;5619.80330688424;1323.0474058677737;1339.5198305872066;1342.4227582139579;1350.4800651749147;1351.6620844788804;876.3918210084439;940.5908429833045;949.4192170036812;950.6340059077305;955.1785464500524;4517;4786.6410019248;4819.012102518976;4839.201531747292;4909.607231421478;5091.516305950929;5358.168909229919;5371.221172929903;5386.609912920957;5443.836684899459;4455.6435485161755;4574.879154607076;4627.287903475668;4653.812708027222;4920.606351491943;2640.4587059652727;2666.0939575862017;2831.715210355977;2841.8010739248466;2861.2846788302923;4530.388397566287;5583.497485226268;5586.29617966516;5589.037809960727;5609.102543593006;4636.721796692209;4928.852134435972;5362.115250983544;5511.724413779295;5589.748461319169;4706.117552978836;5229;5621.128725047624;5656.171914042979;5670.688112153789;4954.801807927643;5346.652467589594;5419.376771671308;5442.836714898559;5468.5351745100525;4811.412233962854;5304.695304695305;5309.33633295838;5725.398833122629;5726.022468316369;5334.893302133858;5438.619296649196;5488.506034456918;5775.48020678141;5870.618409803349;3310.6689331067664;3868.613138686109;3901.765894046253;3908.5733707197237;3922.9019274517223;4981.346172094771;5822.272215973004;5831.708414579339;5840.890230856124;5855.795047173328;4767.880802979953;5406.351237851483;5558.360788509373;5614.606977511535;5647.6893770843;4867.028853314413;5377.623566350318;5586.413426590312;5616.466435688603;5625.36864309362;5097.388313402415;5468.671879687073;5498.147787093007;5500.7524661391135;5508.504234618904;4680.555347242007;5193.520341371215;5608.943910560843;5640.787230745409;5678.602497825113;4944.777485013255;5103.821366252312;5334.639666884919;5481.588880834033;5538.889222215453 07:29:56 INFO - PROCESS | 1650 | |5;yui.html;723.5477826358526;746.3544034410237;779.2558107007808;830.344028217708;833.5707110837916;10975.560977560908;11443.542258309679;13557.7966330505;14499.782503262459;14533.128012319256;12098.092643051785;14733.705325893503;15124.697506049872;15213.695726085472;15538;845.7843249971264;872.9388942774009;878.0736323179044;878.1745159550035;879.2921698033081;689.290031267795;702.6767686864049;852.9061803201643;875.7591662292857;884.4207044385937;914.1087439746227;929.0106037070532;929.4144688846018;930.4417349590226;934.5420743835506;922.8015976565038;923.8891333040078;924.9213816825578;925.1488630459993;928.8420968435382;689.8171984424082;691.5090285897019;692.5498426023075;692.5913710910537;695.5930780493418;14164.079334843202;14377.71244575113;14408;14595.854041459555;14621.97646164769;14332.211728354936;14718;14774.482893098797;14842.109473431628;14852.851471485255;9823.954574082058;11812.468438920268;11827.053835693125;11938.343391113485;11939.283642981449;3726.7018638508853;3765.303418867491;3793.7344385892998;3850.69194464445;3886.844526218948;99691;113700.43149784282;114448;115844;118669;11184.328940263611;11191.384473854016;11218.046466050313;11470.082393408507;11484;23560.7643923562;24078;24085.51828963411;24091.156809511584;24129.396765080663;7815.491993020435;7887.369010479262;7895.60521973899;7903.486273392211;8046.557439340892;4190.245755763931;4260;4287.656987440997;4309.870703878889;4434.357018232338;3514.314708631792;3579.3557159711504;3581.086822860206;3600.531930848973;3615.1142969972525;544.9727513624382;662.0499583098269;667.4160109903834;678.6945874356559;680.5270337115658;671.5903298987614;698.8551518168243;701.8841891088016;703.525120543631;721.7618185998608;9408.388454750419;9821.656242031637;10200.897991020143;10257.22879246611;10257.435841028666;640.9134766806515;654.8853950558633;705.9576425414491;706.6713978000255;723.2586598736232;4397.714148580332;4947.851564453073;5004.9499505005215;5007.248912663057;5017.648764586444;107567;107588.92411075946;108698;109893.45053274682;115001.4249928745;92839.5358023219;94040.52979735058;94414.36577330525;95520.11997993791;97777;50714.98570028579;83431.16568834355;83982.58008710039;84006;84401;9722.173615242784;9809.362391444532;9822.901770982484;9833;9881.950590247003;40756.999999998814;51809.481905180466;52185.47814521806;53743.731281343345;54278.914421712136;70097.29902700908;70342.29657703357;70359.29640703528;70894;71586.28413716005;11797.29216247028;11869.881301186877;11876.228045177382;11935.924401160271;12305.753884922073;12744.86806446297;12746.10777245584;12844.100912936005;13128.737425251633;13388.93305533466;11889.762204755683;11937.701557461132;12034.870933557164;12060.638180854588;12117.333546655018;10202.948985255027;12070.637880863587;12073.396330183632;12194.451249693962;12560.497580096693;11831.255705370892;11846.585369512026;12012.159148859497;12029.75940481203;12339.69150771238;10197.064738436191;10292.330998485075;10375.377477351383;10507.422091785025;10698.358098514114;8226.259636632492;9835.950820245853;9853.408795472295;9930.702078937644;9940.751481213027 07:29:56 INFO - PROCESS | 1650 | __end_tp_report 07:29:56 INFO - PROCESS | 1650 | __start_cc_report 07:29:56 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1341 07:29:56 INFO - PROCESS | 1650 | __end_cc_report 07:29:56 INFO - PROCESS | 1650 | __startTimestamp1484580596974__endTimestamp 07:29:56 INFO - PROCESS | 1650 | 07:29:56 INFO - PROCESS | 1650 | ------- Summary: start ------- 07:29:56 INFO - PROCESS | 1650 | Number of tests: 6 07:29:56 INFO - PROCESS | 1650 | 07:29:56 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5734.72 Median:5907.08 stddev:671.89 (11.4%) stddev-sans-first:641.71 07:29:56 INFO - PROCESS | 1650 | Values: 3113.5 3334.4 3341.3 3342.2 3390.6 4847.7 5555.5 5647.9 5652.0 5690.5 5647.3 5662.7 5695.4 5704.4 5707.7 5190.9 5230.3 5263.3 5266.5 5285.8 5136.9 5299.8 5318.5 5318.8 5319.1 5260.8 5292.0 5303.8 5304.3 5307.8 5119.1 5157.8 5161.0 5279.9 5284.0 5160.2 5178.7 5219.1 5261.2 5266.0 5691.8 5727.7 5736.1 5761.4 5763.1 6294.0 6306.8 6317.1 6318.3 6326.2 6134.6 6176.5 6203.9 6301.7 6305.5 4897.0 5872.4 5900.4 5915.8 5943.8 6215.6 6287.6 6308.4 6310.8 6333.6 6032.6 6083.1 6089.5 6207.8 6229.8 6192.0 6239.1 6268.9 6324.9 6337.7 6130.4 6133.4 6245.8 6268.2 6269.0 6109.7 6204.3 6252.2 6276.7 6324.8 4894.5 5001.5 5008.6 5009.8 5039.0 3700.5 4409.6 4422.2 4428.3 4470.0 5785.9 5794.0 5794.5 5803.9 5819.3 6318.4 6324.0 6332.7 6342.4 6349.0 5618.5 5667.2 5678.8 5709.7 5783.0 5434.8 5452.2 5458.4 5503.7 5515.4 6310.7 6316.8 6324.5 6328.4 6333.8 6158.4 6197.2 6218.6 6338.8 6349.6 5304.2 6240.1 6279.1 6306.6 6318.7 6239.0 6242.9 6253.0 6271.9 6279.4 5315.2 6150.7 6288.3 6342.4 6355.7 4780.2 6029.5 6114.7 6126.6 6128.1 6176.5 6177.5 6181.7 6189.3 6191.7 4939.2 5834.8 5902.0 5907.1 6038.1 6032.2 6196.0 6210.4 6215.3 6223.4 5837.6 5894.5 5901.4 5988.8 5990.1 07:29:56 INFO - PROCESS | 1650 | 07:29:56 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:67868.94 Median:22034.57 stddev:141146.08 (640.6%) stddev-sans-first:141451.34 07:29:56 INFO - PROCESS | 1650 | Values: 478.0 496.1 497.9 499.4 502.3 29561.6 38496.2 43477.9 43613.6 43625.0 44144.0 44518.6 44548.3 44562.4 44576.0 8334.2 9257.5 9492.0 9492.1 9510.2 8355.7 9651.9 11231.7 11470.9 11644.1 11268.2 11281.0 11384.3 11396.6 11474.3 8397.5 8631.6 11390.0 11472.9 11483.9 11052.6 11357.9 11364.7 11560.4 11567.6 42413.0 42699.6 42776.4 42849.0 42875.0 4048.3 4055.4 4061.5 4084.7 4143.8 29952.4 30250.0 31482.5 31515.1 31519.5 3112.5 3187.1 3258.5 3285.2 3342.8 494641.5 495621.0 495708.0 496165.0 500340.0 64248.7 64501.4 64587.0 64616.0 64778.0 69766.0 69978.0 69985.6 70247.3 70275.9 16116.5 16396.6 16402.3 16410.0 16420.4 11212.8 11554.4 11556.2 12568.6 12655.1 15624.7 18380.4 18744.9 18838.5 19471.5 7297.7 7381.7 7398.4 7434.9 7455.8 749.9 848.6 905.2 907.4 909.9 29261.6 30433.7 30508.2 30819.2 31089.7 1063.7 1069.1 1098.7 1117.5 1172.7 15898.4 15923.4 16003.0 16306.0 16425.4 604489.0 609335.0 610439.0 610518.0 610657.0 62730.0 62942.4 62953.4 63075.4 63136.7 1406.3 1452.0 1471.4 1472.9 1476.8 28985.0 29729.9 29946.1 30574.9 30911.8 53694.0 53803.0 54159.0 54274.0 54343.7 469952.0 473845.0 476332.0 477234.0 478712.0 41031.0 41795.2 41824.4 41911.2 42254.0 46491.0 47364.1 47409.1 47550.0 48006.0 38622.6 39476.0 39617.6 40482.2 40536.2 30712.5 38794.0 38875.4 39019.0 40020.8 32798.0 33065.3 34522.0 36629.8 38287.4 31244.7 32556.2 32566.0 32658.2 33233.3 24547.0 24557.9 24827.0 24837.6 24909.6 07:29:56 INFO - PROCESS | 1650 | 07:29:56 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:36570.40 Median:2642.13 stddev:106774.89 (4041.2%) stddev-sans-first:107039.82 07:29:56 INFO - PROCESS | 1650 | Values: 367.5 387.6 392.0 396.3 417.0 14888.2 14993.0 17728.1 20321.8 20806.8 20330.0 21061.5 21382.9 21945.3 21996.0 4625.5 5158.0 5263.0 5435.9 5446.3 4200.2 5247.7 5357.2 5359.9 5362.5 4375.0 6332.6 6577.8 6618.7 6676.2 5222.7 5959.5 6149.4 6656.6 6669.5 5788.3 5862.9 5870.2 5870.9 5878.2 13354.5 13460.5 13572.0 13691.1 13695.2 2586.5 2595.5 2637.2 2647.1 2698.7 9301.9 9983.3 10431.9 11519.7 16098.6 1769.3 1808.3 1813.4 1816.8 1818.7 94690.5 101294.5 113349.4 117285.4 143921.6 10728.4 11591.5 11769.5 11807.1 11997.5 15607.5 15620.5 15628.8 15633.0 15654.2 8203.2 8550.4 8551.6 8673.7 8679.2 8198.8 8210.1 8243.5 8396.3 8401.0 3339.5 4668.0 4675.9 4756.8 4788.2 1960.7 2017.1 2025.6 2028.7 2029.8 861.0 876.6 887.5 889.2 911.2 18964.3 20529.9 21192.0 21342.9 21412.7 892.2 894.9 916.6 917.4 925.6 10264.5 10667.5 10902.2 11026.2 11032.2 357900.0 556131.0 711670.0 717770.0 741496.0 156659.2 160721.4 160909.0 162706.2 165005.3 758.6 912.0 922.9 999.0 1019.3 16123.4 18939.6 20100.0 20159.4 20206.2 47203.3 57187.0 59015.0 60358.7 60870.0 88542.0 91185.0 92262.5 93022.5 93561.1 7442.8 7598.2 8080.0 8289.9 8629.6 11364.9 12687.7 12743.9 13135.9 13167.0 11258.1 11447.8 11454.7 11630.9 11634.4 10984.6 11024.8 11242.3 11313.9 11480.4 11229.4 11523.0 11729.0 11811.9 11898.2 8132.8 8342.0 8412.8 8424.8 8430.4 10181.3 11189.0 11476.0 11479.8 11521.5 07:29:56 INFO - PROCESS | 1650 | 07:29:56 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5317.58 Median:5240.36 stddev:2893.23 (55.2%) stddev-sans-first:2885.39 07:29:56 INFO - PROCESS | 1650 | Values: 1274.7 1335.8 1403.3 1479.2 1488.8 6583.5 8345.5 8355.7 8361.5 8380.9 7394.7 7637.7 7641.1 7901.1 8170.8 2258.1 2302.9 2303.4 2305.0 2307.2 2040.5 2282.6 2313.2 2320.7 2324.5 2004.5 2073.1 2223.8 2278.9 2285.6 1959.8 2285.2 2300.6 2301.4 2304.5 2227.7 2276.4 2279.7 2307.7 2315.4 8263.0 8352.0 8354.5 8358.1 8367.3 4191.5 5180.6 5182.6 5187.8 5188.1 3271.8 3432.5 3463.6 3508.4 3523.2 1161.2 1218.3 1236.0 1251.1 1258.8 10279.7 10699.8 10705.9 10714.8 10717.6 4021.3 4341.3 4492.2 4503.9 4509.5 7395.0 8661.2 8678.4 8678.6 8694.1 5066.2 5078.1 5078.7 5086.4 5087.4 4563.0 4726.7 4736.8 4789.1 4800.4 2997.4 3651.6 3652.7 3721.9 3728.4 1045.6 1146.5 1149.4 1159.1 1165.3 782.2 842.9 882.6 892.9 927.4 5292.6 5387.9 5537.5 5638.2 5678.3 961.4 967.7 982.4 996.7 1035.5 2957.3 3615.8 3658.6 3732.8 3795.4 9654.8 9940.9 9973.3 9981.9 9993.6 9803.9 9903.8 9912.3 9920.4 9928.0 7328.5 7554.7 7655.5 7821.3 7843.5 5573.5 5613.6 5708.9 5752.4 5955.7 9008.3 9052.9 9173.4 9231.6 9359.0 8031.3 8216.7 9344.2 9550.3 9552.2 6399.3 7084.0 7172.1 7254.1 7267.2 6825.7 7257.5 7880.7 7961.5 8036.3 7072.5 7151.6 7187.6 7288.9 7340.6 5882.5 7001.0 7015.2 7024.5 7056.2 6304.5 6312.6 6315.3 6393.1 6400.3 4906.7 4945.1 4947.5 4973.4 5045.8 4870.2 5019.6 5042.9 5078.6 5133.5 07:29:56 INFO - PROCESS | 1650 | 07:29:56 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4464.98 Median:4924.73 stddev:1333.22 (27.1%) stddev-sans-first:1300.76 07:29:56 INFO - PROCESS | 1650 | Values: 353.4 362.7 365.0 368.7 373.7 4646.0 5337.8 5346.5 5358.5 5369.0 4955.4 5106.9 5207.5 5270.7 5291.0 3611.8 3983.5 4097.6 4119.2 4134.9 3510.3 4112.5 4133.7 4144.8 4155.0 3179.7 3393.4 4135.9 4145.4 4157.2 3754.4 3829.7 3870.7 4057.7 4189.7 3632.9 3650.3 3651.9 3656.9 3680.7 4296.5 5189.3 5196.6 5215.3 5225.9 4125.0 4600.9 4702.6 4782.4 4809.8 4500.7 4507.9 5498.6 5593.8 5624.4 3372.7 3854.9 4049.8 4063.7 4066.6 5306.3 5549.3 5795.5 5849.7 5895.9 3399.6 4090.8 4106.6 4121.4 4163.0 3544.0 3709.4 4148.3 4160.2 4168.5 4022.7 4113.2 4406.5 4704.6 4763.2 5550.7 5559.0 5576.5 5596.3 5619.8 1323.0 1339.5 1342.4 1350.5 1351.7 876.4 940.6 949.4 950.6 955.2 4517.0 4786.6 4819.0 4839.2 4909.6 5091.5 5358.2 5371.2 5386.6 5443.8 4455.6 4574.9 4627.3 4653.8 4920.6 2640.5 2666.1 2831.7 2841.8 2861.3 4530.4 5583.5 5586.3 5589.0 5609.1 4636.7 4928.9 5362.1 5511.7 5589.7 4706.1 5229.0 5621.1 5656.2 5670.7 4954.8 5346.7 5419.4 5442.8 5468.5 4811.4 5304.7 5309.3 5725.4 5726.0 5334.9 5438.6 5488.5 5775.5 5870.6 3310.7 3868.6 3901.8 3908.6 3922.9 4981.3 5822.3 5831.7 5840.9 5855.8 4767.9 5406.4 5558.4 5614.6 5647.7 4867.0 5377.6 5586.4 5616.5 5625.4 5097.4 5468.7 5498.1 5500.8 5508.5 4680.6 5193.5 5608.9 5640.8 5678.6 4944.8 5103.8 5334.6 5481.6 5538.9 07:29:56 INFO - PROCESS | 1650 | 07:29:56 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:20865.08 Median:4353.79 stddev:31147.10 (715.4%) stddev-sans-first:31197.76 07:29:56 INFO - PROCESS | 1650 | Values: 723.5 746.4 779.3 830.3 833.6 10975.6 11443.5 13557.8 14499.8 14533.1 12098.1 14733.7 15124.7 15213.7 15538.0 845.8 872.9 878.1 878.2 879.3 689.3 702.7 852.9 875.8 884.4 914.1 929.0 929.4 930.4 934.5 922.8 923.9 924.9 925.1 928.8 689.8 691.5 692.5 692.6 695.6 14164.1 14377.7 14408.0 14595.9 14622.0 14332.2 14718.0 14774.5 14842.1 14852.9 9824.0 11812.5 11827.1 11938.3 11939.3 3726.7 3765.3 3793.7 3850.7 3886.8 99691.0 113700.4 114448.0 115844.0 118669.0 11184.3 11191.4 11218.0 11470.1 11484.0 23560.8 24078.0 24085.5 24091.2 24129.4 7815.5 7887.4 7895.6 7903.5 8046.6 4190.2 4260.0 4287.7 4309.9 4434.4 3514.3 3579.4 3581.1 3600.5 3615.1 545.0 662.0 667.4 678.7 680.5 671.6 698.9 701.9 703.5 721.8 9408.4 9821.7 10200.9 10257.2 10257.4 640.9 654.9 706.0 706.7 723.3 4397.7 4947.9 5004.9 5007.2 5017.6 107567.0 107588.9 108698.0 109893.5 115001.4 92839.5 94040.5 94414.4 95520.1 97777.0 50715.0 83431.2 83982.6 84006.0 84401.0 9722.2 9809.4 9822.9 9833.0 9882.0 40757.0 51809.5 52185.5 53743.7 54278.9 70097.3 70342.3 70359.3 70894.0 71586.3 11797.3 11869.9 11876.2 11935.9 12305.8 12744.9 12746.1 12844.1 13128.7 13388.9 11889.8 11937.7 12034.9 12060.6 12117.3 10202.9 12070.6 12073.4 12194.5 12560.5 11831.3 11846.6 12012.2 12029.8 12339.7 10197.1 10292.3 10375.4 10507.4 10698.4 8226.3 9836.0 9853.4 9930.7 9940.8 07:29:56 INFO - PROCESS | 1650 | -------- Summary: end -------- 07:29:56 INFO - PROCESS | 1650 | 07:29:57 INFO - TEST-INFO | 1650: exit 0 07:29:57 INFO - TEST-OK | dromaeo_css | took 1118514ms 07:29:57 INFO - TEST-START | kraken 07:29:57 INFO - operating with platform_type : mac_ 07:29:57 INFO - Initialising browser for kraken test... 07:29:57 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpPAGqfg/profile http://localhost:49242/getInfo.html) 07:29:59 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 07:29:59 INFO - PROCESS | 1656 | colorDepth:24 07:29:59 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 07:29:59 INFO - PROCESS | 1656 | __metrics 07:30:00 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:30:00 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:30:00 INFO - TEST-INFO | 1656: exit 0 07:30:00 INFO - Browser initialized. 07:30:00 INFO - Running cycle 1/1 for kraken test... 07:30:00 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpPAGqfg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:12 INFO - PROCESS | 1658 | RSS: Main: 234528768 07:30:12 INFO - PROCESS | 1658 | 07:30:15 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 07:30:16 INFO - PROCESS | 1658 | RSS: Main: 287453184 07:30:16 INFO - PROCESS | 1658 | 07:30:19 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 07:30:19 INFO - PROCESS | 1658 | RSS: Main: 286978048 07:30:19 INFO - PROCESS | 1658 | 07:30:23 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 07:30:23 INFO - PROCESS | 1658 | RSS: Main: 379854848 07:30:23 INFO - PROCESS | 1658 | 07:30:25 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 07:30:26 INFO - PROCESS | 1658 | RSS: Main: 283045888 07:30:26 INFO - PROCESS | 1658 | 07:30:28 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:30:28 INFO - PROCESS | 1658 | RSS: Main: 287481856 07:30:28 INFO - PROCESS | 1658 | 07:30:31 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 07:30:32 INFO - PROCESS | 1658 | RSS: Main: 328499200 07:30:32 INFO - PROCESS | 1658 | 07:30:35 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 07:30:36 INFO - PROCESS | 1658 | RSS: Main: 331366400 07:30:36 INFO - PROCESS | 1658 | 07:30:38 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 07:30:39 INFO - PROCESS | 1658 | RSS: Main: 329388032 07:30:39 INFO - PROCESS | 1658 | 07:30:41 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:30:41 INFO - PROCESS | 1658 | RSS: Main: 303972352 07:30:41 INFO - PROCESS | 1658 | 07:30:43 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:30:44 INFO - PROCESS | 1658 | RSS: Main: 306388992 07:30:44 INFO - PROCESS | 1658 | 07:30:46 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:30:46 INFO - PROCESS | 1658 | RSS: Main: 307912704 07:30:46 INFO - PROCESS | 1658 | 07:30:49 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:30:50 INFO - PROCESS | 1658 | RSS: Main: 325066752 07:30:50 INFO - PROCESS | 1658 | 07:30:53 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:30:54 INFO - PROCESS | 1658 | RSS: Main: 319094784 07:30:54 INFO - PROCESS | 1658 | 07:30:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 07:30:56 INFO - PROCESS | 1658 | RSS: Main: 363188224 07:30:56 INFO - PROCESS | 1658 | 07:30:56 INFO - PROCESS | 1658 | __start_tp_report 07:30:56 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 07:30:56 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 07:30:56 INFO - PROCESS | 1658 | |i|pagename|runs| 07:30:56 INFO - PROCESS | 1658 | |0;ai-astar;118;168;165;114;112;114;114;114;113;113 07:30:56 INFO - PROCESS | 1658 | |1;audio-beat-detection;139;105;110;146;112;109;109;108;130;109 07:30:56 INFO - PROCESS | 1658 | |2;audio-dft;186;182;200;264;186;183;181;184;182;183 07:30:56 INFO - PROCESS | 1658 | |3;audio-fft;79;58;59;87;60;59;58;58;73;60 07:30:56 INFO - PROCESS | 1658 | |4;audio-oscillator;89;67;85;70;69;71;82;69;70;83 07:30:56 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;88;86;89;87;88;84;89;86;87;83 07:30:56 INFO - PROCESS | 1658 | |6;imaging-darkroom;136;150;95;94;94;95;96;97;93;99 07:30:56 INFO - PROCESS | 1658 | |7;imaging-desaturate;88;87;87;88;87;87;85;88;88;86 07:30:56 INFO - PROCESS | 1658 | |8;json-parse-financial;54;53;54;53;54;56;54;55;55;54 07:30:56 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;66;67;80;76;73;70;73;71;69;69 07:30:56 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;85;87;87;87;87;86;87;81;86;91 07:30:56 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;146;149;132;142;140;144;146;129;198;173 07:30:56 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;170;174;173;171;172;171;176;172;173;180 07:30:56 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;68;66;67;67;66;69;68;66;66;67 07:30:56 INFO - PROCESS | 1658 | __end_tp_report 07:30:56 INFO - PROCESS | 1658 | __start_cc_report 07:30:56 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1944 07:30:56 INFO - PROCESS | 1658 | __end_cc_report 07:30:56 INFO - PROCESS | 1658 | __startTimestamp1484580656198__endTimestamp 07:30:56 INFO - PROCESS | 1658 | 07:30:56 INFO - PROCESS | 1658 | ------- Summary: start ------- 07:30:56 INFO - PROCESS | 1658 | Number of tests: 14 07:30:56 INFO - PROCESS | 1658 | 07:30:56 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:124.50 Median:114.00 stddev:22.20 (19.5%) stddev-sans-first:23.42 07:30:56 INFO - PROCESS | 1658 | Values: 118.0 168.0 165.0 114.0 112.0 114.0 114.0 114.0 113.0 113.0 07:30:56 INFO - PROCESS | 1658 | 07:30:56 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:117.70 Median:111.00 stddev:14.83 (13.4%) stddev-sans-first:13.58 07:30:56 INFO - PROCESS | 1658 | Values: 139.0 105.0 110.0 146.0 112.0 109.0 109.0 108.0 130.0 109.0 07:30:56 INFO - PROCESS | 1658 | 07:30:56 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:193.10 Median:185.00 stddev:25.51 (13.8%) stddev-sans-first:26.92 07:30:56 INFO - PROCESS | 1658 | Values: 186.0 182.0 200.0 264.0 186.0 183.0 181.0 184.0 182.0 183.0 07:30:56 INFO - PROCESS | 1658 | 07:30:56 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:65.10 Median:60.00 stddev:10.61 (17.7%) stddev-sans-first:9.99 07:30:56 INFO - PROCESS | 1658 | Values: 79.0 58.0 59.0 87.0 60.0 59.0 58.0 58.0 73.0 60.0 07:30:56 INFO - PROCESS | 1658 | 07:30:56 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:76.50 stddev:8.22 (10.7%) stddev-sans-first:7.12 07:30:56 INFO - PROCESS | 1658 | Values: 89.0 67.0 85.0 70.0 69.0 71.0 82.0 69.0 70.0 83.0 07:30:56 INFO - PROCESS | 1658 | 07:30:56 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:87.50 stddev:2.00 (2.3%) stddev-sans-first:2.07 07:30:56 INFO - PROCESS | 1658 | Values: 88.0 86.0 89.0 87.0 88.0 84.0 89.0 86.0 87.0 83.0 07:30:56 INFO - PROCESS | 1658 | 07:30:56 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:104.90 Median:95.00 stddev:20.42 (21.5%) stddev-sans-first:18.30 07:30:56 INFO - PROCESS | 1658 | Values: 136.0 150.0 95.0 94.0 94.0 95.0 96.0 97.0 93.0 99.0 07:30:56 INFO - PROCESS | 1658 | 07:30:56 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:87.10 Median:87.50 stddev:0.99 (1.1%) stddev-sans-first:1.00 07:30:56 INFO - PROCESS | 1658 | Values: 88.0 87.0 87.0 88.0 87.0 87.0 85.0 88.0 88.0 86.0 07:30:56 INFO - PROCESS | 1658 | 07:30:56 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.97 07:30:56 INFO - PROCESS | 1658 | Values: 54.0 53.0 54.0 53.0 54.0 56.0 54.0 55.0 55.0 54.0 07:30:56 INFO - PROCESS | 1658 | 07:30:56 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:72.00 stddev:4.25 (5.9%) stddev-sans-first:4.03 07:30:56 INFO - PROCESS | 1658 | Values: 66.0 67.0 80.0 76.0 73.0 70.0 73.0 71.0 69.0 69.0 07:30:56 INFO - PROCESS | 1658 | 07:30:56 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:87.00 stddev:2.46 (2.8%) stddev-sans-first:2.55 07:30:56 INFO - PROCESS | 1658 | Values: 85.0 87.0 87.0 87.0 87.0 86.0 87.0 81.0 86.0 91.0 07:30:56 INFO - PROCESS | 1658 | 07:30:56 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:149.90 Median:146.00 stddev:20.63 (14.1%) stddev-sans-first:21.83 07:30:56 INFO - PROCESS | 1658 | Values: 146.0 149.0 132.0 142.0 140.0 144.0 146.0 129.0 198.0 173.0 07:30:56 INFO - PROCESS | 1658 | 07:30:56 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:173.00 stddev:2.94 (1.7%) stddev-sans-first:2.88 07:30:56 INFO - PROCESS | 1658 | Values: 170.0 174.0 173.0 171.0 172.0 171.0 176.0 172.0 173.0 180.0 07:30:56 INFO - PROCESS | 1658 | 07:30:56 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.05 (1.6%) stddev-sans-first:1.05 07:30:56 INFO - PROCESS | 1658 | Values: 68.0 66.0 67.0 67.0 66.0 69.0 68.0 66.0 66.0 67.0 07:30:56 INFO - PROCESS | 1658 | -------- Summary: end -------- 07:30:56 INFO - PROCESS | 1658 | 07:30:57 INFO - TEST-INFO | 1658: exit 0 07:30:57 INFO - TEST-OK | kraken | took 59489ms 07:30:57 INFO - SUITE-END | took 1178s 07:30:57 INFO - Completed test suite (00:19:38) 07:30:57 INFO - javascript benchmark 07:30:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3113.470709979303, 3334.3998080345527, 3341.3150304187643, 3342.231286804036, 3390.64398238185, 4847.733374664392, 5555.527780138693, 5647.915281270779, 5651.971740141294, 5690.51630611398, 5647.322321321447, 5662.745176467059, 5695.373508914026, 5704.429557044294, 5707.65754054756, 5190.8702282443055, 5230.293910322115, 5263.289455923459, 5266.52601265886, 5285.762140703678, 5136.8972620547565, 5299.814506492274, 5318.494742999409, 5318.787248510055, 5319.148936170213, 5260.789568417259, 5291.968066227088, 5303.814366497154, 5304.336957880265, 5307.840764777063, 5119.10415677255, 5157.767900444489, 5160.974195129038, 5279.86800329991, 5284.022455845681, 5160.174372100483, 5178.689278643255, 5219.060569097561, 5261.210818377236, 5266.0, 5691.8292451226525, 5727.684977326246, 5736.053551164053, 5761.423857614247, 5763.106718458604, 6294.0, 6306.779262725829, 6317.147185129995, 6318.273398559132, 6326.177596912418, 6134.632471123831, 6176.536759742992, 6203.875922481525, 6301.747930082791, 6305.464035556983, 4896.975515122473, 5872.412758724179, 5900.350961394201, 5915.792947246911, 5943.821685349447, 6215.627062376272, 6287.591306565058, 6308.432241098323, 6310.779122730774, 6333.588316759396, 6032.607880487842, 6083.148359229712, 6089.48239399656, 6207.751689932352, 6229.813105606839, 6192.0, 6239.06414037898, 6268.874622507525, 6324.936750632527, 6337.714802833883, 6130.386961303834, 6133.365267548864, 6245.75016999324, 6268.153799237045, 6268.968655156695, 6109.694515274218, 6204.286507051746, 6252.218472690914, 6276.748930042839, 6324.841878953063, 4894.486078961729, 5001.549860512571, 5008.57427118699, 5009.774560144802, 5039.042581909425, 3700.5374328208973, 4409.647228221735, 4422.159789639958, 4428.31361139024, 4470.0, 5785.942140578624, 5794.0439827428845, 5794.507466865363, 5803.912941305884, 5819.301683797887, 6318.4313411793155, 6323.968380158161, 6332.651704156224, 6342.365763423621, 6348.968255158787, 5618.4662457066515, 5667.1782591524825, 5678.829635110871, 5709.714514274269, 5783.0, 5434.809781657623, 5452.154915987949, 5458.372287186945, 5503.724813759376, 5515.420880807537, 6310.7475700971445, 6316.778912738032, 6324.525660575568, 6328.430441260124, 6333.778317758856, 6158.353372895782, 6197.225346831646, 6218.595791273553, 6338.841528961812, 6349.555531112777, 5304.23088652151, 6240.063990401476, 6279.1209230708655, 6306.590071645328, 6318.715657795502, 6238.968805155945, 6242.875142497215, 6252.968735156477, 6271.937280627318, 6279.434850863444, 5315.2292917525965, 6150.723217455135, 6288.339724329063, 6342.429181373698, 6355.650439225887, 4780.211265141213, 6029.457348838626, 6114.723190878535, 6126.5711400203345, 6128.080787881853, 6176.474999625082, 6177.536684748572, 6181.660008699565, 6189.288231853395, 6191.659458729813, 4939.234418665113, 5834.795782147605, 5901.996660567628, 5907.084401917709, 6038.124471951454, 6032.245969253843, 6195.96902015487, 6210.441060304594, 6215.254169499689, 6223.37766223374, 5837.6497410153825, 5894.498967587803, 5901.380355062656, 5988.760449581968, 5990.131430942576], "value": 5691.365688200986, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.9713217206968, 496.1317694035438, 497.89793092416056, 499.3608181527641, 502.32688197814934, 29561.55657665137, 38496.230075398475, 43477.91305217371, 43613.56386436135, 43625.0, 44144.0, 44518.55481445185, 44548.3317750234, 44562.440314588996, 44576.0, 8334.166583341677, 9257.53712314385, 9492.0, 9492.098250666175, 9510.191633711143, 8355.749327520183, 9651.855222171673, 11231.719207019809, 11470.885291147066, 11644.068474522019, 11268.211225214238, 11281.0, 11384.260023098514, 11396.601118960838, 11474.311541307507, 8397.496150231005, 8631.611577479029, 11390.03184729299, 11472.885271147265, 11483.942580287045, 11052.557897684082, 11357.920997505224, 11364.715882102932, 11560.364179970098, 11567.595134170348, 42413.0, 42699.57300426987, 42776.3583546247, 42849.0, 42875.0, 4048.332025215836, 4055.3916912463073, 4061.512618485771, 4084.65280451162, 4143.81352839123, 29952.40095198084, 30250.0, 31482.527762083588, 31515.054548363587, 31519.527207091684, 3112.548680441346, 3187.0757480330676, 3258.5112233164978, 3285.178705323669, 3342.7660063795543, 494641.52679236734, 495621.0, 495708.0, 496165.0, 500339.99999999633, 64248.67875660592, 64501.354986450475, 64587.03119453212, 64616.0, 64778.0, 69766.0, 69978.0, 69985.60028799395, 70247.2975270251, 70275.94586081213, 16116.516504504883, 16396.590085247964, 16402.343906243615, 16410.0, 16420.425285114965, 11212.831807522894, 11554.42227888619, 11556.248843825124, 12568.622941311774, 12655.11414200997, 15624.687506249811, 18380.35668751614, 18744.87530748132, 18838.529036773914, 19471.513212169808, 7297.744578939712, 7381.704731810667, 7398.445116616168, 7434.888476672854, 7455.813604659818, 749.916370844125, 848.6435697007272, 905.185333200112, 907.3648446087765, 909.8771665825029, 29261.56107658387, 30433.695663043087, 30508.23729406738, 30819.22626963584, 31089.689103108678, 1063.7447012717048, 1069.1340014588209, 1098.6594155811565, 1117.5250518529592, 1172.6716519374588, 15898.35073369738, 15923.44267950616, 16002.9598076127, 16306.021638701479, 16425.425110121087, 604489.0, 609335.0, 610439.0, 610518.0, 610657.0, 62730.0, 62942.37057629457, 62953.370466295666, 63075.36924630695, 63136.684316578125, 1406.2546850169426, 1452.0416525093387, 1471.374665767066, 1472.926353682333, 1476.8301645310926, 28984.985525506505, 29729.85135074311, 29946.101616951528, 30574.929877454182, 30911.84544077355, 53694.0, 53803.0, 54159.0, 54274.0, 54343.72828135834, 469952.0, 473845.0, 476332.0, 477234.0, 478712.0, 41031.0, 41795.1640967185, 41824.3726344099, 41911.161776763685, 42254.0, 46491.0, 47364.05271894612, 47409.05181896274, 47550.0, 48006.0, 38622.6137738619, 39476.0, 39617.60382396139, 40482.1903561933, 40536.1892762149, 30712.539311910787, 38794.0, 38875.444982200395, 39019.0, 40020.79989600033, 32798.01605951825, 33065.338693226484, 34522.0, 36629.81685091557, 38287.42568861525, 31244.68755312418, 32556.186095347806, 32566.0, 32658.183545411553, 33233.33533329368, 24547.0, 24557.87721061383, 24827.013838893206, 24837.627435588118, 24909.626355605043], "value": 20583.44805815227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.49285985340225, 387.5756047128395, 391.99216015679684, 396.2866839688561, 416.9728967617107, 14888.181150036744, 14993.0, 17728.113594320297, 20321.796782032176, 20806.791932080712, 20330.0, 21061.473463163427, 21382.89308553455, 21945.341639750794, 21996.0, 4625.4911959684405, 5157.994191132711, 5262.973720124568, 5435.864103397407, 5446.2647542581835, 4200.222958752641, 5247.685138891659, 5357.249985002103, 5359.866003349928, 5362.544183744387, 4374.993751437171, 6332.556721029529, 6577.769778057769, 6618.669066546678, 6676.232233293161, 5222.6682196039765, 5959.463648271633, 6149.446549810494, 6656.633885136315, 6669.5331326807145, 5788.305403351583, 5862.912056319158, 5870.236869207019, 5870.853228669317, 5878.2064421303, 13354.465821367134, 13460.528881489101, 13572.0, 13691.110077845007, 13695.178289302574, 2586.4956333514974, 2595.5068536977915, 2637.1561100447866, 2647.0999860047677, 2698.6896506901567, 9301.88377394717, 9983.251256155745, 10431.947840260826, 11519.712007199803, 16098.5975350616, 1769.3188122572901, 1808.3489943620286, 1813.4197056941784, 1816.8092350303293, 1818.7180986947044, 94690.52654736751, 101294.49352753189, 113349.4332528332, 117285.41357293159, 143921.56078439186, 10728.409937453514, 11591.478383472764, 11769.52921883115, 11807.114466415052, 11997.520099195934, 15607.531774046796, 15620.453284135228, 15628.765568516481, 15633.0, 15654.217289135499, 8203.21090829121, 8550.444221125606, 8551.572421378905, 8673.739787806377, 8679.17547832955, 8198.83602327962, 8210.137935516805, 8243.546604936786, 8396.328293736486, 8400.957995209985, 3339.532465454838, 4668.019715859639, 4675.859724208279, 4756.809727610926, 4788.23388257884, 1960.6764883794015, 2017.1326329678086, 2025.6151331247015, 2028.7117680272838, 2029.8071683190074, 860.9741707748777, 876.6230520876085, 887.454215657366, 889.2041622747605, 911.2391153386997, 18964.336248231244, 20529.89735051315, 21192.046357913932, 21342.89328553347, 21412.678809817866, 892.1747383670208, 894.8702438146432, 916.5692124701379, 917.3807679816231, 925.5511077127587, 10264.486775661187, 10667.466626668636, 10902.182336324808, 11026.228164028442, 11032.172587056002, 357900.0, 556131.0, 711670.0, 717770.0, 741496.0, 156659.21670391576, 160721.39278607297, 160909.0, 162706.18646906927, 165005.3499465014, 758.6206896551724, 911.996803516127, 922.9169374756304, 999.0409207161061, 1019.3068713274896, 16123.435679751152, 18939.62120757605, 20100.0, 20159.39521814348, 20206.19175233033, 47203.29195062008, 57186.99845505387, 59015.0, 60358.698206508685, 60870.0, 88542.0, 91185.0, 92262.53868730614, 93022.53488732514, 93561.06438935795, 7442.776716698508, 7598.202188770099, 8080.0, 8289.917100828914, 8629.611667475105, 11364.886351136383, 12687.746245075232, 12743.87256127427, 13135.949124070243, 13167.0, 11258.09935205198, 11447.828282575601, 11454.656360309204, 11630.88369116298, 11634.418279086181, 10984.615538456115, 11024.779504410028, 11242.269252498561, 11313.886861131283, 11480.425978700865, 11229.38238396896, 11523.0, 11729.003034742142, 11811.877871602184, 11898.22661526998, 8132.796680083045, 8341.95829020851, 8412.831743365221, 8424.83150337002, 8430.367722420966, 10181.33821301613, 11189.04893084097, 11476.02453791437, 11479.827802583135, 11521.53913843437], "value": 9555.290144959861, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1274.6877015131292, 1335.8378210956464, 1403.2913378743733, 1479.1938393575501, 1488.784126301686, 6583.473322134229, 8345.499270043802, 8355.665773369057, 8361.456505327165, 8380.916190838083, 7394.70421183152, 7637.694492220305, 7641.12127105383, 7901.130875603679, 8170.754877353674, 2258.119333459952, 2302.896369663361, 2303.424143964009, 2305.043406986099, 2307.157887371114, 2040.479677682189, 2282.600544904635, 2313.155698170164, 2320.6867072945106, 2324.476992676651, 2004.4688157638238, 2073.0567591745794, 2223.7776222377715, 2278.908843646252, 2285.6228722260807, 1959.8040195980288, 2285.245868863271, 2300.608896487601, 2301.355620426283, 2304.5390921815706, 2227.6992605998307, 2276.408133885185, 2279.726432828055, 2307.676925230469, 2315.351701523576, 8263.0, 8352.03951545574, 8354.540500272482, 8358.122397148334, 8367.28878045367, 4191.497020357546, 5180.559652429548, 5182.5594824439595, 5187.792488300463, 5188.092083885305, 3271.770976031679, 3432.5022871683714, 3463.5670541182353, 3508.438649816043, 3523.242502861897, 1161.2451906260999, 1218.287301928373, 1236.0, 1251.1304643272929, 1258.7922992706192, 10279.691609251735, 10699.83950240747, 10705.892941070568, 10714.78570428587, 10717.624883129052, 4021.3163762160502, 4341.261985462415, 4492.236319825637, 4503.909921801611, 4509.526499717548, 7395.0, 8661.177188167114, 8678.435901666371, 8678.566071696516, 8694.087120852346, 5066.240063990357, 5078.13671675816, 5078.695278283315, 5086.415062267813, 5087.389513258433, 4562.954370456253, 4726.740029298353, 4736.7631618418945, 4789.137955168103, 4800.35195248644, 2997.3705521840657, 3651.561812582454, 3652.6895213906582, 3721.888343349704, 3728.440733889938, 1045.6235755128148, 1146.4554336690005, 1149.373591392693, 1159.1422347462985, 1165.341582006164, 782.2138750555655, 842.928351090152, 882.6248844241172, 892.8526793079199, 927.4481683398367, 5292.629515933924, 5387.892242155135, 5537.501624853782, 5638.154276858504, 5678.296511046752, 961.3703024518951, 967.6613185385058, 982.4203719805349, 996.7059717383389, 1035.5236591168148, 2957.290250339946, 3615.7887107819174, 3658.5975542690285, 3732.757370770891, 3795.4306853972125, 9654.806903861883, 9940.850887236553, 9973.301868869255, 9981.900180998096, 9993.550290236957, 9803.852942205873, 9903.80192396148, 9912.256580756472, 9920.355176913621, 9928.007199280015, 7328.487005909642, 7554.66004029809, 7655.50239234448, 7821.296083352526, 7843.450958432969, 5573.470520300565, 5613.607047506799, 5708.8572785679025, 5752.395998420273, 5955.702214889152, 9008.32437567172, 9052.90947090547, 9173.44959302444, 9231.58457869384, 9358.953205233931, 8031.277185053374, 8216.671333146607, 9344.15902568772, 9550.283728720235, 9552.188064014359, 6399.296077431572, 7084.043654106629, 7172.0676312079095, 7254.093238345207, 7267.200607933018, 6825.726970921306, 7257.455690823103, 7880.684772609032, 7961.482503637245, 8036.316913062456, 7072.469564782765, 7151.570905745672, 7187.604681742554, 7288.927110728825, 7340.605284995834, 5882.499987500939, 7000.964995175195, 7015.2283248843605, 7024.5434046786795, 7056.223815380406, 6304.495640348669, 6312.621242725451, 6315.336889626707, 6393.104965304954, 6400.263969643551, 4906.730129842893, 4945.109880221595, 4947.45577986414, 4973.35346404965, 5045.798168073383, 4870.220764677634, 5019.62352823547, 5042.899142017212, 5078.619103567321, 5133.460986596354], "value": 4327.3749749488325, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.41509801278886, 362.68627637093914, 364.9872254471094, 368.7124043246269, 373.70664028737446, 4645.9535404645985, 5337.7598008089635, 5346.545543628797, 5358.517733403993, 5368.973155134224, 4955.405351357833, 5106.872328191797, 5207.463798179537, 5270.707242349571, 5290.973545132279, 3611.819409029538, 3983.4622325986056, 4097.606813683347, 4119.176164767044, 4134.875953721393, 3510.3330367230146, 4112.506499220098, 4133.6693064554765, 4144.8134833932545, 4154.958450415503, 3179.6820317968136, 3393.372226138172, 4135.896602584944, 4145.3781932710035, 4157.189348077126, 3754.399296112636, 3829.6553310202216, 3870.670992965587, 4057.69567282455, 4189.664826813862, 3632.9273414531563, 3650.3064417760543, 3651.8904432867057, 3656.8720094796554, 3680.6687398134295, 4296.548862369469, 5189.273501709764, 5196.570942990707, 5215.269862219292, 5225.895482090337, 4125.009997600584, 4600.895785011607, 4702.623790096784, 4782.426108866924, 4809.759512024385, 4500.707454015478, 4507.867032412475, 5498.560115190775, 5593.776248950077, 5624.425160954939, 3372.6846529853133, 3854.9421758673643, 4049.817758200888, 4063.6545893599077, 4066.6136717011836, 5306.283651707047, 5549.250851135126, 5795.478406943395, 5849.678267695275, 5895.941040589582, 3399.6260411354733, 4090.8363665453644, 4106.568810274938, 4121.402396652528, 4162.979185104055, 3544.0, 3709.4250391189407, 4148.274052040881, 4160.169525408811, 4168.520620128664, 4022.6781857451333, 4113.1568028554075, 4406.493253275914, 4704.553067458586, 4763.237322353027, 5550.666959982414, 5559.0, 5576.525995290364, 5596.278474814203, 5619.80330688424, 1323.0474058677737, 1339.5198305872066, 1342.4227582139579, 1350.4800651749147, 1351.6620844788804, 876.3918210084439, 940.5908429833045, 949.4192170036812, 950.6340059077305, 955.1785464500524, 4517.0, 4786.6410019248, 4819.012102518976, 4839.201531747292, 4909.607231421478, 5091.516305950929, 5358.168909229919, 5371.221172929903, 5386.609912920957, 5443.836684899459, 4455.6435485161755, 4574.879154607076, 4627.287903475668, 4653.812708027222, 4920.606351491943, 2640.4587059652727, 2666.0939575862017, 2831.715210355977, 2841.8010739248466, 2861.2846788302923, 4530.388397566287, 5583.497485226268, 5586.29617966516, 5589.037809960727, 5609.102543593006, 4636.721796692209, 4928.852134435972, 5362.115250983544, 5511.724413779295, 5589.748461319169, 4706.117552978836, 5229.0, 5621.128725047624, 5656.171914042979, 5670.688112153789, 4954.801807927643, 5346.652467589594, 5419.376771671308, 5442.836714898559, 5468.5351745100525, 4811.412233962854, 5304.695304695305, 5309.33633295838, 5725.398833122629, 5726.022468316369, 5334.893302133858, 5438.619296649196, 5488.506034456918, 5775.48020678141, 5870.618409803349, 3310.6689331067664, 3868.613138686109, 3901.765894046253, 3908.5733707197237, 3922.9019274517223, 4981.346172094771, 5822.272215973004, 5831.708414579339, 5840.890230856124, 5855.795047173328, 4767.880802979953, 5406.351237851483, 5558.360788509373, 5614.606977511535, 5647.6893770843, 4867.028853314413, 5377.623566350318, 5586.413426590312, 5616.466435688603, 5625.36864309362, 5097.388313402415, 5468.671879687073, 5498.147787093007, 5500.7524661391135, 5508.504234618904, 4680.555347242007, 5193.520341371215, 5608.943910560843, 5640.787230745409, 5678.602497825113, 4944.777485013255, 5103.821366252312, 5334.639666884919, 5481.588880834033, 5538.889222215453], "value": 4062.801445869913, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.5477826358526, 746.3544034410237, 779.2558107007808, 830.344028217708, 833.5707110837916, 10975.560977560908, 11443.542258309679, 13557.7966330505, 14499.782503262459, 14533.128012319256, 12098.092643051785, 14733.705325893503, 15124.697506049872, 15213.695726085472, 15538.0, 845.7843249971264, 872.9388942774009, 878.0736323179044, 878.1745159550035, 879.2921698033081, 689.290031267795, 702.6767686864049, 852.9061803201643, 875.7591662292857, 884.4207044385937, 914.1087439746227, 929.0106037070532, 929.4144688846018, 930.4417349590226, 934.5420743835506, 922.8015976565038, 923.8891333040078, 924.9213816825578, 925.1488630459993, 928.8420968435382, 689.8171984424082, 691.5090285897019, 692.5498426023075, 692.5913710910537, 695.5930780493418, 14164.079334843202, 14377.71244575113, 14408.0, 14595.854041459555, 14621.97646164769, 14332.211728354936, 14718.0, 14774.482893098797, 14842.109473431628, 14852.851471485255, 9823.954574082058, 11812.468438920268, 11827.053835693125, 11938.343391113485, 11939.283642981449, 3726.7018638508853, 3765.303418867491, 3793.7344385892998, 3850.69194464445, 3886.844526218948, 99691.0, 113700.43149784282, 114448.0, 115844.0, 118669.0, 11184.328940263611, 11191.384473854016, 11218.046466050313, 11470.082393408507, 11484.0, 23560.7643923562, 24078.0, 24085.51828963411, 24091.156809511584, 24129.396765080663, 7815.491993020435, 7887.369010479262, 7895.60521973899, 7903.486273392211, 8046.557439340892, 4190.245755763931, 4260.0, 4287.656987440997, 4309.870703878889, 4434.357018232338, 3514.314708631792, 3579.3557159711504, 3581.086822860206, 3600.531930848973, 3615.1142969972525, 544.9727513624382, 662.0499583098269, 667.4160109903834, 678.6945874356559, 680.5270337115658, 671.5903298987614, 698.8551518168243, 701.8841891088016, 703.525120543631, 721.7618185998608, 9408.388454750419, 9821.656242031637, 10200.897991020143, 10257.22879246611, 10257.435841028666, 640.9134766806515, 654.8853950558633, 705.9576425414491, 706.6713978000255, 723.2586598736232, 4397.714148580332, 4947.851564453073, 5004.9499505005215, 5007.248912663057, 5017.648764586444, 107567.0, 107588.92411075946, 108698.0, 109893.45053274682, 115001.4249928745, 92839.5358023219, 94040.52979735058, 94414.36577330525, 95520.11997993791, 97777.0, 50714.98570028579, 83431.16568834355, 83982.58008710039, 84006.0, 84401.0, 9722.173615242784, 9809.362391444532, 9822.901770982484, 9833.0, 9881.950590247003, 40756.999999998814, 51809.481905180466, 52185.47814521806, 53743.731281343345, 54278.914421712136, 70097.29902700908, 70342.29657703357, 70359.29640703528, 70894.0, 71586.28413716005, 11797.29216247028, 11869.881301186877, 11876.228045177382, 11935.924401160271, 12305.753884922073, 12744.86806446297, 12746.10777245584, 12844.100912936005, 13128.737425251633, 13388.93305533466, 11889.762204755683, 11937.701557461132, 12034.870933557164, 12060.638180854588, 12117.333546655018, 10202.948985255027, 12070.637880863587, 12073.396330183632, 12194.451249693962, 12560.497580096693, 11831.255705370892, 11846.585369512026, 12012.159148859497, 12029.75940481203, 12339.69150771238, 10197.064738436191, 10292.330998485075, 10375.377477351383, 10507.422091785025, 10698.358098514114, 8226.259636632492, 9835.950820245853, 9853.408795472295, 9930.702078937644, 9940.751481213027], "value": 7440.790555570808, "unit": "score"}], "name": "dromaeo_css", "value": 7260.216030957799, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 168.0, 165.0, 114.0, 112.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 124.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 105.0, 110.0, 146.0, 112.0, 109.0, 109.0, 108.0, 130.0, 109.0], "value": 117.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 182.0, 200.0, 264.0, 186.0, 183.0, 181.0, 184.0, 182.0, 183.0], "value": 193.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 87.0, 60.0, 59.0, 58.0, 58.0, 73.0, 60.0], "value": 65.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 67.0, 85.0, 70.0, 69.0, 71.0, 82.0, 69.0, 70.0, 83.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 87.0, 88.0, 84.0, 89.0, 86.0, 87.0, 83.0], "value": 86.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 150.0, 95.0, 94.0, 94.0, 95.0, 96.0, 97.0, 93.0, 99.0], "value": 104.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 88.0, 87.0, 87.0, 85.0, 88.0, 88.0, 86.0], "value": 87.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 53.0, 54.0, 56.0, 54.0, 55.0, 55.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 80.0, 76.0, 73.0, 70.0, 73.0, 71.0, 69.0, 69.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 87.0, 87.0, 87.0, 86.0, 87.0, 81.0, 86.0, 91.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 132.0, 142.0, 140.0, 144.0, 146.0, 129.0, 198.0, 173.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 173.0, 171.0, 172.0, 171.0, 176.0, 172.0, 173.0, 180.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 67.0, 66.0, 69.0, 68.0, 66.0, 66.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1456.7000000000003, "alertThreshold": 2.0}]} 07:30:57 INFO - Return code: 0 07:30:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:30:57 ERROR - # TBPL SUCCESS # 07:30:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:30:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:30:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:30:57 INFO - 2017-01-16 07:30:57.511 screenresolution[1662:10944] starting screenresolution argv=screenresolution get 07:30:57 INFO - 2017-01-16 07:30:57.513 screenresolution[1662:10944] Display 0: 1600x1200x32@60 07:30:57 INFO - 2017-01-16 07:30:57.519 screenresolution[1663:10947] starting screenresolution argv=screenresolution list 07:30:57 INFO - Available Modes on Display 0 07:30:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:30:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:30:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:30:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:30:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:30:57 INFO - Intel Iris: 07:30:57 INFO - Chipset Model: Intel Iris 07:30:57 INFO - Type: GPU 07:30:57 INFO - Bus: Built-In 07:30:57 INFO - VRAM (Dynamic, Max): 1536 MB 07:30:57 INFO - Vendor: Intel (0x8086) 07:30:57 INFO - Device ID: 0x0a2e 07:30:57 INFO - Revision ID: 0x0009 07:30:57 INFO - Displays: 07:30:57 INFO - Display: 07:30:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:30:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:30:57 INFO - Display Serial Number: 1600x1200 60 07:30:57 INFO - Main Display: Yes 07:30:57 INFO - Mirror: Off 07:30:57 INFO - Online: Yes 07:30:57 INFO - Rotation: Supported 07:30:57 INFO - Return code: 0 07:30:57 INFO - Running post-action listener: _resource_record_post_action 07:30:57 INFO - [mozharness: 2017-01-16 15:30:57.756912Z] Finished run-tests step (success) 07:30:57 INFO - Running post-run listener: _resource_record_post_run 07:30:57 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 33512448; Write bytes: 553698304; Read time: 313; Write time: 2103 07:30:57 INFO - TinderboxPrint: CPU usage
53.7% 07:30:57 INFO - TinderboxPrint: I/O read bytes / time
33,512,448 / 313 07:30:57 INFO - TinderboxPrint: I/O write bytes / time
553,698,304 / 2,103 07:30:57 INFO - TinderboxPrint: CPU idle
2,225.7 (46.3%) 07:30:57 INFO - TinderboxPrint: CPU system
960.4 (20.0%) 07:30:57 INFO - TinderboxPrint: CPU user
1,619.5 (33.7%) 07:30:57 INFO - TinderboxPrint: Swap in / out
281,673,728 / 0 07:30:57 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 243739136; Write bytes: 237684736; Read time: 17737; Write time: 711 07:30:57 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 31484928; Write bytes: 298372096; Read time: 291; Write time: 1351 07:30:58 INFO - Running post-run listener: _upload_blobber_files 07:30:58 INFO - Blob upload gear active. 07:30:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:30:58 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 07:30:58 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:30:58 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:30:58 INFO - (blobuploader) - INFO - Open directory for files ... 07:30:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:30:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:30:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:59 INFO - (blobuploader) - INFO - Done attempting. 07:30:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:30:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:31:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:00 INFO - (blobuploader) - INFO - Done attempting. 07:31:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:31:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:31:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:01 INFO - (blobuploader) - INFO - Done attempting. 07:31:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:31:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:31:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:04 INFO - (blobuploader) - INFO - Done attempting. 07:31:04 INFO - (blobuploader) - INFO - Iteration through files over. 07:31:04 INFO - Return code: 0 07:31:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:31:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:31:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/099bce387157c22125b310c4b409d10e744ec14b638a74c81ef2a259e11ba55a47ea40adf84a835eb50b92087f38782f2d1d2514a35adfaf266c6c1099527f24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9a72625c08541c17e0daa1d3eb7ee6c463c2ee56448badb1545f716e6df620943d2668ea7ca0220c4dfb1e62ef5c47bc172954ad5b4e33aaff56a69120627af4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/704340b508429dd503bb42b6fd10574213a161e51270def3b22171a77e8afb9720ba14f880cb2b08b997a61f7622ef45981c950e351900a6198d56a2e76bbb9a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6dfab3f33e6b35bb184bd2a51b0fa67421206f2de7ef0b3e7264fe3b35b0a4ff55ef8f76fc1e3c1e77fe99e950081c11dde3232f111d8030800e96f85d1e3e09"} 07:31:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:31:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:31:04 INFO - Contents: 07:31:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/099bce387157c22125b310c4b409d10e744ec14b638a74c81ef2a259e11ba55a47ea40adf84a835eb50b92087f38782f2d1d2514a35adfaf266c6c1099527f24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9a72625c08541c17e0daa1d3eb7ee6c463c2ee56448badb1545f716e6df620943d2668ea7ca0220c4dfb1e62ef5c47bc172954ad5b4e33aaff56a69120627af4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/704340b508429dd503bb42b6fd10574213a161e51270def3b22171a77e8afb9720ba14f880cb2b08b997a61f7622ef45981c950e351900a6198d56a2e76bbb9a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6dfab3f33e6b35bb184bd2a51b0fa67421206f2de7ef0b3e7264fe3b35b0a4ff55ef8f76fc1e3c1e77fe99e950081c11dde3232f111d8030800e96f85d1e3e09"} 07:31:04 INFO - Running post-run listener: copy_logs_to_upload_dir 07:31:04 INFO - Copying logs to upload dir... 07:31:04 INFO - mkdir: /builds/slave/test/build/upload/logs 07:31:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.696824 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-16 07:31:04.153085) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 07:31:04.156854) ========= 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.Cm3zIJ4qDV/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.VUnXXWBzNA/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/099bce387157c22125b310c4b409d10e744ec14b638a74c81ef2a259e11ba55a47ea40adf84a835eb50b92087f38782f2d1d2514a35adfaf266c6c1099527f24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9a72625c08541c17e0daa1d3eb7ee6c463c2ee56448badb1545f716e6df620943d2668ea7ca0220c4dfb1e62ef5c47bc172954ad5b4e33aaff56a69120627af4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/704340b508429dd503bb42b6fd10574213a161e51270def3b22171a77e8afb9720ba14f880cb2b08b997a61f7622ef45981c950e351900a6198d56a2e76bbb9a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6dfab3f33e6b35bb184bd2a51b0fa67421206f2de7ef0b3e7264fe3b35b0a4ff55ef8f76fc1e3c1e77fe99e950081c11dde3232f111d8030800e96f85d1e3e09"} build_url:https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010943 build_url: 'https://queue.taskcluster.net/v1/task/a85NKMESQ5yBCj1bsZSaCw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/099bce387157c22125b310c4b409d10e744ec14b638a74c81ef2a259e11ba55a47ea40adf84a835eb50b92087f38782f2d1d2514a35adfaf266c6c1099527f24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9a72625c08541c17e0daa1d3eb7ee6c463c2ee56448badb1545f716e6df620943d2668ea7ca0220c4dfb1e62ef5c47bc172954ad5b4e33aaff56a69120627af4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/704340b508429dd503bb42b6fd10574213a161e51270def3b22171a77e8afb9720ba14f880cb2b08b997a61f7622ef45981c950e351900a6198d56a2e76bbb9a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6dfab3f33e6b35bb184bd2a51b0fa67421206f2de7ef0b3e7264fe3b35b0a4ff55ef8f76fc1e3c1e77fe99e950081c11dde3232f111d8030800e96f85d1e3e09"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 07:31:04.190715) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 07:31:04.191034) ========= 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.Cm3zIJ4qDV/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.VUnXXWBzNA/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.005304 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 07:31:04.239019) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 07:31:04.239326) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 07:31:04.239657) ========= ========= Total master_lag: 0.19 =========