builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0268 starttime: 1484375820.27 results: success (0) buildid: 20170113220224 builduid: 1e169432424244c390899c65dec09ef7 revision: 6a5da724ef90edf99628489c4d773fcded43eefb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 22:37:00.267769) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 22:37:00.268322) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 22:37:00.268666) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 22:37:00.505510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 22:37:00.505928) ========= 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.RZ2OLxWSHu/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.0XWU1H5XDK/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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-13 22:37:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.26M=0.001s 2017-01-13 22:37:00 (8.26 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.181070 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 22:37:00.718995) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 22:37:00.719279) ========= 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.RZ2OLxWSHu/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.0XWU1H5XDK/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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.020634 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 22:37:00.768338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-13 22:37:00.768649) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 6a5da724ef90edf99628489c4d773fcded43eefb --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 6a5da724ef90edf99628489c4d773fcded43eefb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RZ2OLxWSHu/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.0XWU1H5XDK/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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-13 22:37:00,853 truncating revision to first 12 chars 2017-01-13 22:37:00,853 Setting DEBUG logging. 2017-01-13 22:37:00,853 attempt 1/10 2017-01-13 22:37:00,853 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/6a5da724ef90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-13 22:37:03,248 unpacking tar archive at: graphics-6a5da724ef90/testing/mozharness/ program finished with exit code 0 elapsedTime=2.654676 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-13 22:37:03.446932) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 22:37:03.447304) ========= script_repo_revision: 6a5da724ef90edf99628489c4d773fcded43eefb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 22:37:03.447742) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 22:37:03.448027) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 22:37:03.468346) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-13 22:37:03.468748) ========= /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.RZ2OLxWSHu/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.0XWU1H5XDK/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 22:37:03 INFO - MultiFileLogger online at 20170113 22:37:03 in /builds/slave/test 22:37:03 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 22:37:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:37:03 INFO - {'append_to_log': False, 22:37:03 INFO - 'base_work_dir': '/builds/slave/test', 22:37:03 INFO - 'blob_upload_branch': 'Graphics', 22:37:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:37:03 INFO - 'branch': 'Graphics', 22:37:03 INFO - 'buildbot_json_path': 'buildprops.json', 22:37:03 INFO - 'config_files': ('talos/mac_config.py',), 22:37:03 INFO - 'default_actions': ('clobber', 22:37:03 INFO - 'read-buildbot-config', 22:37:03 INFO - 'download-and-extract', 22:37:03 INFO - 'populate-webroot', 22:37:03 INFO - 'create-virtualenv', 22:37:03 INFO - 'install', 22:37:03 INFO - 'run-tests'), 22:37:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:37:03 INFO - 'download_minidump_stackwalk': True, 22:37:03 INFO - 'download_symbols': 'ondemand', 22:37:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:37:03 INFO - 'tooltool.py': '/tools/tooltool.py', 22:37:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:37:03 INFO - '/tools/misc-python/virtualenv.py')}, 22:37:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:37:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:37:03 INFO - 'installer_path': 'installer.exe', 22:37:03 INFO - 'log_level': 'info', 22:37:03 INFO - 'log_name': 'talos', 22:37:03 INFO - 'log_to_console': True, 22:37:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:37:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:37:03 INFO - 'opt_config_files': (), 22:37:03 INFO - 'pip_index': False, 22:37:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:37:03 INFO - 'cmd': ('bash', 22:37:03 INFO - '-c', 22:37:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:37:03 INFO - 'enabled': True, 22:37:03 INFO - 'halt_on_failure': False, 22:37:03 INFO - 'name': 'check_screen_resolution'},), 22:37:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:37:03 INFO - 'cmd': ('bash', 22:37:03 INFO - '-c', 22:37:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:37:03 INFO - 'enabled': True, 22:37:03 INFO - 'halt_on_failure': False, 22:37:03 INFO - 'name': 'check_screen_resolution'},), 22:37:03 INFO - 'run_cmd_checks_enabled': True, 22:37:03 INFO - 'sps_profile': False, 22:37:03 INFO - 'sps_profile_interval': 0, 22:37:03 INFO - 'suite': 'dromaeojs', 22:37:03 INFO - 'system_bits': '32', 22:37:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:37:03 INFO - 'title': 't-yosemite-r7-0268', 22:37:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:37:03 INFO - 'use_talos_json': True, 22:37:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:37:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:37:03 INFO - 'work_dir': 'build'} 22:37:03 INFO - [mozharness: 2017-01-14 06:37:03.677463Z] Running clobber step. 22:37:03 INFO - Running pre-action listener: _resource_record_pre_action 22:37:03 INFO - Running main action method: clobber 22:37:03 INFO - rmtree: /builds/slave/test/build 22:37:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:37:05 INFO - Running post-action listener: _resource_record_post_action 22:37:05 INFO - [mozharness: 2017-01-14 06:37:05.380484Z] Finished clobber step (success) 22:37:05 INFO - [mozharness: 2017-01-14 06:37:05.380619Z] Running read-buildbot-config step. 22:37:05 INFO - Running pre-action listener: _resource_record_pre_action 22:37:05 INFO - Running main action method: read_buildbot_config 22:37:05 INFO - Using buildbot properties: 22:37:05 INFO - { 22:37:05 INFO - "project": "", 22:37:05 INFO - "product": "firefox", 22:37:05 INFO - "script_repo_revision": "default", 22:37:05 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 22:37:05 INFO - "repository": "", 22:37:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 22:37:05 INFO - "buildid": "20170113220224", 22:37:05 INFO - "pgo_build": "False", 22:37:05 INFO - "basedir": "/builds/slave/test", 22:37:05 INFO - "buildnumber": 5, 22:37:05 INFO - "slavename": "t-yosemite-r7-0268", 22:37:05 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 22:37:05 INFO - "platform": "yosemite_r7", 22:37:05 INFO - "scheduler": "tests-graphics-macosx64-talos", 22:37:05 INFO - "branch": "graphics", 22:37:05 INFO - "repo_path": "projects/graphics", 22:37:05 INFO - "revision": "6a5da724ef90edf99628489c4d773fcded43eefb", 22:37:05 INFO - "stage_platform": "macosx64", 22:37:05 INFO - "builduid": "1e169432424244c390899c65dec09ef7", 22:37:05 INFO - "slavebuilddir": "test" 22:37:05 INFO - } 22:37:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 22:37:05 INFO - Running post-action listener: _resource_record_post_action 22:37:05 INFO - [mozharness: 2017-01-14 06:37:05.383873Z] Finished read-buildbot-config step (success) 22:37:05 INFO - [mozharness: 2017-01-14 06:37:05.384004Z] Running download-and-extract step. 22:37:05 INFO - Running pre-action listener: _resource_record_pre_action 22:37:05 INFO - Running main action method: download_and_extract 22:37:05 INFO - mkdir: /builds/slave/test/build/tests 22:37:05 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')]} 22:37:05 INFO - trying https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 22:37:05 INFO - Downloading https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/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 22:37:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/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 22:37:06 INFO - Downloaded 1199 bytes. 22:37:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 22:37:06 INFO - Using the following test package requirements: 22:37:06 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 22:37:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:37:06 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 22:37:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:37:06 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 22:37:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:37:06 INFO - u'jsshell-mac.zip'], 22:37:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:37:06 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 22:37:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 22:37:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:37:06 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 22:37:06 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:37:06 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 22:37:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:37:06 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 22:37:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:37:06 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 22:37:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:37:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 22:37:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:37:06 INFO - Fetch https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 22:37:07 INFO - Expected file size: 16316967 22:37:07 INFO - Obtained file size: 16316967 22:37:14 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 22:37:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 22:37:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:37:14 INFO - Fetch https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 22:37:15 INFO - Expected file size: 16316967 22:37:15 INFO - Obtained file size: 16316967 22:37:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 22:37:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 22:37:21 INFO - Fetch https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 22:37:22 INFO - Expected file size: 14403555 22:37:22 INFO - Obtained file size: 14403555 22:37:22 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')]} 22:37:22 INFO - trying https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 22:37:22 INFO - Downloading https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 22:37:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/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 22:37:24 INFO - Downloaded 70220546 bytes. 22:37:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 22:37:24 INFO - mkdir: /builds/slave/test/properties 22:37:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:37:24 INFO - Writing to file /builds/slave/test/properties/build_url 22:37:24 INFO - Contents: 22:37:24 INFO - build_url:https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 22:37:25 INFO - Running post-action listener: _resource_record_post_action 22:37:25 INFO - Running post-action listener: set_extra_try_arguments 22:37:25 INFO - [mozharness: 2017-01-14 06:37:25.591104Z] Finished download-and-extract step (success) 22:37:25 INFO - [mozharness: 2017-01-14 06:37:25.591263Z] Running populate-webroot step. 22:37:25 INFO - Running pre-action listener: _resource_record_pre_action 22:37:25 INFO - Running main action method: populate_webroot 22:37:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:37:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:37:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:37:25 INFO - '--tppagecycles', 22:37:25 INFO - '7'], 22:37:25 INFO - 'tests': ['tsvgm']}}, 22:37:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:37:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:37:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:37:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:37:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:37:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:37:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:37:25 INFO - 'talos_options': ['--disable-e10s'], 22:37:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:37:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:37:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:37:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:37:25 INFO - 'talos_options': ['--disable-e10s'], 22:37:25 INFO - 'tests': ['damp', 'tps']}, 22:37:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:37:25 INFO - 'tests': ['damp', 'tps']}, 22:37:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:37:25 INFO - 'tests': ['dromaeo_dom']}, 22:37:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:37:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:37:25 INFO - 'tests': ['basic_compositor_video']}, 22:37:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:37:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:37:25 INFO - 'tests': ['a11yr', 22:37:25 INFO - 'ts_paint', 22:37:25 INFO - 'tpaint', 22:37:25 INFO - 'sessionrestore', 22:37:25 INFO - 'sessionrestore_no_auto_restore', 22:37:25 INFO - 'tabpaint']}, 22:37:25 INFO - 'other-e10s': {'tests': ['a11yr', 22:37:25 INFO - 'ts_paint', 22:37:25 INFO - 'tpaint', 22:37:25 INFO - 'sessionrestore', 22:37:25 INFO - 'sessionrestore_no_auto_restore', 22:37:25 INFO - 'tabpaint']}, 22:37:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:37:25 INFO - 'ts_paint', 22:37:25 INFO - 'tpaint', 22:37:25 INFO - 'sessionrestore', 22:37:25 INFO - 'sessionrestore_no_auto_restore', 22:37:25 INFO - 'tabpaint']}, 22:37:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:37:25 INFO - 'ts_paint', 22:37:25 INFO - 'tpaint', 22:37:25 INFO - 'sessionrestore', 22:37:25 INFO - 'sessionrestore_no_auto_restore', 22:37:25 INFO - 'tabpaint']}, 22:37:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:37:25 INFO - 'tests': ['a11yr', 22:37:25 INFO - 'ts_paint', 22:37:25 INFO - 'tpaint', 22:37:25 INFO - 'sessionrestore', 22:37:25 INFO - 'sessionrestore_no_auto_restore', 22:37:25 INFO - 'tabpaint']}, 22:37:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:37:25 INFO - 'tests': ['a11yr', 22:37:25 INFO - 'ts_paint', 22:37:25 INFO - 'tpaint', 22:37:25 INFO - 'sessionrestore', 22:37:25 INFO - 'sessionrestore_no_auto_restore', 22:37:25 INFO - 'tabpaint']}, 22:37:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:37:25 INFO - 'tests': ['tsvgx', 22:37:25 INFO - 'tsvgr_opacity', 22:37:25 INFO - 'tart', 22:37:25 INFO - 'tscrollx', 22:37:25 INFO - 'cart', 22:37:25 INFO - 'tsvg_static']}, 22:37:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:37:25 INFO - 'tsvgr_opacity', 22:37:25 INFO - 'tart', 22:37:25 INFO - 'tscrollx', 22:37:25 INFO - 'cart', 22:37:25 INFO - 'tsvg_static']}, 22:37:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:37:25 INFO - 'talos_options': ['--disable-e10s'], 22:37:25 INFO - 'tests': ['tp5o']}, 22:37:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:37:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:37:25 INFO - 'talos_options': ['--disable-e10s', 22:37:25 INFO - '--xperf_path', 22:37:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:37:25 INFO - 'tests': ['tp5n']}, 22:37:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:37:25 INFO - 'talos_options': ['--xperf_path', 22:37:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:37:25 INFO - 'tests': ['tp5n']}}, 22:37:25 INFO - 'talos.zip': {'path': '', 22:37:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:37:25 INFO - Running post-action listener: _resource_record_post_action 22:37:25 INFO - [mozharness: 2017-01-14 06:37:25.609917Z] Finished populate-webroot step (success) 22:37:25 INFO - [mozharness: 2017-01-14 06:37:25.610050Z] Running create-virtualenv step. 22:37:25 INFO - Running pre-action listener: _resource_record_pre_action 22:37:25 INFO - Running main action method: create_virtualenv 22:37:25 INFO - Creating virtualenv /builds/slave/test/build/venv 22:37:25 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 22:37:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:37:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:37:25 INFO - Using real prefix '/tools/python27' 22:37:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:37:26 INFO - Installing distribute.............................................................................................................................................................................................done. 22:37:29 INFO - Installing pip.................done. 22:37:29 INFO - Return code: 0 22:37:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:37:29 INFO - Reading from file tmpfile_stdout 22:37:29 INFO - Output received: 22:37:29 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) 22:37:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:29 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 0x101e1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc0ce8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfdd30>, '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 0x101b24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf2be8>, '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.RZ2OLxWSHu/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.0XWU1H5XDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 22:37:29 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 22:37:29 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 22:37:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ2OLxWSHu/Render', 22:37:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:37:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:37:29 INFO - 'HOME': '/Users/cltbld', 22:37:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:37:29 INFO - 'LOGNAME': 'cltbld', 22:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:29 INFO - 'MOZ_NO_REMOTE': '1', 22:37:29 INFO - 'NO_EM_RESTART': '1', 22:37:29 INFO - 'PAGER': '/bin/cat', 22:37:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:29 INFO - 'PWD': '/builds/slave/test', 22:37:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:37:29 INFO - 'SHELL': '/bin/bash', 22:37:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XWU1H5XDK/Listeners', 22:37:29 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 22:37:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:37:29 INFO - 'USER': 'cltbld', 22:37:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:37:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:29 INFO - 'XPC_FLAGS': '0x0', 22:37:29 INFO - 'XPC_SERVICE_NAME': '0', 22:37:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:29 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 22:37:29 INFO - Cleaning up... 22:37:29 INFO - Return code: 0 22:37:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:29 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 0x101e1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc0ce8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfdd30>, '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 0x101b24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf2be8>, '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.RZ2OLxWSHu/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.0XWU1H5XDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 22:37:29 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 22:37:29 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 22:37:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ2OLxWSHu/Render', 22:37:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:37:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:37:29 INFO - 'HOME': '/Users/cltbld', 22:37:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:37:29 INFO - 'LOGNAME': 'cltbld', 22:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:29 INFO - 'MOZ_NO_REMOTE': '1', 22:37:29 INFO - 'NO_EM_RESTART': '1', 22:37:29 INFO - 'PAGER': '/bin/cat', 22:37:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:29 INFO - 'PWD': '/builds/slave/test', 22:37:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:37:29 INFO - 'SHELL': '/bin/bash', 22:37:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XWU1H5XDK/Listeners', 22:37:29 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 22:37:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:37:29 INFO - 'USER': 'cltbld', 22:37:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:37:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:29 INFO - 'XPC_FLAGS': '0x0', 22:37:29 INFO - 'XPC_SERVICE_NAME': '0', 22:37:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:30 INFO - Downloading/unpacking psutil>=3.1.1 22:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:37:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:37:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:37:34 INFO - Installing collected packages: psutil 22:37:34 INFO - Running setup.py install for psutil 22:37:34 INFO - building 'psutil._psutil_osx' extension 22:37:34 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 22:37:34 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 22:37:34 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 22:37:34 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 22:37:34 INFO - building 'psutil._psutil_posix' extension 22:37:34 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 22:37:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:37:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:37:34 INFO - ^ 22:37:34 INFO - 1 warning generated. 22:37:34 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 22:37:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:37:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:37:34 INFO - Successfully installed psutil 22:37:34 INFO - Cleaning up... 22:37:35 INFO - Return code: 0 22:37:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc0ce8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfdd30>, '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 0x101b24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf2be8>, '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.RZ2OLxWSHu/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.0XWU1H5XDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 22:37:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:37:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ2OLxWSHu/Render', 22:37:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:37:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:37:35 INFO - 'HOME': '/Users/cltbld', 22:37:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:37:35 INFO - 'LOGNAME': 'cltbld', 22:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:35 INFO - 'MOZ_NO_REMOTE': '1', 22:37:35 INFO - 'NO_EM_RESTART': '1', 22:37:35 INFO - 'PAGER': '/bin/cat', 22:37:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:35 INFO - 'PWD': '/builds/slave/test', 22:37:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:37:35 INFO - 'SHELL': '/bin/bash', 22:37:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XWU1H5XDK/Listeners', 22:37:35 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 22:37:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:37:35 INFO - 'USER': 'cltbld', 22:37:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:37:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:35 INFO - 'XPC_FLAGS': '0x0', 22:37:35 INFO - 'XPC_SERVICE_NAME': '0', 22:37:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:37:37 INFO - Installing collected packages: mozsystemmonitor 22:37:37 INFO - Running setup.py install for mozsystemmonitor 22:37:38 INFO - Successfully installed mozsystemmonitor 22:37:38 INFO - Cleaning up... 22:37:38 INFO - Return code: 0 22:37:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:37:38 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')]} 22:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:38 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')]} 22:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:38 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 0x101e1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc0ce8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfdd30>, '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 0x101b24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf2be8>, '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.RZ2OLxWSHu/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.0XWU1H5XDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 22:37:38 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 22:37:38 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 22:37:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ2OLxWSHu/Render', 22:37:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:37:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:37:38 INFO - 'HOME': '/Users/cltbld', 22:37:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:37:38 INFO - 'LOGNAME': 'cltbld', 22:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:38 INFO - 'MOZ_NO_REMOTE': '1', 22:37:38 INFO - 'NO_EM_RESTART': '1', 22:37:38 INFO - 'PAGER': '/bin/cat', 22:37:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:38 INFO - 'PWD': '/builds/slave/test', 22:37:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:37:38 INFO - 'SHELL': '/bin/bash', 22:37:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XWU1H5XDK/Listeners', 22:37:38 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 22:37:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:37:38 INFO - 'USER': 'cltbld', 22:37:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:37:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:38 INFO - 'XPC_FLAGS': '0x0', 22:37:38 INFO - 'XPC_SERVICE_NAME': '0', 22:37:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:38 INFO - Downloading/unpacking jsonschema==2.5.1 22:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:37:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:37:41 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 22:37:41 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 22:37:41 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 22:37:41 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 22:37:41 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 22:37:41 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 22:37:41 INFO - Downloading functools32-3.2.3-2.tar.gz 22:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:37:41 INFO - warning: no files found matching '*.txt' 22:37:41 INFO - no previously-included directories found matching 'build' 22:37:41 INFO - no previously-included directories found matching 'dist' 22:37:41 INFO - no previously-included directories found matching '.git*' 22:37:41 INFO - Installing collected packages: jsonschema, functools32 22:37:41 INFO - Running setup.py install for functools32 22:37:41 INFO - warning: no files found matching '*.txt' 22:37:41 INFO - no previously-included directories found matching 'build' 22:37:41 INFO - no previously-included directories found matching 'dist' 22:37:41 INFO - no previously-included directories found matching '.git*' 22:37:41 INFO - Successfully installed jsonschema functools32 22:37:41 INFO - Cleaning up... 22:37:41 INFO - Return code: 0 22:37:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:41 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 0x101e1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc0ce8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfdd30>, '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 0x101b24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf2be8>, '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.RZ2OLxWSHu/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.0XWU1H5XDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 22:37:41 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 22:37:41 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 22:37:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ2OLxWSHu/Render', 22:37:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:37:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:37:41 INFO - 'HOME': '/Users/cltbld', 22:37:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:37:41 INFO - 'LOGNAME': 'cltbld', 22:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:41 INFO - 'MOZ_NO_REMOTE': '1', 22:37:41 INFO - 'NO_EM_RESTART': '1', 22:37:41 INFO - 'PAGER': '/bin/cat', 22:37:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:41 INFO - 'PWD': '/builds/slave/test', 22:37:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:37:41 INFO - 'SHELL': '/bin/bash', 22:37:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XWU1H5XDK/Listeners', 22:37:41 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 22:37:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:37:41 INFO - 'USER': 'cltbld', 22:37:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:37:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:41 INFO - 'XPC_FLAGS': '0x0', 22:37:41 INFO - 'XPC_SERVICE_NAME': '0', 22:37:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:37:42 INFO - Cleaning up... 22:37:42 INFO - Return code: 0 22:37:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:37:42 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')]} 22:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:42 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')]} 22:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:42 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 0x101e1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc0ce8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfdd30>, '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 0x101b24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf2be8>, '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.RZ2OLxWSHu/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.0XWU1H5XDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 22:37:42 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 22:37:42 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 22:37:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ2OLxWSHu/Render', 22:37:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:37:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:37:42 INFO - 'HOME': '/Users/cltbld', 22:37:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:37:42 INFO - 'LOGNAME': 'cltbld', 22:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:42 INFO - 'MOZ_NO_REMOTE': '1', 22:37:42 INFO - 'NO_EM_RESTART': '1', 22:37:42 INFO - 'PAGER': '/bin/cat', 22:37:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:42 INFO - 'PWD': '/builds/slave/test', 22:37:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:37:42 INFO - 'SHELL': '/bin/bash', 22:37:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XWU1H5XDK/Listeners', 22:37:42 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 22:37:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:37:42 INFO - 'USER': 'cltbld', 22:37:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:37:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:42 INFO - 'XPC_FLAGS': '0x0', 22:37:42 INFO - 'XPC_SERVICE_NAME': '0', 22:37:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:42 INFO - Downloading/unpacking blobuploader==1.2.4 22:37:42 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 22:37:42 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 22:37:42 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 22:37:42 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 22:37:42 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 22:37:42 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 22:37:45 INFO - Downloading blobuploader-1.2.4.tar.gz 22:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:37:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:37:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:46 INFO - Downloading docopt-0.6.1.tar.gz 22:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:37:46 INFO - Installing collected packages: blobuploader, requests, docopt 22:37:46 INFO - Running setup.py install for blobuploader 22:37:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:37:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:37:46 INFO - Running setup.py install for requests 22:37:46 INFO - Running setup.py install for docopt 22:37:47 INFO - Successfully installed blobuploader requests docopt 22:37:47 INFO - Cleaning up... 22:37:47 INFO - Return code: 0 22:37:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:47 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 0x101e1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc0ce8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfdd30>, '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 0x101b24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf2be8>, '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.RZ2OLxWSHu/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.0XWU1H5XDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 22:37:47 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 22:37:47 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 22:37:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ2OLxWSHu/Render', 22:37:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:37:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:37:47 INFO - 'HOME': '/Users/cltbld', 22:37:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:37:47 INFO - 'LOGNAME': 'cltbld', 22:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:47 INFO - 'MOZ_NO_REMOTE': '1', 22:37:47 INFO - 'NO_EM_RESTART': '1', 22:37:47 INFO - 'PAGER': '/bin/cat', 22:37:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:47 INFO - 'PWD': '/builds/slave/test', 22:37:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:37:47 INFO - 'SHELL': '/bin/bash', 22:37:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XWU1H5XDK/Listeners', 22:37:47 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 22:37:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:37:47 INFO - 'USER': 'cltbld', 22:37:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:37:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:47 INFO - 'XPC_FLAGS': '0x0', 22:37:47 INFO - 'XPC_SERVICE_NAME': '0', 22:37:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:37:47 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-E41gb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:37:47 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-IqfYkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:37:47 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-iI9FhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:37:47 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-CxuqJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:37:47 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-z8ypFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:37:48 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-0eg21O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:37:48 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-LbjOpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:37:48 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-2qpWjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:37:48 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-opfQ_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:37:48 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-QlyZst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:37:48 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-qdWxHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:37:48 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-n1avmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:37:48 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-IfHpI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:37:48 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Yx7icD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:37:48 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-oSeEJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:37:49 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-G5rsb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:37:49 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-35DsrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:37:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:37:49 INFO - Running setup.py install for manifestparser 22:37:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:37:49 INFO - Running setup.py install for mozcrash 22:37:49 INFO - Running setup.py install for mozdebug 22:37:49 INFO - Running setup.py install for mozdevice 22:37:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:37:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:37:49 INFO - Running setup.py install for mozfile 22:37:50 INFO - Running setup.py install for mozhttpd 22:37:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:37:50 INFO - Running setup.py install for mozinfo 22:37:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:37:50 INFO - Running setup.py install for mozInstall 22:37:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:37:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:37:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:37:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:37:50 INFO - Running setup.py install for mozleak 22:37:50 INFO - Running setup.py install for mozlog 22:37:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:37:50 INFO - Running setup.py install for moznetwork 22:37:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:37:50 INFO - Running setup.py install for mozprocess 22:37:51 INFO - Running setup.py install for mozprofile 22:37:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:37:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:37:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:37:51 INFO - Running setup.py install for mozrunner 22:37:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:37:51 INFO - Running setup.py install for mozscreenshot 22:37:51 INFO - Running setup.py install for moztest 22:37:51 INFO - Running setup.py install for mozversion 22:37:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:37:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:37:51 INFO - Cleaning up... 22:37:51 INFO - Return code: 0 22:37:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc0ce8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfdd30>, '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 0x101b24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf2be8>, '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.RZ2OLxWSHu/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.0XWU1H5XDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 22:37:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:37:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ2OLxWSHu/Render', 22:37:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:37:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:37:51 INFO - 'HOME': '/Users/cltbld', 22:37:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:37:51 INFO - 'LOGNAME': 'cltbld', 22:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:51 INFO - 'MOZ_NO_REMOTE': '1', 22:37:51 INFO - 'NO_EM_RESTART': '1', 22:37:51 INFO - 'PAGER': '/bin/cat', 22:37:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:51 INFO - 'PWD': '/builds/slave/test', 22:37:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:37:51 INFO - 'SHELL': '/bin/bash', 22:37:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XWU1H5XDK/Listeners', 22:37:51 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 22:37:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:37:51 INFO - 'USER': 'cltbld', 22:37:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:37:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:51 INFO - 'XPC_FLAGS': '0x0', 22:37:51 INFO - 'XPC_SERVICE_NAME': '0', 22:37:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:37:52 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-QEVc7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:37:52 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)) 22:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:37:52 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-BQ13D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:37:52 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)) 22:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:37:52 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-AzcZEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:37:52 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)) 22:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:37:52 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Jyq91H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:37:52 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)) 22:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:37:52 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-E7uf53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:37:52 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)) 22:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:37:52 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-siOLCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:37:52 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-hZr3Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:37:52 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-uXc7EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:37:52 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-hmhWzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:37:53 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)) 22:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:37:53 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-CoOQ7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:37:53 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)) 22:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:37:53 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-SN0mZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:37:53 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)) 22:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:37:53 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-vIt_Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:37:53 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)) 22:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:37:53 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-6sOxbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:37:53 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)) 22:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:37:53 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-ypZUS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:37:53 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)) 22:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:37:53 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-fbXEHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:37:53 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)) 22:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:37:53 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-1XvLqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:37:53 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-n5KJim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:37:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:56 INFO - Downloading blessings-1.6.tar.gz 22:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:37:56 INFO - Installing collected packages: blessings 22:37:56 INFO - Running setup.py install for blessings 22:37:56 INFO - Successfully installed blessings 22:37:56 INFO - Cleaning up... 22:37:56 INFO - Return code: 0 22:37:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:37:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:37:57 INFO - Reading from file tmpfile_stdout 22:37:57 INFO - Current package versions: 22:37:57 INFO - blessings == 1.6 22:37:57 INFO - blobuploader == 1.2.4 22:37:57 INFO - docopt == 0.6.1 22:37:57 INFO - functools32 == 3.2.3-2 22:37:57 INFO - jsonschema == 2.5.1 22:37:57 INFO - manifestparser == 1.1 22:37:57 INFO - mozInstall == 1.12 22:37:57 INFO - mozcrash == 1.0 22:37:57 INFO - mozdebug == 0.1 22:37:57 INFO - mozdevice == 0.49 22:37:57 INFO - mozfile == 1.2 22:37:57 INFO - mozhttpd == 0.7 22:37:57 INFO - mozinfo == 0.9 22:37:57 INFO - mozleak == 0.1 22:37:57 INFO - mozlog == 3.4 22:37:57 INFO - moznetwork == 0.27 22:37:57 INFO - mozprocess == 0.24 22:37:57 INFO - mozprofile == 0.28 22:37:57 INFO - mozrunner == 6.13 22:37:57 INFO - mozscreenshot == 0.1 22:37:57 INFO - mozsystemmonitor == 0.3 22:37:57 INFO - moztest == 0.8 22:37:57 INFO - mozversion == 1.4 22:37:57 INFO - psutil == 3.1.1 22:37:57 INFO - requests == 1.2.3 22:37:57 INFO - wsgiref == 0.1.2 22:37:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:37:57 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')]} 22:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:57 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')]} 22:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:57 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 0x101e1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc0ce8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfdd30>, '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 0x101b24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf2be8>, '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.RZ2OLxWSHu/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.0XWU1H5XDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 22:37:57 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 22:37:57 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 22:37:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ2OLxWSHu/Render', 22:37:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:37:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:37:57 INFO - 'HOME': '/Users/cltbld', 22:37:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:37:57 INFO - 'LOGNAME': 'cltbld', 22:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:57 INFO - 'MOZ_NO_REMOTE': '1', 22:37:57 INFO - 'NO_EM_RESTART': '1', 22:37:57 INFO - 'PAGER': '/bin/cat', 22:37:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:57 INFO - 'PWD': '/builds/slave/test', 22:37:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:37:57 INFO - 'SHELL': '/bin/bash', 22:37:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XWU1H5XDK/Listeners', 22:37:57 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 22:37:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:37:57 INFO - 'USER': 'cltbld', 22:37:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:37:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:57 INFO - 'XPC_FLAGS': '0x0', 22:37:57 INFO - 'XPC_SERVICE_NAME': '0', 22:37:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:57 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)) 22:37:57 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)) 22:37:57 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)) 22:37:57 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)) 22:37:57 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)) 22:37:57 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)) 22:37:57 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)) 22:37:57 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)) 22:37:57 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)) 22:37:57 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)) 22:37:57 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)) 22:37:57 INFO - Cleaning up... 22:37:57 INFO - Return code: 0 22:37:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:37:57 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')]} 22:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:57 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')]} 22:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:57 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 0x101e1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc0ce8c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfdd30>, '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 0x101b24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf2be8>, '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.RZ2OLxWSHu/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.0XWU1H5XDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 22:37:57 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 22:37:57 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 22:37:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ2OLxWSHu/Render', 22:37:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:37:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:37:57 INFO - 'HOME': '/Users/cltbld', 22:37:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:37:57 INFO - 'LOGNAME': 'cltbld', 22:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:57 INFO - 'MOZ_NO_REMOTE': '1', 22:37:57 INFO - 'NO_EM_RESTART': '1', 22:37:57 INFO - 'PAGER': '/bin/cat', 22:37:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:57 INFO - 'PWD': '/builds/slave/test', 22:37:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:37:57 INFO - 'SHELL': '/bin/bash', 22:37:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XWU1H5XDK/Listeners', 22:37:57 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 22:37:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:37:57 INFO - 'USER': 'cltbld', 22:37:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:37:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:57 INFO - 'XPC_FLAGS': '0x0', 22:37:57 INFO - 'XPC_SERVICE_NAME': '0', 22:37:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:37:57 INFO - Cleaning up... 22:37:57 INFO - Return code: 0 22:37:57 INFO - Running post-action listener: _resource_record_post_action 22:37:57 INFO - Running post-action listener: _start_resource_monitoring 22:37:57 INFO - Starting resource monitoring. 22:37:57 INFO - [mozharness: 2017-01-14 06:37:57.808534Z] Finished create-virtualenv step (success) 22:37:57 INFO - [mozharness: 2017-01-14 06:37:57.809555Z] Running install step. 22:37:57 INFO - Running pre-action listener: _resource_record_pre_action 22:37:57 INFO - Running main action method: install 22:37:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:37:58 INFO - Reading from file tmpfile_stdout 22:37:58 INFO - Detecting whether we're running mozinstall >=1.0... 22:37:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:37:58 INFO - Reading from file tmpfile_stdout 22:37:58 INFO - Output received: 22:37:58 INFO - Usage: mozinstall [options] installer 22:37:58 INFO - Options: 22:37:58 INFO - -h, --help show this help message and exit 22:37:58 INFO - -d DEST, --destination=DEST 22:37:58 INFO - Directory to install application into. [default: 22:37:58 INFO - "/builds/slave/test"] 22:37:58 INFO - --app=APP Application being installed. [default: firefox] 22:37:58 INFO - mkdir: /builds/slave/test/build/application 22:37:58 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'] 22:37:58 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 22:38:19 INFO - Reading from file tmpfile_stdout 22:38:19 INFO - Output received: 22:38:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:38:19 INFO - Running post-action listener: _resource_record_post_action 22:38:19 INFO - [mozharness: 2017-01-14 06:38:19.868254Z] Finished install step (success) 22:38:19 INFO - [mozharness: 2017-01-14 06:38:19.868405Z] Running run-tests step. 22:38:19 INFO - Running pre-action listener: _resource_record_pre_action 22:38:19 INFO - Running main action method: run_tests 22:38:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:38:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:38:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:38:19 INFO - 2017-01-13 22:38:19.881 screenresolution[1926:13243] starting screenresolution argv=screenresolution get 22:38:19 INFO - 2017-01-13 22:38:19.883 screenresolution[1926:13243] Display 0: 1600x1200x32@60 22:38:19 INFO - 2017-01-13 22:38:19.888 screenresolution[1927:13246] starting screenresolution argv=screenresolution list 22:38:19 INFO - Available Modes on Display 0 22:38:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:38:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:38:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:38:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:38:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:38:20 INFO - Intel Iris: 22:38:20 INFO - Chipset Model: Intel Iris 22:38:20 INFO - Type: GPU 22:38:20 INFO - Bus: Built-In 22:38:20 INFO - VRAM (Dynamic, Max): 1536 MB 22:38:20 INFO - Vendor: Intel (0x8086) 22:38:20 INFO - Device ID: 0x0a2e 22:38:20 INFO - Revision ID: 0x0009 22:38:20 INFO - Displays: 22:38:20 INFO - Display: 22:38:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:38:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:38:20 INFO - Display Serial Number: 1600x1200 60 22:38:20 INFO - Main Display: Yes 22:38:20 INFO - Mirror: Off 22:38:20 INFO - Online: Yes 22:38:20 INFO - Rotation: Supported 22:38:20 INFO - Return code: 0 22:38:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:38:20 INFO - Python 2.7.3 22:38:20 INFO - Return code: 0 22:38:20 INFO - grabbing minidump binary from tooltool 22:38: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')]} 22:38:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfdd30>, '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 0x101b24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:38:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:38:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 22:38:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:38:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:38:20 INFO - Return code: 0 22:38:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:38:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:38:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:38:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:38:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:38:20 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/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0268', '--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 22:38:20 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/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0268 --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 22:38:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ2OLxWSHu/Render', 22:38:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:38:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:38:20 INFO - 'HOME': '/Users/cltbld', 22:38:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:38:20 INFO - 'LOGNAME': 'cltbld', 22:38:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:38:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:20 INFO - 'MOZ_NO_REMOTE': '1', 22:38:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:38:20 INFO - 'NO_EM_RESTART': '1', 22:38:20 INFO - 'PAGER': '/bin/cat', 22:38:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:20 INFO - 'PWD': '/builds/slave/test', 22:38:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:38:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:38:20 INFO - 'SHELL': '/bin/bash', 22:38:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XWU1H5XDK/Listeners', 22:38:20 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 22:38:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:38:20 INFO - 'USER': 'cltbld', 22:38:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:38:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:20 INFO - 'XPC_FLAGS': '0x0', 22:38:20 INFO - 'XPC_SERVICE_NAME': '0', 22:38:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:38:20 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/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0268', '--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 22:38:20 INFO - mozversion application_buildid: 20170113220224 22:38:20 INFO - mozversion application_changeset: 6a5da724ef90edf99628489c4d773fcded43eefb 22:38:20 INFO - mozversion application_display_name: Nightly 22:38:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:38:20 INFO - mozversion application_name: Firefox 22:38:20 INFO - mozversion application_remotingname: firefox 22:38:20 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 22:38:20 INFO - mozversion application_vendor: Mozilla 22:38:20 INFO - mozversion application_version: 53.0a1 22:38:20 INFO - mozversion platform_buildid: 20170113220224 22:38:20 INFO - mozversion platform_changeset: 6a5da724ef90edf99628489c4d773fcded43eefb 22:38:20 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 22:38:20 INFO - mozversion platform_version: 53.0a1 22:38:20 INFO - using testdate: 1484375900 22:38:20 INFO - actual date: 1484375900 22:38:20 INFO - starting webserver on 'localhost:49415' 22:38:20 INFO - SUITE-START | Running 2 tests 22:38:20 INFO - TEST-START | dromaeo_css 22:38:20 INFO - operating with platform_type : mac_ 22:38:20 INFO - Initialising browser for dromaeo_css test... 22:38:20 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpmJydWh/profile http://localhost:49415/getInfo.html) 22:38:22 INFO - PROCESS | 1937 | __metrics Screen width/height:1600/1200 22:38:22 INFO - PROCESS | 1937 | colorDepth:24 22:38:22 INFO - PROCESS | 1937 | Browser inner width/height: 1024/689 22:38:22 INFO - PROCESS | 1937 | __metrics 22:38:22 INFO - PROCESS | 1937 | 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" 22:38:22 INFO - PROCESS | 1937 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:38:23 INFO - TEST-INFO | 1937: exit 0 22:38:23 INFO - Browser initialized. 22:38:23 INFO - Running cycle 1/1 for dromaeo_css test... 22:38:23 INFO - TEST-INFO | started process 1940 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpmJydWh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:38:35 INFO - PROCESS | 1940 | RSS: Main: 235368448 22:38:35 INFO - PROCESS | 1940 | 22:41:40 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49415/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49415/tests/dromaeo/cssquery-ext.html) 22:41:41 INFO - PROCESS | 1940 | RSS: Main: 402829312 22:41:41 INFO - PROCESS | 1940 | 22:43:25 INFO - PROCESS | 1940 | ************************* 22:43:25 INFO - PROCESS | 1940 | A coding exception was thrown and uncaught in a Task. 22:43:25 INFO - PROCESS | 1940 | 22:43:25 ERROR - PROCESS | 1940 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:43:25 INFO - PROCESS | 1940 | Full stack: 22:43:25 INFO - PROCESS | 1940 | ************************* 22:44:44 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49415/tests/dromaeo/cssquery-ext.html (next: http://localhost:49415/tests/dromaeo/cssquery-jquery.html) 22:44:45 INFO - PROCESS | 1940 | RSS: Main: 364601344 22:44:45 INFO - PROCESS | 1940 | 22:47:47 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49415/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49415/tests/dromaeo/cssquery-mootools.html) 22:47:48 INFO - PROCESS | 1940 | RSS: Main: 359411712 22:47:48 INFO - PROCESS | 1940 | 22:50:50 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49415/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49415/tests/dromaeo/cssquery-prototype.html) 22:50:51 INFO - PROCESS | 1940 | RSS: Main: 330096640 22:50:51 INFO - PROCESS | 1940 | 22:53:55 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49415/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49415/tests/dromaeo/cssquery-yui.html) 22:53:55 INFO - PROCESS | 1940 | RSS: Main: 331329536 22:53:55 INFO - PROCESS | 1940 | 22:56:58 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49415/tests/dromaeo/cssquery-yui.html (next: http://localhost:49415/tests/dromaeo/cssquery-dojo.html) 22:56:59 INFO - PROCESS | 1940 | RSS: Main: 388182016 22:56:59 INFO - PROCESS | 1940 | 22:56:59 INFO - PROCESS | 1940 | __start_tp_report 22:56:59 INFO - PROCESS | 1940 | _x_x_mozilla_page_load 22:56:59 INFO - PROCESS | 1940 | _x_x_mozilla_page_load_details 22:56:59 INFO - PROCESS | 1940 | |i|pagename|runs| 22:56:59 INFO - PROCESS | 1940 | |0;dojo.html;3309.189248634085;3327.3345330933803;3329.26756113655;3348.2131699050733;3387.6442973487783;5523.696196709179;5529.364123125842;5598.608097433176;5626.352969408519;5665.745041473138;5615.326160860693;5645.350784659765;5658.462446067617;5664.603477756558;5665.206871038058;5106.948930510703;5125.692458452486;5151.562117220041;5154;5188.325517682715;5229.947700522984;5235.6596821206695;5238.083335416306;5240.056789777838;5240.737963101848;5241.50205730455;5242.868928276805;5250.081235783741;5251.684898906059;5252.763625636836;5234.319538459995;5235.319408476912;5236.952609478081;5238.240455134022;5263.815766448156;5056.014077254937;5128.871778205537;5186.481351864821;5186.507281808223;5197.454267301954;5598.944010559923;5627.521660658849;5671.886562268773;5739.684317362543;5741.799037033726;6075.392460753934;6142.754289828402;6190.938090619126;6240.500759939239;6244.219472565929;5137.717425541594;6102.761931713813;6219.2847822500535;6227.937720622781;6262.906056409158;5778.219940308089;5784.768609255667;5789.131630255495;5796.42035796417;5809.331926828384;6322.557420980487;6332.905006424908;6336.968315158487;6338.524610654219;6340.302566717657;5933.3769954154195;5973.611715238582;5993.760249589967;6048.455638992512;6130.448259656652;6229.96885015572;6236.563440559117;6241.875162496815;6254.124422580842;6254.749810007549;6079.939200608026;6197.5351848611535;6211.503079753699;6224.595401298901;6245.718942647592;6045.818625441244;6088.482478989247;6116.785912493041;6228.190335256388;6240.9702399103635;4913.140200464976;4949.529794669501;4970.254461830755;4973.303737476756;5007.84819491519;4393.648508119343;4398.296272596369;4408.691391602557;4414.492333381702;4446.710963787344;5678.545716342683;5727.770889164387;5728.140778883201;5771.538276937835;5796.739146738407;6075.878482430327;6104.877902441926;6113.93006223909;6149.262088549313;6195.845103872439;5818.679972601548;5820.185174075633;5836.387179346192;5843.503302219274;5856.12158176277;5298.947010529922;5359;5366.570674346043;5393.083175860034;5456.127019676833;6280;6344.365563443619;6345.936540634627;6361.491080713439;6393.840153996187;6110.7555697771595;6121.300552271563;6290.370962903856;6290.811275661737;6318.747250110128;6239.625622462667;6257.1552840367785;6275.623462592259;6283.937160628335;6284.622922624657;6180.505559555315;6202.689865506616;6208.317085120723;6211.534134939988;6215.409536094064;6257.342978987323;6265.404786545271;6277.15258440123;6278.591891527036;6281.59169653971;5796.94203057964;5836.533077353716;5866.853328666647;5989.490893273946;6074;5960.523158147251;6002.219711437485;6010.068439391901;6014.969925150346;6031.4270144336215;5877.588568800143;5926.525877929669;5943.554233432424;5969.134475501115;6008.759649613967;6120.846978825565;6121.296050954197;6130.049842274455;6134.938650613437;6135.355787642234;5880.647161170344;5890.175375447527;5900.291964964232;5902.321233058082;5910.1134829774155 22:56:59 INFO - PROCESS | 1940 | |1;ext.html;451.2982312504057;499.92017242755645;503.8285985084679;524.6615932723394;539.8515408262725;29478.557821632665;38075.80962095189;39348.21303573927;39547.60452395475;41287;40701.389479157835;41088;41128.32665876716;41132.79433602835;41147.177056458924;7974.840503189962;8898.555072246394;9095.226905713022;9111.863322050174;9113.134252246025;8047;10805.297655652357;11022.228444008922;11022.50398732055;11199;11010.064144547723;11096.167787415936;11105.056070233999;11113.666590002273;11121.388323642197;8130.634121464548;8331;10646.201534884915;11043.503042363112;11121.27711698741;10707.946460267649;10915.962983516552;10923.344599323986;10924.180686448548;10968.903109689047;38575.42136867949;38946;38996;39014.414783778266;39029.804850975845;3975.1652153047894;3985.561588225293;4011.2579172853116;4027.637512623878;4049.2306461772464;23770.88114559416;29359;29444.263893402836;29751.851240743876;30136.397272054437;2714.1043455659583;3129.702678245563;3140.5917230759856;3154.5678321957457;3172.762042846796;448250;448266;448474.757626213;449955.75022125005;449976;56111.43888561144;56415;56416.43583564194;56451.71774141185;56601.867962640514;59960.700196498736;60021.099683504784;60032;60046.69976650089;60091.798164036474;15515.534533963999;15728.977616454893;15768.369265229263;15773.605659858365;15781.763273550905;10868.836967445495;11145.498452569655;12059.879401205875;12377.195482293622;12392;14715.043522171025;14938.775918361232;15137.318820653098;15178.772318415233;15193.62015949588;6534.934650653528;7370.336669699753;7410.370118539984;7506.361959233417;7560.659770310349;862.5083702289635;867.197841996151;903.7333986474006;911.7948461596088;916.0884919505135;25284.36789080251;29530.44918980129;29656.851715741283;29995.700042999728;30418.84790576033;938.9718258506924;996.7707427291764;1042.1558537584428;1087.3367245979946;1203.3141109567637;14708.117512949257;15162.469313573973;15212.923935380251;15518.612034699223;15547.844521554865;613690;614749;615103;615814;619394;57484.42515574791;57646;57755.71122144363;57761.71119144378;57809;1382.163790906487;1437.4681367893945;1450.173401161328;1454.8472410396967;1460.1385182742022;27907.720922791323;27986.58020129659;28801;29582.408351833274;29618.963336283126;47936.7603161982;49423.50576494333;49677;52037;52117;564224;567861;570791;573850.1307493435;574876;23800.166994155123;24066.39834004164;24166.637500437155;24185.15351962673;24205.152819651226;32684.836575816968;33715.662843371254;40664;41843.95390115149;42267.73196804101;34505.654943450245;34658.9602311931;34753;35626.10934726652;35983.64016359803;34585.827070864485;34720.479192811625;35250.94247172589;36507.63492365149;36730.63269367272;33943.83028084844;34184.97445076652;34592.30815383628;34848.30303393969;34884.82557587196;28463.602734338478;29702.405951881272;31165.053862513076;31166.22084447907;31518.8481151883;20131.496712582302;22662.66006009878;22941.655875161552;23695.93892397471;23984.760152398252 22:56:59 INFO - PROCESS | 1940 | |2;jquery.html;374.5711160720973;393.5533169852218;394.30798947846523;400.90779120802216;423.3205704843726;14747.778783318245;20357.592848143046;21354.466138346528;21962.560748785014;22085.889570552124;21303.68044479334;21970.560588788256;22084;22097.447563810914;22317.665235021486;5682.318121825387;5724.885502289952;5847.502962248214;5996.580239383245;6003.1895694081395;3444.414449543571;5806.82579522615;5918.230630018092;5919.200907877446;5924.259467566554;4331.242032644291;6150.876982460348;6517.478601711851;6543.93456065438;6553.344665533432;6290.119383286344;6426.678666066678;6537.607743535403;6577.473802095821;6652;5823.941760582382;5829.708514574297;5839.474447299721;5847.298324201123;5937.614055086406;26252.343691407867;27045.729542704517;27287.863560682268;27359.589606155925;27417.31456713578;2737.438825040862;2768.9030883919168;2769.833809971388;2776.1532732516575;2779.958300625492;14990.775138372934;15840.049597024215;15899.443519476763;16275.918620406941;16641.169471358142;1830.9908450457797;1834.752308438357;1849.537615596101;1887.339431199083;1912.1204246046834;116475.252871207;138661.2137968274;143855;144212;146352;11303.43941658375;11365;11431.256968297033;11457.875164940615;11719.765604687858;14421.92789036048;14427.422903083969;14784.334704938303;14946.476873309382;14985.850141498664;8472.322214222848;8517.361197910057;8758.47449153053;8784.121587841164;8940.240079593177;8559.657613695506;8570.957145214234;8622.31021518277;8772.420964226372;8778.60496277669;7138.25048369924;7311.195768465464;7322.96338518304;7323.0480037595835;7323.560586364835;1902.4007437657094;1932.719755635425;1954.4039068084371;1957.1779852462;1963.4993076765334;968.4625033106694;979.4368238263028;985.84719368498;998.1715176403568;1020.8162530744389;21537.461563460725;21881.890590546944;21998.910103540136;22117.783521906127;22218.222362217246;990.8067926754358;1008.9091981721533;1017.2624846985876;1018.9592416303265;1026.8357062869904;11191.104711623051;11502.367369794742;11506.367149806674;11539.249948753471;11552.826707599394;690783;697071;702000;718601;720044;82140;133739.3313033448;140693;152155.47844521634;153316.84034285383;1014.4268488304232;1055.9524821383056;1101.9173561982884;1111.8999290063932;1113.7438389170375;20482.38552843417;20947.057382417523;21148;21391.094970793496;21527.56944861125;57179;57938.7103064482;58651.70674146602;59027.114593280276;59134.40865591289;83570.58214708888;85646;85900.71148932895;87024.5648771752;89308.56594417423;8227;8274.338052955629;8513.361497887807;8659.6103175356;8678.088800675838;12671.429785659851;13806.723865522432;13858.307084645929;13921.51274705421;14197.219152946274;9856.556454959687;11406.429678515875;11548.769024619292;11614.477348519167;11715.882841171479;11380.94309528447;11520.423978801195;11606.593769218036;11745.412729363326;11748.823767643664;9627.9037209627;10697;11884.346360949885;12012.339321337411;12051.57819476314;7488.288612581796;8237.217464340878;8450.535220562928;8473.449225800303;8572.871406929025;11222.270552414067;11245;11612.76774464489;11739.11956603241;11802 22:56:59 INFO - PROCESS | 1940 | |3;mootools.html;1422.054333867978;1425.4155796123591;1439.7840323951407;1445.2990299704638;1450.9419623215065;7873.37013038957;8224.095349511548;8242.546659933701;8244.258016778504;8253.628586713605;7340.265973402657;7562.205968373324;7574.469787114904;7929.643166057527;8097;2255.76314486979;2313.8958746856347;2314.4772198303845;2318.5710643530915;2322.2104484475276;2294.403455101669;2327.662488939103;2330.7319658239267;2337.684412604294;2340.6254999200046;2032.3598066609045;2104.6527322991687;2226.443389152712;2284.0407029047838;2285.42864283929;2134.8505604607685;2163.8809865457392;2281.703378560793;2303.815694744425;2306.8269879759087;2233.2406981626164;2289.9313020609407;2295.173737454515;2331.5453486570127;2334.4280651240556;6991.755288564927;7121.8219544511285;7901.486403383762;8112.067112282045;8231.876521852177;4941.703497790144;5095.363079615048;5104.591632669378;5105.412877519096;5106.872328191787;3221.520757581806;3403.5235067090625;3430.622631510532;3486.2330287336745;3489.3719130556487;1141.2923987128033;1179.6932797472632;1208.2267348896712;1225.7180848404917;1238.8946939510151;10506.737331566696;10522.579096836118;10538.419237114418;10563.683089507327;10629.893701062967;4442.511323754385;4565.748883811356;4656.348111264358;4686.601638860735;4700.271457924027;9336.57985390659;9415.670451534163;9422.199113075465;9430.481323527134;9431.292653051049;5230.293910322058;5233.215017747369;5234.502722241381;5239.659422137549;5240.895182096337;4580.1984652686315;4687.648426368036;4694.671373003857;4800.615950723934;4815.879603009953;3693.132113953219;3793.1172309045323;3825.407061905409;3832.8466861325232;3926.1951299983434;1249.0881656390886;1250.787366147757;1250.7998720204723;1269.892059174962;1280.2382582363664;664.4949838123061;859.7463748194298;881.4579033894237;891.460666296894;928.1553786054658;4479.641628669699;5367.919481207785;5395.2986111806;5521.475459831309;5550.306211723535;932.5896605493562;949.7625593601599;962.3552220012608;987.7678745494803;1004.4023805835516;2932.5307950728206;3785.375413056815;3794.4687743715904;3860.285847118292;3867.504907685764;9647.469389183661;9879.715636967292;9884;9891.307608467338;9894.653687120915;9202.861957070649;9664.275179361575;9825.312228144105;9843.557039933221;9881.901180988241;7542.547447153188;7733.265339792711;7735.265149810759;7735.922640773632;7742.419318551131;5242.449542797951;5279.313689220377;5374.355077390738;5416.079266524779;5458.5087342139395;8698.869516957377;8709.738707838775;8754.781130471789;8834.277315923333;8945.642174312954;7518.8890773086705;8898.86651700238;9105.817883642423;9203.631854725736;9236.491992940453;6404.519661025535;7005.474589405917;7177.677004534704;7177.7487787927175;7200.387967022862;6995.895061573979;7755.883661744965;7875.881861772193;7930.246626570467;7943.880841787262;6997.545159564612;7100.183478899992;7102.538335008208;7103.183133939663;7231.963840180765;6982.546134501241;6997;6999.1950925644205;7024.227334993045;7065.6113913735235;5209.765560549708;6072.969635151796;6096.0855871619615;6141.232345956755;6198;4882.145624515767;4907.533784290486;4911.533404326583;4958.438092001008;5042.445331013512;4857.198562237191;5022.874428139179;5037.143685573535;5056.82301119459;5124.769385377593 22:56:59 INFO - PROCESS | 1940 | |4;prototype.html;351.08367161707946;368.7658336956032;369.9426588878725;377.54317276095924;377.8073182676834;4833.830815921444;5011.749412529377;5160.20016897381;5210.452902445246;5225.32070830792;4206.495220573528;4233.809478573464;4486.371907932892;5216.426193118754;5216.652506372128;3361.2354811498267;3674.6692797648207;3808.7143464240226;3993.7603743775467;4027.3556231003045;3300.6204286507;3632.891013269606;4019.437278780973;4021.457103291062;4035.273650742865;3433.8798142065034;4043.2722110020186;4070.3690927906073;4080.7551546907134;4099.6720262379085;3855.6337147970758;3977.210255385088;3991.2815693175216;4014.2372949139863;4085.673146148316;3368.3936891359544;3590.622984586633;3637.4177232903508;3637.854485820564;3655.1958569114754;4470.396496472967;5062.746862656889;5069.315642388267;5221.817236396708;5222.5531149441185;3775.8678446254526;4558.544145585448;4632.235681112612;4737.692050016738;4808.711477311373;4669.7858556775145;4843.709377437365;5415.891682166374;5457.836264912059;5480.616356855022;3858.401947698111;4008.779517126557;4011.6991225657903;4019.738716983416;4057.878263652095;4682.765861706969;5063.01271252106;5294.92057619136;5425.593080518937;5449.4005659377435;3724.981375093161;4066.7356621819486;4077.7757223353;4086.162336720965;4103.733257338264;4112.280350938574;4143.6685065194715;4146.751194928314;4148.211839750437;4156.9792151039055;3773.584905660375;4383.846565370261;4645.256758918556;4709.764511774466;4751.192297309466;5453.64551304164;5458.37997761069;5474;5487.451254874481;5507.284053073155;1179.4279774309452;1297.605074544868;1346.8047133165833;1351.2635613590617;1363.3660347938255;838.9538575378291;913.4336711238941;922.8919867382806;970.3256236915418;984.247051005981;4252.192083504125;4339.566043395698;4686.555381794378;4885.560299573055;4892.339534162842;4355.7822108894425;4652.860414187579;5023.572996295356;5143.099957507421;5289.523942845162;3894.4937158169255;4056.634902858757;4871.683340582851;4879.097366987119;4898.314236006961;2753.600727894444;2760.6687197536426;2791.2742686901147;2795.636567246245;2807.873645685949;5487.6921616530835;5489.780408783604;5543.837903217748;5563.388027316992;5570.860728481739;4865.49427045065;4914.72968986702;5383.461653834664;5433.914016301688;5517.641353312022;4716.311702329639;5224.947750522522;5278.841634750964;5320.201969704575;5668.0364338063455;4576.06190730906;4949.7030178189425;5335.292706334091;5349.545288650508;5355.973220133875;4590.2818716839465;4645.790939407667;4759.119562880878;4998.400191976986;5233.502817232356;4840.975795121002;4985.7257850817105;5577.944220557904;5647.915281270702;5671.234383358359;3608.314420260142;3645.690116340035;4052.5684589246216;4077.041895154696;4078.5309689384912;5242.47575242488;5333.7866485340155;5578.051731205624;5595.720213989365;5603.80386686464;4245.830166793294;4452.977735111303;5111.821086261963;5377.005254028018;5430.5384042356845;4863.586595139453;5083.059633967728;5336.973315133399;5382.67703937765;5430.402655707948;5081.593472522263;5270.446603106619;5300.655457395257;5300.920486192633;5333.3066701330135;5377.596680248918;5408.972955135199;5409.972950135381;5416.377116631637;5453.972730136324;4343.869683909487;4610.861674149781;5242.951409717995;5257.764425360114;5286.920696189483 22:56:59 INFO - PROCESS | 1940 | |5;yui.html;704.9647517624114;710.6730903784259;768.6195333310012;802.7551596762987;804.21588950773;14926.029808062469;15355.385784568633;15736.05583664981;15755.212239388013;15756.606084847885;14297.857021429783;14446.638834029129;14449.5665130046;14450.494232701858;14459.20474373909;694.9965250173742;717.6053170756089;720.4920531025614;848.5799529233038;861.5864385095158;872.5637181409295;873.681106396164;885.6590212768066;885.9468431894074;885.9512726800024;913.0869130869131;930.3859452761179;931.1526510875105;935.2845073518764;938.6714649872524;723.6200994477941;749.5802350683634;890.1988210610438;930.6882194464862;933.2533972821749;694.7394726977384;698.5424546921774;698.9895151572731;700.5306444682025;700.5971566349318;14902.403903843833;15140.772888406682;15181.620459488491;15191.240437978056;15198.392064317413;12788.616341509769;12839.580209895052;13011.089223754247;13016.609501714964;13266.867331326659;12932.48270069196;12987.805182922264;13005.089643724943;13144.802827957588;13232.470701171942;4351.9782401088105;4595.471520775087;4606.424196975378;4677.18149323867;4683.555062269079;98042.5097874506;99229.5115573267;100160.49919750355;101020.49489752577;101038.4948075255;10063.547140378554;10499.370037797757;10726.410047447309;10878.891211087788;10890.673279801618;20642.58714825695;20798.272060478113;20936.267230646856;20961.056752446177;20971.636843605116;7472.402207823361;7537.095548534211;7547;7643.624147653476;7686.884696729554;4116.897077573085;4120.928558574732;4150.958490415057;4157.750534967851;4173.207090652766;3403.6085850127056;3435.57055368079;3463.4804779282804;3487.215376540309;3490.2321489272317;604.4137186928672;611.0406661541338;643.9066335381343;651.8077167235676;662.0697919423218;529.3303970477349;537.4893850841715;547.3541221358835;557.8103444828697;563.4253061876863;9254.86117708235;9325.813483730288;9695.369800962915;9788.755281117887;9794.853077203848;594.5986459140063;604.7913469852894;616.5191150902303;663.0617675988423;670.031670625489;4483.865484035484;4911.993450675376;4949.125111764909;5172.5603323717905;5175.689458632494;93851.59222611666;95699.52150239205;95841.52079239559;96183.03816961881;97756.02243977612;83224;83375.16624833795;84377;84957;87427.56286218528;65955.01067483991;66091.66954165198;66239.66880165665;71472.64263678648;73637.63181184167;10813.189010824062;10863.67408977732;10964.506597202986;10966.835497467704;11215.60745373908;47691.284630729875;49106.75446622744;49387.75306123446;50299.49700502948;50844.49155508397;62078;63589.68205158944;64593.67703161454;64664;66591.66704166448;12662.873371266169;12941.417636206204;12984.35078246065;13351.666208344868;13656.863431365558;12262.20295680778;14378.640533986734;14584.635384115481;14631.516416152348;15526.456574019856;12620.242785432536;12641.557545485864;12682.936585317015;13186.868131318564;13214.207147571176;13322.600321990356;13627.318634068059;13639.772420482204;13647.59057228245;13693.863061369657;13285.933570332087;13433.66415839612;13455.259960701864;13483.98870084728;13641.181529108286;11194.216404851582;11221.60724374643;11324.830127548259;11668.533258669559;11688.298702077902;9950.950245248727;10830.241883068426;10867.891321087005;10868.565257389615;10946.507407166855 22:56:59 INFO - PROCESS | 1940 | __end_tp_report 22:56:59 INFO - PROCESS | 1940 | __start_cc_report 22:56:59 INFO - PROCESS | 1940 | _x_x_mozilla_cycle_collect,1810 22:56:59 INFO - PROCESS | 1940 | __end_cc_report 22:56:59 INFO - PROCESS | 1940 | __startTimestamp1484377019026__endTimestamp 22:56:59 INFO - PROCESS | 1940 | 22:56:59 INFO - PROCESS | 1940 | ------- Summary: start ------- 22:56:59 INFO - PROCESS | 1940 | Number of tests: 6 22:56:59 INFO - PROCESS | 1940 | 22:56:59 INFO - PROCESS | 1940 | [#0] dojo.html Cycles:165 Average:5721.92 Median:5900.29 stddev:632.85 (10.7%) stddev-sans-first:605.82 22:56:59 INFO - PROCESS | 1940 | Values: 3309.2 3327.3 3329.3 3348.2 3387.6 5523.7 5529.4 5598.6 5626.4 5665.7 5615.3 5645.4 5658.5 5664.6 5665.2 5106.9 5125.7 5151.6 5154.0 5188.3 5229.9 5235.7 5238.1 5240.1 5240.7 5241.5 5242.9 5250.1 5251.7 5252.8 5234.3 5235.3 5237.0 5238.2 5263.8 5056.0 5128.9 5186.5 5186.5 5197.5 5598.9 5627.5 5671.9 5739.7 5741.8 6075.4 6142.8 6190.9 6240.5 6244.2 5137.7 6102.8 6219.3 6227.9 6262.9 5778.2 5784.8 5789.1 5796.4 5809.3 6322.6 6332.9 6337.0 6338.5 6340.3 5933.4 5973.6 5993.8 6048.5 6130.4 6230.0 6236.6 6241.9 6254.1 6254.7 6079.9 6197.5 6211.5 6224.6 6245.7 6045.8 6088.5 6116.8 6228.2 6241.0 4913.1 4949.5 4970.3 4973.3 5007.8 4393.6 4398.3 4408.7 4414.5 4446.7 5678.5 5727.8 5728.1 5771.5 5796.7 6075.9 6104.9 6113.9 6149.3 6195.8 5818.7 5820.2 5836.4 5843.5 5856.1 5298.9 5359.0 5366.6 5393.1 5456.1 6280.0 6344.4 6345.9 6361.5 6393.8 6110.8 6121.3 6290.4 6290.8 6318.7 6239.6 6257.2 6275.6 6283.9 6284.6 6180.5 6202.7 6208.3 6211.5 6215.4 6257.3 6265.4 6277.2 6278.6 6281.6 5796.9 5836.5 5866.9 5989.5 6074.0 5960.5 6002.2 6010.1 6015.0 6031.4 5877.6 5926.5 5943.6 5969.1 6008.8 6120.8 6121.3 6130.0 6134.9 6135.4 5880.6 5890.2 5900.3 5902.3 5910.1 22:56:59 INFO - PROCESS | 1940 | 22:56:59 INFO - PROCESS | 1940 | [#1] ext.html Cycles:180 Average:66966.52 Median:34800.65 stddev:146940.56 (422.2%) stddev-sans-first:147267.90 22:56:59 INFO - PROCESS | 1940 | Values: 451.3 499.9 503.8 524.7 539.9 29478.6 38075.8 39348.2 39547.6 41287.0 40701.4 41088.0 41128.3 41132.8 41147.2 7974.8 8898.6 9095.2 9111.9 9113.1 8047.0 10805.3 11022.2 11022.5 11199.0 11010.1 11096.2 11105.1 11113.7 11121.4 8130.6 8331.0 10646.2 11043.5 11121.3 10707.9 10916.0 10923.3 10924.2 10968.9 38575.4 38946.0 38996.0 39014.4 39029.8 3975.2 3985.6 4011.3 4027.6 4049.2 23770.9 29359.0 29444.3 29751.9 30136.4 2714.1 3129.7 3140.6 3154.6 3172.8 448250.0 448266.0 448474.8 449955.8 449976.0 56111.4 56415.0 56416.4 56451.7 56601.9 59960.7 60021.1 60032.0 60046.7 60091.8 15515.5 15729.0 15768.4 15773.6 15781.8 10868.8 11145.5 12059.9 12377.2 12392.0 14715.0 14938.8 15137.3 15178.8 15193.6 6534.9 7370.3 7410.4 7506.4 7560.7 862.5 867.2 903.7 911.8 916.1 25284.4 29530.4 29656.9 29995.7 30418.8 939.0 996.8 1042.2 1087.3 1203.3 14708.1 15162.5 15212.9 15518.6 15547.8 613690.0 614749.0 615103.0 615814.0 619394.0 57484.4 57646.0 57755.7 57761.7 57809.0 1382.2 1437.5 1450.2 1454.8 1460.1 27907.7 27986.6 28801.0 29582.4 29619.0 47936.8 49423.5 49677.0 52037.0 52117.0 564224.0 567861.0 570791.0 573850.1 574876.0 23800.2 24066.4 24166.6 24185.2 24205.2 32684.8 33715.7 40664.0 41844.0 42267.7 34505.7 34659.0 34753.0 35626.1 35983.6 34585.8 34720.5 35250.9 36507.6 36730.6 33943.8 34185.0 34592.3 34848.3 34884.8 28463.6 29702.4 31165.1 31166.2 31518.8 20131.5 22662.7 22941.7 23695.9 23984.8 22:56:59 INFO - PROCESS | 1940 | 22:56:59 INFO - PROCESS | 1940 | [#2] jquery.html Cycles:180 Average:39632.25 Median:22267.94 stddev:117510.97 (527.7%) stddev-sans-first:117803.64 22:56:59 INFO - PROCESS | 1940 | Values: 374.6 393.6 394.3 400.9 423.3 14747.8 20357.6 21354.5 21962.6 22085.9 21303.7 21970.6 22084.0 22097.4 22317.7 5682.3 5724.9 5847.5 5996.6 6003.2 3444.4 5806.8 5918.2 5919.2 5924.3 4331.2 6150.9 6517.5 6543.9 6553.3 6290.1 6426.7 6537.6 6577.5 6652.0 5823.9 5829.7 5839.5 5847.3 5937.6 26252.3 27045.7 27287.9 27359.6 27417.3 2737.4 2768.9 2769.8 2776.2 2780.0 14990.8 15840.0 15899.4 16275.9 16641.2 1831.0 1834.8 1849.5 1887.3 1912.1 116475.3 138661.2 143855.0 144212.0 146352.0 11303.4 11365.0 11431.3 11457.9 11719.8 14421.9 14427.4 14784.3 14946.5 14985.9 8472.3 8517.4 8758.5 8784.1 8940.2 8559.7 8571.0 8622.3 8772.4 8778.6 7138.3 7311.2 7323.0 7323.0 7323.6 1902.4 1932.7 1954.4 1957.2 1963.5 968.5 979.4 985.8 998.2 1020.8 21537.5 21881.9 21998.9 22117.8 22218.2 990.8 1008.9 1017.3 1019.0 1026.8 11191.1 11502.4 11506.4 11539.2 11552.8 690783.0 697071.0 702000.0 718601.0 720044.0 82140.0 133739.3 140693.0 152155.5 153316.8 1014.4 1056.0 1101.9 1111.9 1113.7 20482.4 20947.1 21148.0 21391.1 21527.6 57179.0 57938.7 58651.7 59027.1 59134.4 83570.6 85646.0 85900.7 87024.6 89308.6 8227.0 8274.3 8513.4 8659.6 8678.1 12671.4 13806.7 13858.3 13921.5 14197.2 9856.6 11406.4 11548.8 11614.5 11715.9 11380.9 11520.4 11606.6 11745.4 11748.8 9627.9 10697.0 11884.3 12012.3 12051.6 7488.3 8237.2 8450.5 8473.4 8572.9 11222.3 11245.0 11612.8 11739.1 11802.0 22:56:59 INFO - PROCESS | 1940 | 22:56:59 INFO - PROCESS | 1940 | [#3] mootools.html Cycles:180 Average:5311.08 Median:5237.08 stddev:2861.06 (54.6%) stddev-sans-first:2854.16 22:56:59 INFO - PROCESS | 1940 | Values: 1422.1 1425.4 1439.8 1445.3 1450.9 7873.4 8224.1 8242.5 8244.3 8253.6 7340.3 7562.2 7574.5 7929.6 8097.0 2255.8 2313.9 2314.5 2318.6 2322.2 2294.4 2327.7 2330.7 2337.7 2340.6 2032.4 2104.7 2226.4 2284.0 2285.4 2134.9 2163.9 2281.7 2303.8 2306.8 2233.2 2289.9 2295.2 2331.5 2334.4 6991.8 7121.8 7901.5 8112.1 8231.9 4941.7 5095.4 5104.6 5105.4 5106.9 3221.5 3403.5 3430.6 3486.2 3489.4 1141.3 1179.7 1208.2 1225.7 1238.9 10506.7 10522.6 10538.4 10563.7 10629.9 4442.5 4565.7 4656.3 4686.6 4700.3 9336.6 9415.7 9422.2 9430.5 9431.3 5230.3 5233.2 5234.5 5239.7 5240.9 4580.2 4687.6 4694.7 4800.6 4815.9 3693.1 3793.1 3825.4 3832.8 3926.2 1249.1 1250.8 1250.8 1269.9 1280.2 664.5 859.7 881.5 891.5 928.2 4479.6 5367.9 5395.3 5521.5 5550.3 932.6 949.8 962.4 987.8 1004.4 2932.5 3785.4 3794.5 3860.3 3867.5 9647.5 9879.7 9884.0 9891.3 9894.7 9202.9 9664.3 9825.3 9843.6 9881.9 7542.5 7733.3 7735.3 7735.9 7742.4 5242.4 5279.3 5374.4 5416.1 5458.5 8698.9 8709.7 8754.8 8834.3 8945.6 7518.9 8898.9 9105.8 9203.6 9236.5 6404.5 7005.5 7177.7 7177.7 7200.4 6995.9 7755.9 7875.9 7930.2 7943.9 6997.5 7100.2 7102.5 7103.2 7232.0 6982.5 6997.0 6999.2 7024.2 7065.6 5209.8 6073.0 6096.1 6141.2 6198.0 4882.1 4907.5 4911.5 4958.4 5042.4 4857.2 5022.9 5037.1 5056.8 5124.8 22:56:59 INFO - PROCESS | 1940 | 22:56:59 INFO - PROCESS | 1940 | [#4] prototype.html Cycles:180 Average:4350.54 Median:4783.92 stddev:1264.89 (26.4%) stddev-sans-first:1232.30 22:56:59 INFO - PROCESS | 1940 | Values: 351.1 368.8 369.9 377.5 377.8 4833.8 5011.7 5160.2 5210.5 5225.3 4206.5 4233.8 4486.4 5216.4 5216.7 3361.2 3674.7 3808.7 3993.8 4027.4 3300.6 3632.9 4019.4 4021.5 4035.3 3433.9 4043.3 4070.4 4080.8 4099.7 3855.6 3977.2 3991.3 4014.2 4085.7 3368.4 3590.6 3637.4 3637.9 3655.2 4470.4 5062.7 5069.3 5221.8 5222.6 3775.9 4558.5 4632.2 4737.7 4808.7 4669.8 4843.7 5415.9 5457.8 5480.6 3858.4 4008.8 4011.7 4019.7 4057.9 4682.8 5063.0 5294.9 5425.6 5449.4 3725.0 4066.7 4077.8 4086.2 4103.7 4112.3 4143.7 4146.8 4148.2 4157.0 3773.6 4383.8 4645.3 4709.8 4751.2 5453.6 5458.4 5474.0 5487.5 5507.3 1179.4 1297.6 1346.8 1351.3 1363.4 839.0 913.4 922.9 970.3 984.2 4252.2 4339.6 4686.6 4885.6 4892.3 4355.8 4652.9 5023.6 5143.1 5289.5 3894.5 4056.6 4871.7 4879.1 4898.3 2753.6 2760.7 2791.3 2795.6 2807.9 5487.7 5489.8 5543.8 5563.4 5570.9 4865.5 4914.7 5383.5 5433.9 5517.6 4716.3 5224.9 5278.8 5320.2 5668.0 4576.1 4949.7 5335.3 5349.5 5356.0 4590.3 4645.8 4759.1 4998.4 5233.5 4841.0 4985.7 5577.9 5647.9 5671.2 3608.3 3645.7 4052.6 4077.0 4078.5 5242.5 5333.8 5578.1 5595.7 5603.8 4245.8 4453.0 5111.8 5377.0 5430.5 4863.6 5083.1 5337.0 5382.7 5430.4 5081.6 5270.4 5300.7 5300.9 5333.3 5377.6 5409.0 5410.0 5416.4 5454.0 4343.9 4610.9 5243.0 5257.8 5286.9 22:56:59 INFO - PROCESS | 1940 | 22:56:59 INFO - PROCESS | 1940 | [#5] yui.html Cycles:180 Average:19633.51 Median:4641.80 stddev:27384.62 (590.0%) stddev-sans-first:27424.56 22:56:59 INFO - PROCESS | 1940 | Values: 705.0 710.7 768.6 802.8 804.2 14926.0 15355.4 15736.1 15755.2 15756.6 14297.9 14446.6 14449.6 14450.5 14459.2 695.0 717.6 720.5 848.6 861.6 872.6 873.7 885.7 885.9 886.0 913.1 930.4 931.2 935.3 938.7 723.6 749.6 890.2 930.7 933.3 694.7 698.5 699.0 700.5 700.6 14902.4 15140.8 15181.6 15191.2 15198.4 12788.6 12839.6 13011.1 13016.6 13266.9 12932.5 12987.8 13005.1 13144.8 13232.5 4352.0 4595.5 4606.4 4677.2 4683.6 98042.5 99229.5 100160.5 101020.5 101038.5 10063.5 10499.4 10726.4 10878.9 10890.7 20642.6 20798.3 20936.3 20961.1 20971.6 7472.4 7537.1 7547.0 7643.6 7686.9 4116.9 4120.9 4151.0 4157.8 4173.2 3403.6 3435.6 3463.5 3487.2 3490.2 604.4 611.0 643.9 651.8 662.1 529.3 537.5 547.4 557.8 563.4 9254.9 9325.8 9695.4 9788.8 9794.9 594.6 604.8 616.5 663.1 670.0 4483.9 4912.0 4949.1 5172.6 5175.7 93851.6 95699.5 95841.5 96183.0 97756.0 83224.0 83375.2 84377.0 84957.0 87427.6 65955.0 66091.7 66239.7 71472.6 73637.6 10813.2 10863.7 10964.5 10966.8 11215.6 47691.3 49106.8 49387.8 50299.5 50844.5 62078.0 63589.7 64593.7 64664.0 66591.7 12662.9 12941.4 12984.4 13351.7 13656.9 12262.2 14378.6 14584.6 14631.5 15526.5 12620.2 12641.6 12682.9 13186.9 13214.2 13322.6 13627.3 13639.8 13647.6 13693.9 13285.9 13433.7 13455.3 13484.0 13641.2 11194.2 11221.6 11324.8 11668.5 11688.3 9951.0 10830.2 10867.9 10868.6 10946.5 22:56:59 INFO - PROCESS | 1940 | -------- Summary: end -------- 22:56:59 INFO - PROCESS | 1940 | 22:56:59 INFO - TEST-INFO | 1940: exit 0 22:56:59 INFO - TEST-OK | dromaeo_css | took 1119272ms 22:56:59 INFO - TEST-START | kraken 22:56:59 INFO - operating with platform_type : mac_ 22:56:59 INFO - Initialising browser for kraken test... 22:56:59 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpfs9tTY/profile http://localhost:49415/getInfo.html) 22:57:02 INFO - PROCESS | 1945 | __metrics Screen width/height:1600/1200 22:57:02 INFO - PROCESS | 1945 | colorDepth:24 22:57:02 INFO - PROCESS | 1945 | Browser inner width/height: 1024/689 22:57:02 INFO - PROCESS | 1945 | __metrics 22:57:02 INFO - PROCESS | 1945 | 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" 22:57:02 INFO - PROCESS | 1945 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:57:03 INFO - TEST-INFO | 1945: exit 0 22:57:03 INFO - Browser initialized. 22:57:03 INFO - Running cycle 1/1 for kraken test... 22:57:03 INFO - TEST-INFO | started process 1946 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpfs9tTY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:57:15 INFO - PROCESS | 1946 | RSS: Main: 226893824 22:57:15 INFO - PROCESS | 1946 | 22:57:17 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49415/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49415/tests/kraken/driver.html?testName=audio-beat-detection) 22:57:18 INFO - PROCESS | 1946 | RSS: Main: 287010816 22:57:18 INFO - PROCESS | 1946 | 22:57:21 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49415/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49415/tests/kraken/driver.html?testName=audio-dft) 22:57:22 INFO - PROCESS | 1946 | RSS: Main: 288931840 22:57:22 INFO - PROCESS | 1946 | 22:57:25 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49415/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49415/tests/kraken/driver.html?testName=audio-fft) 22:57:26 INFO - PROCESS | 1946 | RSS: Main: 380022784 22:57:26 INFO - PROCESS | 1946 | 22:57:28 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49415/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49415/tests/kraken/driver.html?testName=audio-oscillator) 22:57:28 INFO - PROCESS | 1946 | RSS: Main: 282996736 22:57:28 INFO - PROCESS | 1946 | 22:57:30 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49415/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49415/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:57:31 INFO - PROCESS | 1946 | RSS: Main: 288051200 22:57:31 INFO - PROCESS | 1946 | 22:57:34 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49415/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49415/tests/kraken/driver.html?testName=imaging-darkroom) 22:57:34 INFO - PROCESS | 1946 | RSS: Main: 328499200 22:57:34 INFO - PROCESS | 1946 | 22:57:37 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49415/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49415/tests/kraken/driver.html?testName=imaging-desaturate) 22:57:38 INFO - PROCESS | 1946 | RSS: Main: 332111872 22:57:38 INFO - PROCESS | 1946 | 22:57:41 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49415/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49415/tests/kraken/driver.html?testName=json-parse-financial) 22:57:41 INFO - PROCESS | 1946 | RSS: Main: 329031680 22:57:41 INFO - PROCESS | 1946 | 22:57:43 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49415/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49415/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:57:43 INFO - PROCESS | 1946 | RSS: Main: 304807936 22:57:43 INFO - PROCESS | 1946 | 22:57:45 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49415/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49415/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:57:46 INFO - PROCESS | 1946 | RSS: Main: 307986432 22:57:46 INFO - PROCESS | 1946 | 22:57:48 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49415/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49415/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:57:49 INFO - PROCESS | 1946 | RSS: Main: 317038592 22:57:49 INFO - PROCESS | 1946 | 22:57:52 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49415/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:57:52 INFO - PROCESS | 1946 | RSS: Main: 328937472 22:57:52 INFO - PROCESS | 1946 | 22:57:56 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:57:56 INFO - PROCESS | 1946 | RSS: Main: 322711552 22:57:56 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:49415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49415/tests/kraken/driver.html?testName=ai-astar) 22:57:58 INFO - PROCESS | 1946 | RSS: Main: 367009792 22:57:58 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | __start_tp_report 22:57:58 INFO - PROCESS | 1946 | _x_x_mozilla_page_load 22:57:58 INFO - PROCESS | 1946 | _x_x_mozilla_page_load_details 22:57:58 INFO - PROCESS | 1946 | |i|pagename|runs| 22:57:58 INFO - PROCESS | 1946 | |0;ai-astar;111;112;112;112;113;114;116;162;136;112 22:57:58 INFO - PROCESS | 1946 | |1;audio-beat-detection;144;110;109;147;114;110;109;111;130;111 22:57:58 INFO - PROCESS | 1946 | |2;audio-dft;183;189;258;214;182;180;180;182;184;184 22:57:58 INFO - PROCESS | 1946 | |3;audio-fft;79;58;59;88;60;57;59;74;96;82 22:57:58 INFO - PROCESS | 1946 | |4;audio-oscillator;92;70;84;70;68;69;81;68;68;82 22:57:58 INFO - PROCESS | 1946 | |5;imaging-gaussian-blur;87;85;87;85;87;84;88;84;88;85 22:57:58 INFO - PROCESS | 1946 | |6;imaging-darkroom;97;94;94;94;94;94;94;95;95;94 22:57:58 INFO - PROCESS | 1946 | |7;imaging-desaturate;86;84;87;86;85;87;84;85;89;85 22:57:58 INFO - PROCESS | 1946 | |8;json-parse-financial;56;54;55;53;53;55;55;55;55;55 22:57:58 INFO - PROCESS | 1946 | |9;json-stringify-tinderbox;65;66;73;80;71;70;70;71;70;72 22:57:58 INFO - PROCESS | 1946 | |10;stanford-crypto-aes;86;89;89;88;90;89;89;91;93;88 22:57:58 INFO - PROCESS | 1946 | |11;stanford-crypto-ccm;159;153;152;130;139;142;142;138;182;144 22:57:58 INFO - PROCESS | 1946 | |12;stanford-crypto-pbkdf2;179;247;194;171;174;174;173;177;172;171 22:57:58 INFO - PROCESS | 1946 | |13;stanford-crypto-sha256-iterative;68;68;68;66;67;66;66;65;67;66 22:57:58 INFO - PROCESS | 1946 | __end_tp_report 22:57:58 INFO - PROCESS | 1946 | __start_cc_report 22:57:58 INFO - PROCESS | 1946 | _x_x_mozilla_cycle_collect,2108 22:57:58 INFO - PROCESS | 1946 | __end_cc_report 22:57:58 INFO - PROCESS | 1946 | __startTimestamp1484377078604__endTimestamp 22:57:58 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | ------- Summary: start ------- 22:57:58 INFO - PROCESS | 1946 | Number of tests: 14 22:57:58 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | [#0] ai-astar Cycles:10 Average:120.00 Median:113.50 stddev:16.53 (14.6%) stddev-sans-first:17.20 22:57:58 INFO - PROCESS | 1946 | Values: 111.0 112.0 112.0 112.0 113.0 114.0 116.0 162.0 136.0 112.0 22:57:58 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | [#1] audio-beat-detection Cycles:10 Average:119.50 Median:112.50 stddev:15.06 (13.4%) stddev-sans-first:13.11 22:57:58 INFO - PROCESS | 1946 | Values: 144.0 110.0 109.0 147.0 114.0 110.0 109.0 111.0 130.0 111.0 22:57:58 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | [#2] audio-dft Cycles:10 Average:193.60 Median:184.00 stddev:24.77 (13.5%) stddev-sans-first:25.97 22:57:58 INFO - PROCESS | 1946 | Values: 183.0 189.0 258.0 214.0 182.0 180.0 180.0 182.0 184.0 184.0 22:57:58 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | [#3] audio-fft Cycles:10 Average:71.20 Median:76.50 stddev:14.46 (18.9%) stddev-sans-first:15.06 22:57:58 INFO - PROCESS | 1946 | Values: 79.0 58.0 59.0 88.0 60.0 57.0 59.0 74.0 96.0 82.0 22:57:58 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:75.50 stddev:8.74 (11.6%) stddev-sans-first:6.84 22:57:58 INFO - PROCESS | 1946 | Values: 92.0 70.0 84.0 70.0 68.0 69.0 81.0 68.0 68.0 82.0 22:57:58 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:87.00 stddev:1.56 (1.8%) stddev-sans-first:1.62 22:57:58 INFO - PROCESS | 1946 | Values: 87.0 85.0 87.0 85.0 87.0 84.0 88.0 84.0 88.0 85.0 22:57:58 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:94.00 stddev:0.97 (1.0%) stddev-sans-first:0.44 22:57:58 INFO - PROCESS | 1946 | Values: 97.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 94.0 22:57:58 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:1.55 (1.8%) stddev-sans-first:1.64 22:57:58 INFO - PROCESS | 1946 | Values: 86.0 84.0 87.0 86.0 85.0 87.0 84.0 85.0 89.0 85.0 22:57:58 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:0.88 22:57:58 INFO - PROCESS | 1946 | Values: 56.0 54.0 55.0 53.0 53.0 55.0 55.0 55.0 55.0 55.0 22:57:58 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.00 stddev:4.08 (5.7%) stddev-sans-first:3.75 22:57:58 INFO - PROCESS | 1946 | Values: 65.0 66.0 73.0 80.0 71.0 70.0 70.0 71.0 70.0 72.0 22:57:58 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:89.00 stddev:1.87 (2.1%) stddev-sans-first:1.59 22:57:58 INFO - PROCESS | 1946 | Values: 86.0 89.0 89.0 88.0 90.0 89.0 89.0 91.0 93.0 88.0 22:57:58 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:148.00 stddev:14.57 (9.8%) stddev-sans-first:14.91 22:57:58 INFO - PROCESS | 1946 | Values: 159.0 153.0 152.0 130.0 139.0 142.0 142.0 138.0 182.0 144.0 22:57:58 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:175.50 stddev:23.43 (13.3%) stddev-sans-first:24.80 22:57:58 INFO - PROCESS | 1946 | Values: 179.0 247.0 194.0 171.0 174.0 174.0 173.0 177.0 172.0 171.0 22:57:58 INFO - PROCESS | 1946 | 22:57:58 INFO - PROCESS | 1946 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.06 (1.6%) stddev-sans-first:1.01 22:57:58 INFO - PROCESS | 1946 | Values: 68.0 68.0 68.0 66.0 67.0 66.0 66.0 65.0 67.0 66.0 22:57:58 INFO - PROCESS | 1946 | -------- Summary: end -------- 22:57:58 INFO - PROCESS | 1946 | 22:57:59 INFO - TEST-INFO | 1946: exit 0 22:57:59 INFO - TEST-OK | kraken | took 59742ms 22:57:59 INFO - SUITE-END | took 1179s 22:57:59 INFO - Completed test suite (00:19:39) 22:57:59 INFO - javascript benchmark 22:57:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3309.189248634085, 3327.3345330933803, 3329.26756113655, 3348.2131699050733, 3387.6442973487783, 5523.696196709179, 5529.364123125842, 5598.608097433176, 5626.352969408519, 5665.745041473138, 5615.326160860693, 5645.350784659765, 5658.462446067617, 5664.603477756558, 5665.206871038058, 5106.948930510703, 5125.692458452486, 5151.562117220041, 5154.0, 5188.325517682715, 5229.947700522984, 5235.6596821206695, 5238.083335416306, 5240.056789777838, 5240.737963101848, 5241.50205730455, 5242.868928276805, 5250.081235783741, 5251.684898906059, 5252.763625636836, 5234.319538459995, 5235.319408476912, 5236.952609478081, 5238.240455134022, 5263.815766448156, 5056.014077254937, 5128.871778205537, 5186.481351864821, 5186.507281808223, 5197.454267301954, 5598.944010559923, 5627.521660658849, 5671.886562268773, 5739.684317362543, 5741.799037033726, 6075.392460753934, 6142.754289828402, 6190.938090619126, 6240.500759939239, 6244.219472565929, 5137.717425541594, 6102.761931713813, 6219.2847822500535, 6227.937720622781, 6262.906056409158, 5778.219940308089, 5784.768609255667, 5789.131630255495, 5796.42035796417, 5809.331926828384, 6322.557420980487, 6332.905006424908, 6336.968315158487, 6338.524610654219, 6340.302566717657, 5933.3769954154195, 5973.611715238582, 5993.760249589967, 6048.455638992512, 6130.448259656652, 6229.96885015572, 6236.563440559117, 6241.875162496815, 6254.124422580842, 6254.749810007549, 6079.939200608026, 6197.5351848611535, 6211.503079753699, 6224.595401298901, 6245.718942647592, 6045.818625441244, 6088.482478989247, 6116.785912493041, 6228.190335256388, 6240.9702399103635, 4913.140200464976, 4949.529794669501, 4970.254461830755, 4973.303737476756, 5007.84819491519, 4393.648508119343, 4398.296272596369, 4408.691391602557, 4414.492333381702, 4446.710963787344, 5678.545716342683, 5727.770889164387, 5728.140778883201, 5771.538276937835, 5796.739146738407, 6075.878482430327, 6104.877902441926, 6113.93006223909, 6149.262088549313, 6195.845103872439, 5818.679972601548, 5820.185174075633, 5836.387179346192, 5843.503302219274, 5856.12158176277, 5298.947010529922, 5359.0, 5366.570674346043, 5393.083175860034, 5456.127019676833, 6280.0, 6344.365563443619, 6345.936540634627, 6361.491080713439, 6393.840153996187, 6110.7555697771595, 6121.300552271563, 6290.370962903856, 6290.811275661737, 6318.747250110128, 6239.625622462667, 6257.1552840367785, 6275.623462592259, 6283.937160628335, 6284.622922624657, 6180.505559555315, 6202.689865506616, 6208.317085120723, 6211.534134939988, 6215.409536094064, 6257.342978987323, 6265.404786545271, 6277.15258440123, 6278.591891527036, 6281.59169653971, 5796.94203057964, 5836.533077353716, 5866.853328666647, 5989.490893273946, 6074.0, 5960.523158147251, 6002.219711437485, 6010.068439391901, 6014.969925150346, 6031.4270144336215, 5877.588568800143, 5926.525877929669, 5943.554233432424, 5969.134475501115, 6008.759649613967, 6120.846978825565, 6121.296050954197, 6130.049842274455, 6134.938650613437, 6135.355787642234, 5880.647161170344, 5890.175375447527, 5900.291964964232, 5902.321233058082, 5910.1134829774155], "value": 5681.052423313485, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.2982312504057, 499.92017242755645, 503.8285985084679, 524.6615932723394, 539.8515408262725, 29478.557821632665, 38075.80962095189, 39348.21303573927, 39547.60452395475, 41287.0, 40701.389479157835, 41088.0, 41128.32665876716, 41132.79433602835, 41147.177056458924, 7974.840503189962, 8898.555072246394, 9095.226905713022, 9111.863322050174, 9113.134252246025, 8047.0, 10805.297655652357, 11022.228444008922, 11022.50398732055, 11199.0, 11010.064144547723, 11096.167787415936, 11105.056070233999, 11113.666590002273, 11121.388323642197, 8130.634121464548, 8331.0, 10646.201534884915, 11043.503042363112, 11121.27711698741, 10707.946460267649, 10915.962983516552, 10923.344599323986, 10924.180686448548, 10968.903109689047, 38575.42136867949, 38946.0, 38996.0, 39014.414783778266, 39029.804850975845, 3975.1652153047894, 3985.561588225293, 4011.2579172853116, 4027.637512623878, 4049.2306461772464, 23770.88114559416, 29359.0, 29444.263893402836, 29751.851240743876, 30136.397272054437, 2714.1043455659583, 3129.702678245563, 3140.5917230759856, 3154.5678321957457, 3172.762042846796, 448250.0, 448266.0, 448474.757626213, 449955.75022125005, 449976.0, 56111.43888561144, 56415.0, 56416.43583564194, 56451.71774141185, 56601.867962640514, 59960.700196498736, 60021.099683504784, 60032.0, 60046.69976650089, 60091.798164036474, 15515.534533963999, 15728.977616454893, 15768.369265229263, 15773.605659858365, 15781.763273550905, 10868.836967445495, 11145.498452569655, 12059.879401205875, 12377.195482293622, 12392.0, 14715.043522171025, 14938.775918361232, 15137.318820653098, 15178.772318415233, 15193.62015949588, 6534.934650653528, 7370.336669699753, 7410.370118539984, 7506.361959233417, 7560.659770310349, 862.5083702289635, 867.197841996151, 903.7333986474006, 911.7948461596088, 916.0884919505135, 25284.36789080251, 29530.44918980129, 29656.851715741283, 29995.700042999728, 30418.84790576033, 938.9718258506924, 996.7707427291764, 1042.1558537584428, 1087.3367245979946, 1203.3141109567637, 14708.117512949257, 15162.469313573973, 15212.923935380251, 15518.612034699223, 15547.844521554865, 613690.0, 614749.0, 615103.0, 615814.0, 619394.0, 57484.42515574791, 57646.0, 57755.71122144363, 57761.71119144378, 57809.0, 1382.163790906487, 1437.4681367893945, 1450.173401161328, 1454.8472410396967, 1460.1385182742022, 27907.720922791323, 27986.58020129659, 28801.0, 29582.408351833274, 29618.963336283126, 47936.7603161982, 49423.50576494333, 49677.0, 52037.0, 52117.0, 564224.0, 567861.0, 570791.0, 573850.1307493435, 574876.0, 23800.166994155123, 24066.39834004164, 24166.637500437155, 24185.15351962673, 24205.152819651226, 32684.836575816968, 33715.662843371254, 40664.0, 41843.95390115149, 42267.73196804101, 34505.654943450245, 34658.9602311931, 34753.0, 35626.10934726652, 35983.64016359803, 34585.827070864485, 34720.479192811625, 35250.94247172589, 36507.63492365149, 36730.63269367272, 33943.83028084844, 34184.97445076652, 34592.30815383628, 34848.30303393969, 34884.82557587196, 28463.602734338478, 29702.405951881272, 31165.053862513076, 31166.22084447907, 31518.8481151883, 20131.496712582302, 22662.66006009878, 22941.655875161552, 23695.93892397471, 23984.760152398252], "value": 19241.766533548755, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.5711160720973, 393.5533169852218, 394.30798947846523, 400.90779120802216, 423.3205704843726, 14747.778783318245, 20357.592848143046, 21354.466138346528, 21962.560748785014, 22085.889570552124, 21303.68044479334, 21970.560588788256, 22084.0, 22097.447563810914, 22317.665235021486, 5682.318121825387, 5724.885502289952, 5847.502962248214, 5996.580239383245, 6003.1895694081395, 3444.414449543571, 5806.82579522615, 5918.230630018092, 5919.200907877446, 5924.259467566554, 4331.242032644291, 6150.876982460348, 6517.478601711851, 6543.93456065438, 6553.344665533432, 6290.119383286344, 6426.678666066678, 6537.607743535403, 6577.473802095821, 6652.0, 5823.941760582382, 5829.708514574297, 5839.474447299721, 5847.298324201123, 5937.614055086406, 26252.343691407867, 27045.729542704517, 27287.863560682268, 27359.589606155925, 27417.31456713578, 2737.438825040862, 2768.9030883919168, 2769.833809971388, 2776.1532732516575, 2779.958300625492, 14990.775138372934, 15840.049597024215, 15899.443519476763, 16275.918620406941, 16641.169471358142, 1830.9908450457797, 1834.752308438357, 1849.537615596101, 1887.339431199083, 1912.1204246046834, 116475.252871207, 138661.2137968274, 143855.0, 144212.0, 146352.0, 11303.43941658375, 11365.0, 11431.256968297033, 11457.875164940615, 11719.765604687858, 14421.92789036048, 14427.422903083969, 14784.334704938303, 14946.476873309382, 14985.850141498664, 8472.322214222848, 8517.361197910057, 8758.47449153053, 8784.121587841164, 8940.240079593177, 8559.657613695506, 8570.957145214234, 8622.31021518277, 8772.420964226372, 8778.60496277669, 7138.25048369924, 7311.195768465464, 7322.96338518304, 7323.0480037595835, 7323.560586364835, 1902.4007437657094, 1932.719755635425, 1954.4039068084371, 1957.1779852462, 1963.4993076765334, 968.4625033106694, 979.4368238263028, 985.84719368498, 998.1715176403568, 1020.8162530744389, 21537.461563460725, 21881.890590546944, 21998.910103540136, 22117.783521906127, 22218.222362217246, 990.8067926754358, 1008.9091981721533, 1017.2624846985876, 1018.9592416303265, 1026.8357062869904, 11191.104711623051, 11502.367369794742, 11506.367149806674, 11539.249948753471, 11552.826707599394, 690783.0, 697071.0, 702000.0, 718601.0, 720044.0, 82140.0, 133739.3313033448, 140693.0, 152155.47844521634, 153316.84034285383, 1014.4268488304232, 1055.9524821383056, 1101.9173561982884, 1111.8999290063932, 1113.7438389170375, 20482.38552843417, 20947.057382417523, 21148.0, 21391.094970793496, 21527.56944861125, 57179.0, 57938.7103064482, 58651.70674146602, 59027.114593280276, 59134.40865591289, 83570.58214708888, 85646.0, 85900.71148932895, 87024.5648771752, 89308.56594417423, 8227.0, 8274.338052955629, 8513.361497887807, 8659.6103175356, 8678.088800675838, 12671.429785659851, 13806.723865522432, 13858.307084645929, 13921.51274705421, 14197.219152946274, 9856.556454959687, 11406.429678515875, 11548.769024619292, 11614.477348519167, 11715.882841171479, 11380.94309528447, 11520.423978801195, 11606.593769218036, 11745.412729363326, 11748.823767643664, 9627.9037209627, 10697.0, 11884.346360949885, 12012.339321337411, 12051.57819476314, 7488.288612581796, 8237.217464340878, 8450.535220562928, 8473.449225800303, 8572.871406929025, 11222.270552414067, 11245.0, 11612.76774464489, 11739.11956603241, 11802.0], "value": 10316.470147322945, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.054333867978, 1425.4155796123591, 1439.7840323951407, 1445.2990299704638, 1450.9419623215065, 7873.37013038957, 8224.095349511548, 8242.546659933701, 8244.258016778504, 8253.628586713605, 7340.265973402657, 7562.205968373324, 7574.469787114904, 7929.643166057527, 8097.0, 2255.76314486979, 2313.8958746856347, 2314.4772198303845, 2318.5710643530915, 2322.2104484475276, 2294.403455101669, 2327.662488939103, 2330.7319658239267, 2337.684412604294, 2340.6254999200046, 2032.3598066609045, 2104.6527322991687, 2226.443389152712, 2284.0407029047838, 2285.42864283929, 2134.8505604607685, 2163.8809865457392, 2281.703378560793, 2303.815694744425, 2306.8269879759087, 2233.2406981626164, 2289.9313020609407, 2295.173737454515, 2331.5453486570127, 2334.4280651240556, 6991.755288564927, 7121.8219544511285, 7901.486403383762, 8112.067112282045, 8231.876521852177, 4941.703497790144, 5095.363079615048, 5104.591632669378, 5105.412877519096, 5106.872328191787, 3221.520757581806, 3403.5235067090625, 3430.622631510532, 3486.2330287336745, 3489.3719130556487, 1141.2923987128033, 1179.6932797472632, 1208.2267348896712, 1225.7180848404917, 1238.8946939510151, 10506.737331566696, 10522.579096836118, 10538.419237114418, 10563.683089507327, 10629.893701062967, 4442.511323754385, 4565.748883811356, 4656.348111264358, 4686.601638860735, 4700.271457924027, 9336.57985390659, 9415.670451534163, 9422.199113075465, 9430.481323527134, 9431.292653051049, 5230.293910322058, 5233.215017747369, 5234.502722241381, 5239.659422137549, 5240.895182096337, 4580.1984652686315, 4687.648426368036, 4694.671373003857, 4800.615950723934, 4815.879603009953, 3693.132113953219, 3793.1172309045323, 3825.407061905409, 3832.8466861325232, 3926.1951299983434, 1249.0881656390886, 1250.787366147757, 1250.7998720204723, 1269.892059174962, 1280.2382582363664, 664.4949838123061, 859.7463748194298, 881.4579033894237, 891.460666296894, 928.1553786054658, 4479.641628669699, 5367.919481207785, 5395.2986111806, 5521.475459831309, 5550.306211723535, 932.5896605493562, 949.7625593601599, 962.3552220012608, 987.7678745494803, 1004.4023805835516, 2932.5307950728206, 3785.375413056815, 3794.4687743715904, 3860.285847118292, 3867.504907685764, 9647.469389183661, 9879.715636967292, 9884.0, 9891.307608467338, 9894.653687120915, 9202.861957070649, 9664.275179361575, 9825.312228144105, 9843.557039933221, 9881.901180988241, 7542.547447153188, 7733.265339792711, 7735.265149810759, 7735.922640773632, 7742.419318551131, 5242.449542797951, 5279.313689220377, 5374.355077390738, 5416.079266524779, 5458.5087342139395, 8698.869516957377, 8709.738707838775, 8754.781130471789, 8834.277315923333, 8945.642174312954, 7518.8890773086705, 8898.86651700238, 9105.817883642423, 9203.631854725736, 9236.491992940453, 6404.519661025535, 7005.474589405917, 7177.677004534704, 7177.7487787927175, 7200.387967022862, 6995.895061573979, 7755.883661744965, 7875.881861772193, 7930.246626570467, 7943.880841787262, 6997.545159564612, 7100.183478899992, 7102.538335008208, 7103.183133939663, 7231.963840180765, 6982.546134501241, 6997.0, 6999.1950925644205, 7024.227334993045, 7065.6113913735235, 5209.765560549708, 6072.969635151796, 6096.0855871619615, 6141.232345956755, 6198.0, 4882.145624515767, 4907.533784290486, 4911.533404326583, 4958.438092001008, 5042.445331013512, 4857.198562237191, 5022.874428139179, 5037.143685573535, 5056.82301119459, 5124.769385377593], "value": 4339.654215662538, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.08367161707946, 368.7658336956032, 369.9426588878725, 377.54317276095924, 377.8073182676834, 4833.830815921444, 5011.749412529377, 5160.20016897381, 5210.452902445246, 5225.32070830792, 4206.495220573528, 4233.809478573464, 4486.371907932892, 5216.426193118754, 5216.652506372128, 3361.2354811498267, 3674.6692797648207, 3808.7143464240226, 3993.7603743775467, 4027.3556231003045, 3300.6204286507, 3632.891013269606, 4019.437278780973, 4021.457103291062, 4035.273650742865, 3433.8798142065034, 4043.2722110020186, 4070.3690927906073, 4080.7551546907134, 4099.6720262379085, 3855.6337147970758, 3977.210255385088, 3991.2815693175216, 4014.2372949139863, 4085.673146148316, 3368.3936891359544, 3590.622984586633, 3637.4177232903508, 3637.854485820564, 3655.1958569114754, 4470.396496472967, 5062.746862656889, 5069.315642388267, 5221.817236396708, 5222.5531149441185, 3775.8678446254526, 4558.544145585448, 4632.235681112612, 4737.692050016738, 4808.711477311373, 4669.7858556775145, 4843.709377437365, 5415.891682166374, 5457.836264912059, 5480.616356855022, 3858.401947698111, 4008.779517126557, 4011.6991225657903, 4019.738716983416, 4057.878263652095, 4682.765861706969, 5063.01271252106, 5294.92057619136, 5425.593080518937, 5449.4005659377435, 3724.981375093161, 4066.7356621819486, 4077.7757223353, 4086.162336720965, 4103.733257338264, 4112.280350938574, 4143.6685065194715, 4146.751194928314, 4148.211839750437, 4156.9792151039055, 3773.584905660375, 4383.846565370261, 4645.256758918556, 4709.764511774466, 4751.192297309466, 5453.64551304164, 5458.37997761069, 5474.0, 5487.451254874481, 5507.284053073155, 1179.4279774309452, 1297.605074544868, 1346.8047133165833, 1351.2635613590617, 1363.3660347938255, 838.9538575378291, 913.4336711238941, 922.8919867382806, 970.3256236915418, 984.247051005981, 4252.192083504125, 4339.566043395698, 4686.555381794378, 4885.560299573055, 4892.339534162842, 4355.7822108894425, 4652.860414187579, 5023.572996295356, 5143.099957507421, 5289.523942845162, 3894.4937158169255, 4056.634902858757, 4871.683340582851, 4879.097366987119, 4898.314236006961, 2753.600727894444, 2760.6687197536426, 2791.2742686901147, 2795.636567246245, 2807.873645685949, 5487.6921616530835, 5489.780408783604, 5543.837903217748, 5563.388027316992, 5570.860728481739, 4865.49427045065, 4914.72968986702, 5383.461653834664, 5433.914016301688, 5517.641353312022, 4716.311702329639, 5224.947750522522, 5278.841634750964, 5320.201969704575, 5668.0364338063455, 4576.06190730906, 4949.7030178189425, 5335.292706334091, 5349.545288650508, 5355.973220133875, 4590.2818716839465, 4645.790939407667, 4759.119562880878, 4998.400191976986, 5233.502817232356, 4840.975795121002, 4985.7257850817105, 5577.944220557904, 5647.915281270702, 5671.234383358359, 3608.314420260142, 3645.690116340035, 4052.5684589246216, 4077.041895154696, 4078.5309689384912, 5242.47575242488, 5333.7866485340155, 5578.051731205624, 5595.720213989365, 5603.80386686464, 4245.830166793294, 4452.977735111303, 5111.821086261963, 5377.005254028018, 5430.5384042356845, 4863.586595139453, 5083.059633967728, 5336.973315133399, 5382.67703937765, 5430.402655707948, 5081.593472522263, 5270.446603106619, 5300.655457395257, 5300.920486192633, 5333.3066701330135, 5377.596680248918, 5408.972955135199, 5409.972950135381, 5416.377116631637, 5453.972730136324, 4343.869683909487, 4610.861674149781, 5242.951409717995, 5257.764425360114, 5286.920696189483], "value": 3972.5621903574256, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.9647517624114, 710.6730903784259, 768.6195333310012, 802.7551596762987, 804.21588950773, 14926.029808062469, 15355.385784568633, 15736.05583664981, 15755.212239388013, 15756.606084847885, 14297.857021429783, 14446.638834029129, 14449.5665130046, 14450.494232701858, 14459.20474373909, 694.9965250173742, 717.6053170756089, 720.4920531025614, 848.5799529233038, 861.5864385095158, 872.5637181409295, 873.681106396164, 885.6590212768066, 885.9468431894074, 885.9512726800024, 913.0869130869131, 930.3859452761179, 931.1526510875105, 935.2845073518764, 938.6714649872524, 723.6200994477941, 749.5802350683634, 890.1988210610438, 930.6882194464862, 933.2533972821749, 694.7394726977384, 698.5424546921774, 698.9895151572731, 700.5306444682025, 700.5971566349318, 14902.403903843833, 15140.772888406682, 15181.620459488491, 15191.240437978056, 15198.392064317413, 12788.616341509769, 12839.580209895052, 13011.089223754247, 13016.609501714964, 13266.867331326659, 12932.48270069196, 12987.805182922264, 13005.089643724943, 13144.802827957588, 13232.470701171942, 4351.9782401088105, 4595.471520775087, 4606.424196975378, 4677.18149323867, 4683.555062269079, 98042.5097874506, 99229.5115573267, 100160.49919750355, 101020.49489752577, 101038.4948075255, 10063.547140378554, 10499.370037797757, 10726.410047447309, 10878.891211087788, 10890.673279801618, 20642.58714825695, 20798.272060478113, 20936.267230646856, 20961.056752446177, 20971.636843605116, 7472.402207823361, 7537.095548534211, 7547.0, 7643.624147653476, 7686.884696729554, 4116.897077573085, 4120.928558574732, 4150.958490415057, 4157.750534967851, 4173.207090652766, 3403.6085850127056, 3435.57055368079, 3463.4804779282804, 3487.215376540309, 3490.2321489272317, 604.4137186928672, 611.0406661541338, 643.9066335381343, 651.8077167235676, 662.0697919423218, 529.3303970477349, 537.4893850841715, 547.3541221358835, 557.8103444828697, 563.4253061876863, 9254.86117708235, 9325.813483730288, 9695.369800962915, 9788.755281117887, 9794.853077203848, 594.5986459140063, 604.7913469852894, 616.5191150902303, 663.0617675988423, 670.031670625489, 4483.865484035484, 4911.993450675376, 4949.125111764909, 5172.5603323717905, 5175.689458632494, 93851.59222611666, 95699.52150239205, 95841.52079239559, 96183.03816961881, 97756.02243977612, 83224.0, 83375.16624833795, 84377.0, 84957.0, 87427.56286218528, 65955.01067483991, 66091.66954165198, 66239.66880165665, 71472.64263678648, 73637.63181184167, 10813.189010824062, 10863.67408977732, 10964.506597202986, 10966.835497467704, 11215.60745373908, 47691.284630729875, 49106.75446622744, 49387.75306123446, 50299.49700502948, 50844.49155508397, 62078.0, 63589.68205158944, 64593.67703161454, 64664.0, 66591.66704166448, 12662.873371266169, 12941.417636206204, 12984.35078246065, 13351.666208344868, 13656.863431365558, 12262.20295680778, 14378.640533986734, 14584.635384115481, 14631.516416152348, 15526.456574019856, 12620.242785432536, 12641.557545485864, 12682.936585317015, 13186.868131318564, 13214.207147571176, 13322.600321990356, 13627.318634068059, 13639.772420482204, 13647.59057228245, 13693.863061369657, 13285.933570332087, 13433.66415839612, 13455.259960701864, 13483.98870084728, 13641.181529108286, 11194.216404851582, 11221.60724374643, 11324.830127548259, 11668.533258669559, 11688.298702077902, 9950.950245248727, 10830.241883068426, 10867.891321087005, 10868.565257389615, 10946.507407166855], "value": 7398.162876484374, "unit": "score"}], "name": "dromaeo_css", "value": 7238.534244459991, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 112.0, 112.0, 113.0, 114.0, 116.0, 162.0, 136.0, 112.0], "value": 120.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 109.0, 147.0, 114.0, 110.0, 109.0, 111.0, 130.0, 111.0], "value": 119.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 189.0, 258.0, 214.0, 182.0, 180.0, 180.0, 182.0, 184.0, 184.0], "value": 193.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 88.0, 60.0, 57.0, 59.0, 74.0, 96.0, 82.0], "value": 71.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 84.0, 70.0, 68.0, 69.0, 81.0, 68.0, 68.0, 82.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 87.0, 84.0, 88.0, 84.0, 88.0, 85.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 86.0, 85.0, 87.0, 84.0, 85.0, 89.0, 85.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 53.0, 53.0, 55.0, 55.0, 55.0, 55.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 73.0, 80.0, 71.0, 70.0, 70.0, 71.0, 70.0, 72.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 89.0, 88.0, 90.0, 89.0, 89.0, 91.0, 93.0, 88.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 153.0, 152.0, 130.0, 139.0, 142.0, 142.0, 138.0, 182.0, 144.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 247.0, 194.0, 171.0, 174.0, 174.0, 173.0, 177.0, 172.0, 171.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 66.0, 67.0, 66.0, 66.0, 65.0, 67.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1458.3999999999999, "alertThreshold": 2.0}]} 22:57:59 INFO - Return code: 0 22:57:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:57:59 ERROR - # TBPL SUCCESS # 22:57:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:57:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:57:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:57:59 INFO - 2017-01-13 22:57:59.942 screenresolution[1950:15475] starting screenresolution argv=screenresolution get 22:57:59 INFO - 2017-01-13 22:57:59.945 screenresolution[1950:15475] Display 0: 1600x1200x32@60 22:57:59 INFO - 2017-01-13 22:57:59.951 screenresolution[1951:15478] starting screenresolution argv=screenresolution list 22:57:59 INFO - Available Modes on Display 0 22:57:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:57:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:57:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:57:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:58:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:58:00 INFO - Intel Iris: 22:58:00 INFO - Chipset Model: Intel Iris 22:58:00 INFO - Type: GPU 22:58:00 INFO - Bus: Built-In 22:58:00 INFO - VRAM (Dynamic, Max): 1536 MB 22:58:00 INFO - Vendor: Intel (0x8086) 22:58:00 INFO - Device ID: 0x0a2e 22:58:00 INFO - Revision ID: 0x0009 22:58:00 INFO - Displays: 22:58:00 INFO - Display: 22:58:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:58:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:58:00 INFO - Display Serial Number: 1600x1200 60 22:58:00 INFO - Main Display: Yes 22:58:00 INFO - Mirror: Off 22:58:00 INFO - Online: Yes 22:58:00 INFO - Rotation: Supported 22:58:00 INFO - Return code: 0 22:58:00 INFO - Running post-action listener: _resource_record_post_action 22:58:00 INFO - [mozharness: 2017-01-14 06:58:00.186408Z] Finished run-tests step (success) 22:58:00 INFO - Running post-run listener: _resource_record_post_run 22:58:00 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 28327936; Write bytes: 551834624; Read time: 165; Write time: 1637 22:58:00 INFO - TinderboxPrint: CPU usage
53.9% 22:58:00 INFO - TinderboxPrint: I/O read bytes / time
28,327,936 / 165 22:58:00 INFO - TinderboxPrint: I/O write bytes / time
551,834,624 / 1,637 22:58:00 INFO - TinderboxPrint: CPU idle
2,215.4 (46.1%) 22:58:00 INFO - TinderboxPrint: CPU system
961.7 (20.0%) 22:58:00 INFO - TinderboxPrint: CPU user
1,628.6 (33.9%) 22:58:00 INFO - TinderboxPrint: Swap in / out
273,551,360 / 0 22:58:00 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 252660224; Write bytes: 252612608; Read time: 18195; Write time: 531 22:58:00 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 28246016; Write bytes: 297690112; Read time: 163; Write time: 1095 22:58:00 INFO - Running post-run listener: _upload_blobber_files 22:58:00 INFO - Blob upload gear active. 22:58:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:58:00 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 22:58:00 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'] 22:58:00 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 22:58:01 INFO - (blobuploader) - INFO - Open directory for files ... 22:58:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:58:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:58:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:58:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:58:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:58:01 INFO - (blobuploader) - INFO - Done attempting. 22:58:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:58:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:58:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:58:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:58:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:58:02 INFO - (blobuploader) - INFO - Done attempting. 22:58:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:58:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:58:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:58:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:58:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:58:03 INFO - (blobuploader) - INFO - Done attempting. 22:58:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:58:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:58:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:58:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:58:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:58:05 INFO - (blobuploader) - INFO - Done attempting. 22:58:05 INFO - (blobuploader) - INFO - Iteration through files over. 22:58:05 INFO - Return code: 0 22:58:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:58:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:58:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7670374a3646ea2f71df42f0c2740f22305c66ee6d7115ea041aad06a1dc4fec129ba2a4b649adb490cf11e8fd1b190354799d476577cab0e10529efec562f57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f42be0a45fe3118572939862ab69a77cbd98a4d8c64aa74e8c4a002815fd2ade0bcff16317cc52f93e85b04a5ac1bf151687de63d8bea446ced86f3455c759e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4329b343b00f4288f9844cf3cad8aa3e98635432ad8e7a054468e1c0f099ed8fc33922e5e04aa8d6cc5464a9c5f1f1c8a4042fa6cc6e69f7e37e7ee5c6c30b9c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/18e1f3c8bc79ef0d23c396fb8150220c634e80d890053dcd17d1117628d5372de4c8f4bbfb8acde35908581cb6cb41eb3ce4ccdd7fd31ae575d6b1cccf44da8c"} 22:58:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:58:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:58:05 INFO - Contents: 22:58:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7670374a3646ea2f71df42f0c2740f22305c66ee6d7115ea041aad06a1dc4fec129ba2a4b649adb490cf11e8fd1b190354799d476577cab0e10529efec562f57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f42be0a45fe3118572939862ab69a77cbd98a4d8c64aa74e8c4a002815fd2ade0bcff16317cc52f93e85b04a5ac1bf151687de63d8bea446ced86f3455c759e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4329b343b00f4288f9844cf3cad8aa3e98635432ad8e7a054468e1c0f099ed8fc33922e5e04aa8d6cc5464a9c5f1f1c8a4042fa6cc6e69f7e37e7ee5c6c30b9c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/18e1f3c8bc79ef0d23c396fb8150220c634e80d890053dcd17d1117628d5372de4c8f4bbfb8acde35908581cb6cb41eb3ce4ccdd7fd31ae575d6b1cccf44da8c"} 22:58:05 INFO - Running post-run listener: copy_logs_to_upload_dir 22:58:05 INFO - Copying logs to upload dir... 22:58:05 INFO - mkdir: /builds/slave/test/build/upload/logs 22:58:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.423547 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-13 22:58:05.938314) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 22:58:05.941893) ========= 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.RZ2OLxWSHu/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.0XWU1H5XDK/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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/7670374a3646ea2f71df42f0c2740f22305c66ee6d7115ea041aad06a1dc4fec129ba2a4b649adb490cf11e8fd1b190354799d476577cab0e10529efec562f57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f42be0a45fe3118572939862ab69a77cbd98a4d8c64aa74e8c4a002815fd2ade0bcff16317cc52f93e85b04a5ac1bf151687de63d8bea446ced86f3455c759e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4329b343b00f4288f9844cf3cad8aa3e98635432ad8e7a054468e1c0f099ed8fc33922e5e04aa8d6cc5464a9c5f1f1c8a4042fa6cc6e69f7e37e7ee5c6c30b9c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/18e1f3c8bc79ef0d23c396fb8150220c634e80d890053dcd17d1117628d5372de4c8f4bbfb8acde35908581cb6cb41eb3ce4ccdd7fd31ae575d6b1cccf44da8c"} build_url:https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/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/7670374a3646ea2f71df42f0c2740f22305c66ee6d7115ea041aad06a1dc4fec129ba2a4b649adb490cf11e8fd1b190354799d476577cab0e10529efec562f57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f42be0a45fe3118572939862ab69a77cbd98a4d8c64aa74e8c4a002815fd2ade0bcff16317cc52f93e85b04a5ac1bf151687de63d8bea446ced86f3455c759e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4329b343b00f4288f9844cf3cad8aa3e98635432ad8e7a054468e1c0f099ed8fc33922e5e04aa8d6cc5464a9c5f1f1c8a4042fa6cc6e69f7e37e7ee5c6c30b9c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/18e1f3c8bc79ef0d23c396fb8150220c634e80d890053dcd17d1117628d5372de4c8f4bbfb8acde35908581cb6cb41eb3ce4ccdd7fd31ae575d6b1cccf44da8c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 22:58:05.980590) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 22:58:05.980976) ========= 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.RZ2OLxWSHu/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.0XWU1H5XDK/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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.005329 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 22:58:06.032162) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 22:58:06.032888) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 22:58:06.033670) ========= ========= Total master_lag: 0.20 =========