builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0347 starttime: 1480889986.74 results: success (0) buildid: 20161204125338 builduid: 9a43496d8b3c4bd8bdbd2d627715d9a5 revision: 166e3210dcc64181f5541b6b9382faafcf5859a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-04 14:19:46.739691) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-04 14:19:46.740131) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-04 14:19:46.740419) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-04 14:19:46.909305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 14:19:46.909599) ========= 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.Dk7ZN1bqDn/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.pR7uoVFxJA/Listeners TMPDIR=/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 --2016-12-04 14:19:46-- 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% 135M=0s 2016-12-04 14:19:47 (135 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.593179 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 14:19:47.527740) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 14:19:47.528040) ========= 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.Dk7ZN1bqDn/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.pR7uoVFxJA/Listeners TMPDIR=/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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.019799 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 14:19:47.576747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-04 14:19:47.577059) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 166e3210dcc64181f5541b6b9382faafcf5859a2 --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 166e3210dcc64181f5541b6b9382faafcf5859a2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Dk7ZN1bqDn/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.pR7uoVFxJA/Listeners TMPDIR=/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 2016-12-04 14:19:47,552 truncating revision to first 12 chars 2016-12-04 14:19:47,553 Setting DEBUG logging. 2016-12-04 14:19:47,553 attempt 1/10 2016-12-04 14:19:47,553 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/166e3210dcc6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-04 14:19:48,815 unpacking tar archive at: graphics-166e3210dcc6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.528037 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-04 14:19:49.128700) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-04 14:19:49.129005) ========= script_repo_revision: 166e3210dcc64181f5541b6b9382faafcf5859a2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-04 14:19:49.129395) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-04 14:19:49.129660) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-04 14:19:49.147987) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-12-04 14:19:49.148290) ========= /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.Dk7ZN1bqDn/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.pR7uoVFxJA/Listeners TMPDIR=/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 14:19:49 INFO - MultiFileLogger online at 20161204 14:19:49 in /builds/slave/test 14:19:49 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 14:19:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:19:49 INFO - {'append_to_log': False, 14:19:49 INFO - 'base_work_dir': '/builds/slave/test', 14:19:49 INFO - 'blob_upload_branch': 'Graphics', 14:19:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:19:49 INFO - 'branch': 'Graphics', 14:19:49 INFO - 'buildbot_json_path': 'buildprops.json', 14:19:49 INFO - 'config_files': ('talos/mac_config.py',), 14:19:49 INFO - 'default_actions': ('clobber', 14:19:49 INFO - 'read-buildbot-config', 14:19:49 INFO - 'download-and-extract', 14:19:49 INFO - 'populate-webroot', 14:19:49 INFO - 'create-virtualenv', 14:19:49 INFO - 'install', 14:19:49 INFO - 'run-tests'), 14:19:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:19:49 INFO - 'download_minidump_stackwalk': True, 14:19:49 INFO - 'download_symbols': 'ondemand', 14:19:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:19:49 INFO - 'tooltool.py': '/tools/tooltool.py', 14:19:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:19:49 INFO - '/tools/misc-python/virtualenv.py')}, 14:19:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:19:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:19:49 INFO - 'installer_path': 'installer.exe', 14:19:49 INFO - 'log_level': 'info', 14:19:49 INFO - 'log_name': 'talos', 14:19:49 INFO - 'log_to_console': True, 14:19:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:19:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:19:49 INFO - 'opt_config_files': (), 14:19:49 INFO - 'pip_index': False, 14:19:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:19:49 INFO - 'cmd': ('bash', 14:19:49 INFO - '-c', 14:19:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:19:49 INFO - 'enabled': True, 14:19:49 INFO - 'halt_on_failure': False, 14:19:49 INFO - 'name': 'check_screen_resolution'},), 14:19:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:19:49 INFO - 'cmd': ('bash', 14:19:49 INFO - '-c', 14:19:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:19:49 INFO - 'enabled': True, 14:19:49 INFO - 'halt_on_failure': False, 14:19:49 INFO - 'name': 'check_screen_resolution'},), 14:19:49 INFO - 'run_cmd_checks_enabled': True, 14:19:49 INFO - 'sps_profile': False, 14:19:49 INFO - 'sps_profile_interval': 0, 14:19:49 INFO - 'suite': 'dromaeojs', 14:19:49 INFO - 'system_bits': '32', 14:19:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:19:49 INFO - 'title': 't-yosemite-r7-0347', 14:19:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:19:49 INFO - 'use_talos_json': True, 14:19:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:19:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:19:49 INFO - 'work_dir': 'build'} 14:19:49 INFO - [mozharness: 2016-12-04 22:19:49.245584Z] Running clobber step. 14:19:49 INFO - Running pre-action listener: _resource_record_pre_action 14:19:49 INFO - Running main action method: clobber 14:19:49 INFO - rmtree: /builds/slave/test/build 14:19:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:19:50 INFO - Running post-action listener: _resource_record_post_action 14:19:50 INFO - [mozharness: 2016-12-04 22:19:50.777943Z] Finished clobber step (success) 14:19:50 INFO - [mozharness: 2016-12-04 22:19:50.778103Z] Running read-buildbot-config step. 14:19:50 INFO - Running pre-action listener: _resource_record_pre_action 14:19:50 INFO - Running main action method: read_buildbot_config 14:19:50 INFO - Using buildbot properties: 14:19:50 INFO - { 14:19:50 INFO - "project": "", 14:19:50 INFO - "product": "firefox", 14:19:50 INFO - "script_repo_revision": "default", 14:19:50 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 14:19:50 INFO - "repository": "", 14:19:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 14:19:50 INFO - "buildid": "20161204125338", 14:19:50 INFO - "pgo_build": "False", 14:19:50 INFO - "basedir": "/builds/slave/test", 14:19:50 INFO - "buildnumber": 10, 14:19:50 INFO - "slavename": "t-yosemite-r7-0347", 14:19:50 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:19:50 INFO - "platform": "yosemite_r7", 14:19:50 INFO - "scheduler": "tests-graphics-macosx64-talos", 14:19:50 INFO - "branch": "graphics", 14:19:50 INFO - "repo_path": "projects/graphics", 14:19:50 INFO - "revision": "166e3210dcc64181f5541b6b9382faafcf5859a2", 14:19:50 INFO - "stage_platform": "macosx64", 14:19:50 INFO - "builduid": "9a43496d8b3c4bd8bdbd2d627715d9a5", 14:19:50 INFO - "slavebuilddir": "test" 14:19:50 INFO - } 14:19:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 14:19:50 INFO - Running post-action listener: _resource_record_post_action 14:19:50 INFO - [mozharness: 2016-12-04 22:19:50.781233Z] Finished read-buildbot-config step (success) 14:19:50 INFO - [mozharness: 2016-12-04 22:19:50.781366Z] Running download-and-extract step. 14:19:50 INFO - Running pre-action listener: _resource_record_pre_action 14:19:50 INFO - Running main action method: download_and_extract 14:19:50 INFO - mkdir: /builds/slave/test/build/tests 14:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:50 INFO - trying https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 14:19:50 INFO - Downloading https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/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 14:19:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/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 14:19:51 INFO - Downloaded 1199 bytes. 14:19:51 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:19:51 INFO - Using the following test package requirements: 14:19:51 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:19:51 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:19:51 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 14:19:51 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:19:51 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 14:19:51 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:19:51 INFO - u'jsshell-mac.zip'], 14:19:51 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:19:51 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 14:19:51 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:19:51 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:19:51 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 14:19:51 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:19:51 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 14:19:51 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:19:51 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 14:19:51 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:19:51 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 14:19:51 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:19:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:19:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:19:51 INFO - Fetch https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:19:52 INFO - Http code: 200 14:19:52 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 14:19:52 INFO - x-amz-cf-id: -MGQLW9jyHgdFW_Yy3U7z0gh_NQciy6hCe8pIiwxGJyzcfbzfQ7nIg== 14:19:52 INFO - x-amz-version-id: ffldtD4DIMJGGbUiesAZkKaVI7tLde0E 14:19:52 INFO - Expected file size: 16282598 14:19:52 INFO - Obtained file size: 16282598 14:19:59 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 14:19:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:19:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:19:59 INFO - Fetch https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:19:59 INFO - Http code: 200 14:19:59 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 14:19:59 INFO - x-amz-cf-id: 2-NCbqmJVsdoUfxtXUghN7XA3RccC6nPAA3llCV_Lg7XWWt6-2kR1w== 14:19:59 INFO - x-amz-version-id: ffldtD4DIMJGGbUiesAZkKaVI7tLde0E 14:20:00 INFO - Expected file size: 16282598 14:20:00 INFO - Obtained file size: 16282598 14:20:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 14:20:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:20:06 INFO - Fetch https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 14:20:07 INFO - Http code: 200 14:20:07 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 14:20:07 INFO - x-amz-cf-id: n439UcWtqPrX6i8ZRLjtqklPivT85Wr7KCbwlSZJexmupWbcbMC9PQ== 14:20:07 INFO - x-amz-version-id: IX96gzy3YLndPTj8gll0WE2CAruqomXR 14:20:08 INFO - Expected file size: 14409702 14:20:08 INFO - Obtained file size: 14409702 14:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:20:08 INFO - trying https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:20:08 INFO - Downloading https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 14:20:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/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 14:20:11 INFO - Downloaded 107606756 bytes. 14:20:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:20:11 INFO - mkdir: /builds/slave/test/properties 14:20:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:20:11 INFO - Writing to file /builds/slave/test/properties/build_url 14:20:11 INFO - Contents: 14:20:11 INFO - build_url:https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:20:11 INFO - Running post-action listener: _resource_record_post_action 14:20:11 INFO - Running post-action listener: set_extra_try_arguments 14:20:11 INFO - [mozharness: 2016-12-04 22:20:11.821698Z] Finished download-and-extract step (success) 14:20:11 INFO - [mozharness: 2016-12-04 22:20:11.821821Z] Running populate-webroot step. 14:20:11 INFO - Running pre-action listener: _resource_record_pre_action 14:20:11 INFO - Running main action method: populate_webroot 14:20:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:20:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:20:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:20:11 INFO - '--tppagecycles', 14:20:11 INFO - '7'], 14:20:11 INFO - 'tests': ['tsvgm']}}, 14:20:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:20:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:20:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:20:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:20:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:20:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:20:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:20:11 INFO - 'talos_options': ['--disable-e10s'], 14:20:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:20:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:20:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:20:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:20:11 INFO - 'talos_options': ['--disable-e10s'], 14:20:11 INFO - 'tests': ['damp', 'tps']}, 14:20:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:20:11 INFO - 'tests': ['damp', 'tps']}, 14:20:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:20:11 INFO - 'tests': ['dromaeo_dom']}, 14:20:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:20:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:20:11 INFO - 'tests': ['basic_compositor_video']}, 14:20:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:20:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:20:11 INFO - 'tests': ['a11yr', 14:20:11 INFO - 'ts_paint', 14:20:11 INFO - 'tpaint', 14:20:11 INFO - 'sessionrestore', 14:20:11 INFO - 'sessionrestore_no_auto_restore', 14:20:11 INFO - 'tabpaint']}, 14:20:11 INFO - 'other-e10s': {'tests': ['a11yr', 14:20:11 INFO - 'ts_paint', 14:20:11 INFO - 'tpaint', 14:20:11 INFO - 'sessionrestore', 14:20:11 INFO - 'sessionrestore_no_auto_restore', 14:20:11 INFO - 'tabpaint']}, 14:20:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:20:11 INFO - 'ts_paint', 14:20:11 INFO - 'tpaint', 14:20:11 INFO - 'sessionrestore', 14:20:11 INFO - 'sessionrestore_no_auto_restore', 14:20:11 INFO - 'tabpaint']}, 14:20:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:20:11 INFO - 'ts_paint', 14:20:11 INFO - 'tpaint', 14:20:11 INFO - 'sessionrestore', 14:20:11 INFO - 'sessionrestore_no_auto_restore', 14:20:11 INFO - 'tabpaint']}, 14:20:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:20:11 INFO - 'tests': ['a11yr', 14:20:11 INFO - 'ts_paint', 14:20:11 INFO - 'tpaint', 14:20:11 INFO - 'sessionrestore', 14:20:11 INFO - 'sessionrestore_no_auto_restore', 14:20:11 INFO - 'tabpaint']}, 14:20:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:20:11 INFO - 'tests': ['a11yr', 14:20:11 INFO - 'ts_paint', 14:20:11 INFO - 'tpaint', 14:20:11 INFO - 'sessionrestore', 14:20:11 INFO - 'sessionrestore_no_auto_restore', 14:20:11 INFO - 'tabpaint']}, 14:20:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:20:11 INFO - 'tests': ['tsvgx', 14:20:11 INFO - 'tsvgr_opacity', 14:20:11 INFO - 'tart', 14:20:11 INFO - 'tscrollx', 14:20:11 INFO - 'cart', 14:20:11 INFO - 'tsvg_static']}, 14:20:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:20:11 INFO - 'tsvgr_opacity', 14:20:11 INFO - 'tart', 14:20:11 INFO - 'tscrollx', 14:20:11 INFO - 'cart', 14:20:11 INFO - 'tsvg_static']}, 14:20:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:20:11 INFO - 'talos_options': ['--disable-e10s'], 14:20:11 INFO - 'tests': ['tp5o']}, 14:20:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:20:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:20:11 INFO - 'talos_options': ['--disable-e10s', 14:20:11 INFO - '--xperf_path', 14:20:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:20:11 INFO - 'tests': ['tp5n']}, 14:20:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:20:11 INFO - 'talos_options': ['--xperf_path', 14:20:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:20:11 INFO - 'tests': ['tp5n']}}, 14:20:11 INFO - 'talos.zip': {'path': '', 14:20:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:20:11 INFO - Running post-action listener: _resource_record_post_action 14:20:11 INFO - [mozharness: 2016-12-04 22:20:11.840289Z] Finished populate-webroot step (success) 14:20:11 INFO - [mozharness: 2016-12-04 22:20:11.840394Z] Running create-virtualenv step. 14:20:11 INFO - Running pre-action listener: _resource_record_pre_action 14:20:11 INFO - Running main action method: create_virtualenv 14:20:11 INFO - Creating virtualenv /builds/slave/test/build/venv 14:20:11 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 14:20:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:20:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:20:11 INFO - Using real prefix '/tools/python27' 14:20:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:20:12 INFO - Installing distribute.............................................................................................................................................................................................done. 14:20:15 INFO - Installing pip.................done. 14:20:15 INFO - Return code: 0 14:20:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:20:15 INFO - Reading from file tmpfile_stdout 14:20:15 INFO - Output received: 14:20:15 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) 14:20:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:20:15 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')]} 14:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:15 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')]} 14:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:15 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 0x109a103f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109986570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc041c80970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826d30>, '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 0x10968ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981eb20>, '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.Dk7ZN1bqDn/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.pR7uoVFxJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 14:20:15 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 14:20:15 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 14:20:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk7ZN1bqDn/Render', 14:20:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:15 INFO - 'HOME': '/Users/cltbld', 14:20:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:15 INFO - 'LOGNAME': 'cltbld', 14:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:15 INFO - 'MOZ_NO_REMOTE': '1', 14:20:15 INFO - 'NO_EM_RESTART': '1', 14:20:15 INFO - 'PAGER': '/bin/cat', 14:20:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:15 INFO - 'PWD': '/builds/slave/test', 14:20:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:15 INFO - 'SHELL': '/bin/bash', 14:20:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pR7uoVFxJA/Listeners', 14:20:15 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 14:20:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:15 INFO - 'USER': 'cltbld', 14:20:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:15 INFO - 'XPC_FLAGS': '0x0', 14:20:15 INFO - 'XPC_SERVICE_NAME': '0', 14:20:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:16 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 14:20:16 INFO - Cleaning up... 14:20:16 INFO - Return code: 0 14:20:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:20:16 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')]} 14:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:16 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')]} 14:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:16 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 0x109a103f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109986570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc041c80970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826d30>, '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 0x10968ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981eb20>, '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.Dk7ZN1bqDn/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.pR7uoVFxJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 14:20:16 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 14:20:16 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 14:20:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk7ZN1bqDn/Render', 14:20:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:16 INFO - 'HOME': '/Users/cltbld', 14:20:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:16 INFO - 'LOGNAME': 'cltbld', 14:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:16 INFO - 'MOZ_NO_REMOTE': '1', 14:20:16 INFO - 'NO_EM_RESTART': '1', 14:20:16 INFO - 'PAGER': '/bin/cat', 14:20:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:16 INFO - 'PWD': '/builds/slave/test', 14:20:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:16 INFO - 'SHELL': '/bin/bash', 14:20:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pR7uoVFxJA/Listeners', 14:20:16 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 14:20:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:16 INFO - 'USER': 'cltbld', 14:20:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:16 INFO - 'XPC_FLAGS': '0x0', 14:20:16 INFO - 'XPC_SERVICE_NAME': '0', 14:20:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:16 INFO - Downloading/unpacking psutil>=3.1.1 14:20:16 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 14:20:16 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 14:20:16 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 14:20:16 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 14:20:16 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 14:20:16 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 14:20:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:20:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:20:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:20:20 INFO - Installing collected packages: psutil 14:20:20 INFO - Running setup.py install for psutil 14:20:20 INFO - building 'psutil._psutil_osx' extension 14:20:20 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 14:20:20 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 14:20:21 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 14:20:21 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 14:20:21 INFO - building 'psutil._psutil_posix' extension 14:20:21 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 14:20:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:20:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:20:21 INFO - ^ 14:20:21 INFO - 1 warning generated. 14:20:21 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 14:20:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:20:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:20:21 INFO - Successfully installed psutil 14:20:21 INFO - Cleaning up... 14:20:21 INFO - Return code: 0 14:20:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:20:21 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')]} 14:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:21 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')]} 14:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:21 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 0x109a103f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109986570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc041c80970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826d30>, '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 0x10968ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981eb20>, '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.Dk7ZN1bqDn/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.pR7uoVFxJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 14:20:21 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 14:20:21 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 14:20:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk7ZN1bqDn/Render', 14:20:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:21 INFO - 'HOME': '/Users/cltbld', 14:20:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:21 INFO - 'LOGNAME': 'cltbld', 14:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:21 INFO - 'MOZ_NO_REMOTE': '1', 14:20:21 INFO - 'NO_EM_RESTART': '1', 14:20:21 INFO - 'PAGER': '/bin/cat', 14:20:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:21 INFO - 'PWD': '/builds/slave/test', 14:20:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:21 INFO - 'SHELL': '/bin/bash', 14:20:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pR7uoVFxJA/Listeners', 14:20:21 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 14:20:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:21 INFO - 'USER': 'cltbld', 14:20:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:21 INFO - 'XPC_FLAGS': '0x0', 14:20:21 INFO - 'XPC_SERVICE_NAME': '0', 14:20:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:20:21 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 14:20:21 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 14:20:21 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 14:20:21 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 14:20:21 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 14:20:21 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 14:20:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:20:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:20:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:20:24 INFO - Installing collected packages: mozsystemmonitor 14:20:24 INFO - Running setup.py install for mozsystemmonitor 14:20:24 INFO - Successfully installed mozsystemmonitor 14:20:24 INFO - Cleaning up... 14:20:24 INFO - Return code: 0 14:20:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109a103f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109986570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc041c80970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826d30>, '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 0x10968ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981eb20>, '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.Dk7ZN1bqDn/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.pR7uoVFxJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 14:20:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:20:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:20:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk7ZN1bqDn/Render', 14:20:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:24 INFO - 'HOME': '/Users/cltbld', 14:20:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:24 INFO - 'LOGNAME': 'cltbld', 14:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:24 INFO - 'MOZ_NO_REMOTE': '1', 14:20:24 INFO - 'NO_EM_RESTART': '1', 14:20:24 INFO - 'PAGER': '/bin/cat', 14:20:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:24 INFO - 'PWD': '/builds/slave/test', 14:20:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:24 INFO - 'SHELL': '/bin/bash', 14:20:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pR7uoVFxJA/Listeners', 14:20:24 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 14:20:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:24 INFO - 'USER': 'cltbld', 14:20:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:24 INFO - 'XPC_FLAGS': '0x0', 14:20:24 INFO - 'XPC_SERVICE_NAME': '0', 14:20:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:25 INFO - Downloading/unpacking jsonschema==2.5.1 14:20:25 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 14:20:25 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 14:20:25 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 14:20:25 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 14:20:25 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 14:20:25 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 14:20:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:20:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:28 INFO - Downloading functools32-3.2.3-2.tar.gz 14:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:20:28 INFO - warning: no files found matching '*.txt' 14:20:28 INFO - no previously-included directories found matching 'build' 14:20:28 INFO - no previously-included directories found matching 'dist' 14:20:28 INFO - no previously-included directories found matching '.git*' 14:20:28 INFO - Installing collected packages: jsonschema, functools32 14:20:28 INFO - Running setup.py install for functools32 14:20:28 INFO - warning: no files found matching '*.txt' 14:20:28 INFO - no previously-included directories found matching 'build' 14:20:28 INFO - no previously-included directories found matching 'dist' 14:20:28 INFO - no previously-included directories found matching '.git*' 14:20:28 INFO - Successfully installed jsonschema functools32 14:20:28 INFO - Cleaning up... 14:20:28 INFO - Return code: 0 14:20:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:20:28 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')]} 14:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:28 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')]} 14:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:28 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 0x109a103f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109986570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc041c80970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826d30>, '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 0x10968ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981eb20>, '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.Dk7ZN1bqDn/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.pR7uoVFxJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 14:20:28 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 14:20:28 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 14:20:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk7ZN1bqDn/Render', 14:20:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:28 INFO - 'HOME': '/Users/cltbld', 14:20:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:28 INFO - 'LOGNAME': 'cltbld', 14:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:28 INFO - 'MOZ_NO_REMOTE': '1', 14:20:28 INFO - 'NO_EM_RESTART': '1', 14:20:28 INFO - 'PAGER': '/bin/cat', 14:20:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:28 INFO - 'PWD': '/builds/slave/test', 14:20:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:28 INFO - 'SHELL': '/bin/bash', 14:20:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pR7uoVFxJA/Listeners', 14:20:28 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 14:20:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:28 INFO - 'USER': 'cltbld', 14:20:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:28 INFO - 'XPC_FLAGS': '0x0', 14:20:28 INFO - 'XPC_SERVICE_NAME': '0', 14:20:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:20:28 INFO - Cleaning up... 14:20:28 INFO - Return code: 0 14:20:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:20:28 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')]} 14:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:28 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')]} 14:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:28 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 0x109a103f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109986570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc041c80970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826d30>, '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 0x10968ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981eb20>, '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.Dk7ZN1bqDn/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.pR7uoVFxJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 14:20:28 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 14:20:28 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 14:20:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk7ZN1bqDn/Render', 14:20:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:28 INFO - 'HOME': '/Users/cltbld', 14:20:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:28 INFO - 'LOGNAME': 'cltbld', 14:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:28 INFO - 'MOZ_NO_REMOTE': '1', 14:20:28 INFO - 'NO_EM_RESTART': '1', 14:20:28 INFO - 'PAGER': '/bin/cat', 14:20:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:28 INFO - 'PWD': '/builds/slave/test', 14:20:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:28 INFO - 'SHELL': '/bin/bash', 14:20:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pR7uoVFxJA/Listeners', 14:20:28 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 14:20:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:28 INFO - 'USER': 'cltbld', 14:20:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:28 INFO - 'XPC_FLAGS': '0x0', 14:20:28 INFO - 'XPC_SERVICE_NAME': '0', 14:20:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:29 INFO - Downloading/unpacking blobuploader==1.2.4 14:20:29 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 14:20:29 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 14:20:29 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 14:20:29 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 14:20:29 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 14:20:29 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 14:20:31 INFO - Downloading blobuploader-1.2.4.tar.gz 14:20:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:20:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:20:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:20:32 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 14:20:32 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 14:20:32 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 14:20:32 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 14:20:32 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 14:20:32 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 14:20:32 INFO - Downloading docopt-0.6.1.tar.gz 14:20:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:20:32 INFO - Installing collected packages: blobuploader, requests, docopt 14:20:32 INFO - Running setup.py install for blobuploader 14:20:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:20:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:20:33 INFO - Running setup.py install for requests 14:20:33 INFO - Running setup.py install for docopt 14:20:33 INFO - Successfully installed blobuploader requests docopt 14:20:33 INFO - Cleaning up... 14:20:33 INFO - Return code: 0 14:20:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:33 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 0x109a103f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109986570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc041c80970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826d30>, '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 0x10968ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981eb20>, '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.Dk7ZN1bqDn/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.pR7uoVFxJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 14:20:33 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 14:20:33 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 14:20:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk7ZN1bqDn/Render', 14:20:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:33 INFO - 'HOME': '/Users/cltbld', 14:20:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:33 INFO - 'LOGNAME': 'cltbld', 14:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:33 INFO - 'MOZ_NO_REMOTE': '1', 14:20:33 INFO - 'NO_EM_RESTART': '1', 14:20:33 INFO - 'PAGER': '/bin/cat', 14:20:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:33 INFO - 'PWD': '/builds/slave/test', 14:20:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:33 INFO - 'SHELL': '/bin/bash', 14:20:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pR7uoVFxJA/Listeners', 14:20:33 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 14:20:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:33 INFO - 'USER': 'cltbld', 14:20:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:33 INFO - 'XPC_FLAGS': '0x0', 14:20:33 INFO - 'XPC_SERVICE_NAME': '0', 14:20:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:20:34 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-OUYd99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:20:34 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-u2gfut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:20:34 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-qUofCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:20:34 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-xekxDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:20:34 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-CRlaCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:20:34 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-DIgg6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:20:34 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-Lk6nUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:20:34 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-W1zeCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:20:34 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-Vfo97b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:20:35 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-SkHyeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:20:35 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-44S5VL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:20:35 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-PYdMDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:20:35 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-_se5JK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:20:35 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-XEunM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:20:35 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-aFWZqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:20:35 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-hFdKBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:20:35 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-Rcq3mC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:20:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:20:35 INFO - Running setup.py install for manifestparser 14:20:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:20:36 INFO - Running setup.py install for mozcrash 14:20:36 INFO - Running setup.py install for mozdebug 14:20:36 INFO - Running setup.py install for mozdevice 14:20:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:20:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:20:36 INFO - Running setup.py install for mozfile 14:20:36 INFO - Running setup.py install for mozhttpd 14:20:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:20:36 INFO - Running setup.py install for mozinfo 14:20:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:20:36 INFO - Running setup.py install for mozInstall 14:20:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:20:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:20:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:20:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:20:37 INFO - Running setup.py install for mozleak 14:20:37 INFO - Running setup.py install for mozlog 14:20:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:20:37 INFO - Running setup.py install for moznetwork 14:20:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:20:37 INFO - Running setup.py install for mozprocess 14:20:37 INFO - Running setup.py install for mozprofile 14:20:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:20:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:20:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:20:37 INFO - Running setup.py install for mozrunner 14:20:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:20:38 INFO - Running setup.py install for mozscreenshot 14:20:38 INFO - Running setup.py install for moztest 14:20:38 INFO - Running setup.py install for mozversion 14:20:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:20:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:20:38 INFO - Cleaning up... 14:20:38 INFO - Return code: 0 14:20:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:20: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')]} 14:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20: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')]} 14:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:38 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 0x109a103f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109986570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc041c80970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826d30>, '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 0x10968ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981eb20>, '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.Dk7ZN1bqDn/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.pR7uoVFxJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 14:20:38 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 14:20:38 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 14:20:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk7ZN1bqDn/Render', 14:20:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:38 INFO - 'HOME': '/Users/cltbld', 14:20:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:38 INFO - 'LOGNAME': 'cltbld', 14:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:38 INFO - 'MOZ_NO_REMOTE': '1', 14:20:38 INFO - 'NO_EM_RESTART': '1', 14:20:38 INFO - 'PAGER': '/bin/cat', 14:20:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:38 INFO - 'PWD': '/builds/slave/test', 14:20:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:38 INFO - 'SHELL': '/bin/bash', 14:20:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pR7uoVFxJA/Listeners', 14:20:38 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 14:20:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:38 INFO - 'USER': 'cltbld', 14:20:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:38 INFO - 'XPC_FLAGS': '0x0', 14:20:38 INFO - 'XPC_SERVICE_NAME': '0', 14:20:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:20:38 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-6kP908-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:20:38 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)) 14:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:20:38 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-XdXti1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:20:38 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)) 14:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:20:38 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-GUH_xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:20:39 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)) 14:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:20:39 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-k3yy08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:20:39 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)) 14:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:20:39 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-eBHWZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:20:39 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)) 14:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:20:39 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-xgXzpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:20:39 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)) 14:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:20:39 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-HRQN2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:20:39 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)) 14:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:20:39 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-i7MnZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:20:39 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)) 14:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:20:39 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-M_y7zC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:20:39 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)) 14:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:20:39 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-XUEbyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:20:39 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)) 14:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:20:39 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-DM_k1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:20:39 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)) 14:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:20:39 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-XVGVIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 14:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:20:40 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-WuqQMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:20:40 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)) 14:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:20:40 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-k5LXWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:20:40 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)) 14:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:20:40 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-VVsrYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:20:40 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)) 14:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:20:40 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-jS1h6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 14:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:20:40 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-YZc39D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:20:40 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)) 14:20:40 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)) 14:20:40 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)) 14:20:40 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)) 14:20:40 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)) 14:20:40 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)) 14:20:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:43 INFO - Downloading blessings-1.6.tar.gz 14:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:20:43 INFO - Installing collected packages: blessings 14:20:43 INFO - Running setup.py install for blessings 14:20:43 INFO - Successfully installed blessings 14:20:43 INFO - Cleaning up... 14:20:43 INFO - Return code: 0 14:20:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:20:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:20:43 INFO - Reading from file tmpfile_stdout 14:20:43 INFO - Current package versions: 14:20:43 INFO - blessings == 1.6 14:20:43 INFO - blobuploader == 1.2.4 14:20:43 INFO - docopt == 0.6.1 14:20:43 INFO - functools32 == 3.2.3-2 14:20:43 INFO - jsonschema == 2.5.1 14:20:43 INFO - manifestparser == 1.1 14:20:43 INFO - mozInstall == 1.12 14:20:43 INFO - mozcrash == 1.0 14:20:43 INFO - mozdebug == 0.1 14:20:43 INFO - mozdevice == 0.49 14:20:43 INFO - mozfile == 1.2 14:20:43 INFO - mozhttpd == 0.7 14:20:43 INFO - mozinfo == 0.9 14:20:43 INFO - mozleak == 0.1 14:20:43 INFO - mozlog == 3.4 14:20:43 INFO - moznetwork == 0.27 14:20:43 INFO - mozprocess == 0.23 14:20:43 INFO - mozprofile == 0.28 14:20:43 INFO - mozrunner == 6.13 14:20:43 INFO - mozscreenshot == 0.1 14:20:43 INFO - mozsystemmonitor == 0.3 14:20:43 INFO - moztest == 0.7 14:20:43 INFO - mozversion == 1.4 14:20:43 INFO - psutil == 3.1.1 14:20:43 INFO - requests == 1.2.3 14:20:43 INFO - wsgiref == 0.1.2 14:20:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:43 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 0x109a103f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109986570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc041c80970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826d30>, '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 0x10968ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981eb20>, '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.Dk7ZN1bqDn/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.pR7uoVFxJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 14:20:43 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 14:20:43 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 14:20:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk7ZN1bqDn/Render', 14:20:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:43 INFO - 'HOME': '/Users/cltbld', 14:20:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:43 INFO - 'LOGNAME': 'cltbld', 14:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:43 INFO - 'MOZ_NO_REMOTE': '1', 14:20:43 INFO - 'NO_EM_RESTART': '1', 14:20:43 INFO - 'PAGER': '/bin/cat', 14:20:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:43 INFO - 'PWD': '/builds/slave/test', 14:20:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:43 INFO - 'SHELL': '/bin/bash', 14:20:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pR7uoVFxJA/Listeners', 14:20:43 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 14:20:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:43 INFO - 'USER': 'cltbld', 14:20:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:43 INFO - 'XPC_FLAGS': '0x0', 14:20:43 INFO - 'XPC_SERVICE_NAME': '0', 14:20:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:44 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)) 14:20:44 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)) 14:20:44 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)) 14:20:44 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)) 14:20:44 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)) 14:20:44 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)) 14:20:44 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)) 14:20:44 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)) 14:20:44 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)) 14:20:44 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)) 14:20:44 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)) 14:20:44 INFO - Cleaning up... 14:20:44 INFO - Return code: 0 14:20:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a103f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109986570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc041c80970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826d30>, '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 0x10968ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981eb20>, '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.Dk7ZN1bqDn/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.pR7uoVFxJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 14:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:20:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk7ZN1bqDn/Render', 14:20:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:44 INFO - 'HOME': '/Users/cltbld', 14:20:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:44 INFO - 'LOGNAME': 'cltbld', 14:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:44 INFO - 'MOZ_NO_REMOTE': '1', 14:20:44 INFO - 'NO_EM_RESTART': '1', 14:20:44 INFO - 'PAGER': '/bin/cat', 14:20:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:44 INFO - 'PWD': '/builds/slave/test', 14:20:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:44 INFO - 'SHELL': '/bin/bash', 14:20:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pR7uoVFxJA/Listeners', 14:20:44 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 14:20:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:44 INFO - 'USER': 'cltbld', 14:20:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:44 INFO - 'XPC_FLAGS': '0x0', 14:20:44 INFO - 'XPC_SERVICE_NAME': '0', 14:20:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:20:44 INFO - Cleaning up... 14:20:44 INFO - Return code: 0 14:20:44 INFO - Running post-action listener: _resource_record_post_action 14:20:44 INFO - Running post-action listener: _start_resource_monitoring 14:20:44 INFO - Starting resource monitoring. 14:20:44 INFO - [mozharness: 2016-12-04 22:20:44.438743Z] Finished create-virtualenv step (success) 14:20:44 INFO - [mozharness: 2016-12-04 22:20:44.439890Z] Running install step. 14:20:44 INFO - Running pre-action listener: _resource_record_pre_action 14:20:44 INFO - Running main action method: install 14:20:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:20:44 INFO - Reading from file tmpfile_stdout 14:20:44 INFO - Detecting whether we're running mozinstall >=1.0... 14:20:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:20:44 INFO - Reading from file tmpfile_stdout 14:20:44 INFO - Output received: 14:20:44 INFO - Usage: mozinstall [options] installer 14:20:44 INFO - Options: 14:20:44 INFO - -h, --help show this help message and exit 14:20:44 INFO - -d DEST, --destination=DEST 14:20:44 INFO - Directory to install application into. [default: 14:20:44 INFO - "/builds/slave/test"] 14:20:44 INFO - --app=APP Application being installed. [default: firefox] 14:20:44 INFO - mkdir: /builds/slave/test/build/application 14:20:44 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'] 14:20:44 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 14:21:17 INFO - Reading from file tmpfile_stdout 14:21:17 INFO - Output received: 14:21:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:21:17 INFO - Running post-action listener: _resource_record_post_action 14:21:17 INFO - [mozharness: 2016-12-04 22:21:17.832035Z] Finished install step (success) 14:21:17 INFO - [mozharness: 2016-12-04 22:21:17.832205Z] Running run-tests step. 14:21:17 INFO - Running pre-action listener: _resource_record_pre_action 14:21:17 INFO - Running main action method: run_tests 14:21:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:21:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:21:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:21:17 INFO - 2016-12-04 14:21:17.846 screenresolution[2547:32869] starting screenresolution argv=screenresolution get 14:21:17 INFO - 2016-12-04 14:21:17.849 screenresolution[2547:32869] Display 0: 1600x1200x32@60 14:21:17 INFO - 2016-12-04 14:21:17.855 screenresolution[2548:32871] starting screenresolution argv=screenresolution list 14:21:17 INFO - Available Modes on Display 0 14:21:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:21:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:21:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:21:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:21:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:21:18 INFO - Intel Iris: 14:21:18 INFO - Chipset Model: Intel Iris 14:21:18 INFO - Type: GPU 14:21:18 INFO - Bus: Built-In 14:21:18 INFO - VRAM (Dynamic, Max): 1536 MB 14:21:18 INFO - Vendor: Intel (0x8086) 14:21:18 INFO - Device ID: 0x0a2e 14:21:18 INFO - Revision ID: 0x0009 14:21:18 INFO - Displays: 14:21:18 INFO - Display: 14:21:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:21:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:21:18 INFO - Display Serial Number: 1600x1200 60 14:21:18 INFO - Main Display: Yes 14:21:18 INFO - Mirror: Off 14:21:18 INFO - Online: Yes 14:21:18 INFO - Rotation: Supported 14:21:18 INFO - Return code: 0 14:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:21:18 INFO - Python 2.7.3 14:21:18 INFO - Return code: 0 14:21:18 INFO - grabbing minidump binary from tooltool 14:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826d30>, '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 0x10968ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10981eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:21:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:21:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:21:18 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:21:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:21:18 INFO - Return code: 0 14:21:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:21:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:21:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:21:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:21:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0347', '--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 14:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0347 --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 14:21:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk7ZN1bqDn/Render', 14:21:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:18 INFO - 'HOME': '/Users/cltbld', 14:21:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:18 INFO - 'LOGNAME': 'cltbld', 14:21:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:21:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:18 INFO - 'MOZ_NO_REMOTE': '1', 14:21:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:21:18 INFO - 'NO_EM_RESTART': '1', 14:21:18 INFO - 'PAGER': '/bin/cat', 14:21:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:18 INFO - 'PWD': '/builds/slave/test', 14:21:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:21:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:18 INFO - 'SHELL': '/bin/bash', 14:21:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pR7uoVFxJA/Listeners', 14:21:18 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 14:21:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:18 INFO - 'USER': 'cltbld', 14:21:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:18 INFO - 'XPC_FLAGS': '0x0', 14:21:18 INFO - 'XPC_SERVICE_NAME': '0', 14:21:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0347', '--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 14:21:18 INFO - mozversion application_buildid: 20161204125338 14:21:18 INFO - mozversion application_changeset: 166e3210dcc64181f5541b6b9382faafcf5859a2 14:21:18 INFO - mozversion application_display_name: Nightly 14:21:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:21:18 INFO - mozversion application_name: Firefox 14:21:18 INFO - mozversion application_remotingname: firefox 14:21:18 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 14:21:18 INFO - mozversion application_vendor: Mozilla 14:21:18 INFO - mozversion application_version: 53.0a1 14:21:18 INFO - mozversion platform_buildid: 20161204125338 14:21:18 INFO - mozversion platform_changeset: 166e3210dcc64181f5541b6b9382faafcf5859a2 14:21:18 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 14:21:18 INFO - mozversion platform_version: 53.0a1 14:21:18 INFO - using testdate: 1480890078 14:21:18 INFO - actual date: 1480890078 14:21:18 INFO - starting webserver on 'localhost:52233' 14:21:18 INFO - SUITE-START | Running 2 tests 14:21:18 INFO - TEST-START | dromaeo_css 14:21:18 INFO - operating with platform_type : mac_ 14:21:18 INFO - Initialising browser for dromaeo_css test... 14:21:18 INFO - TEST-INFO | started process 2558 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/tmpzdGJpC/profile http://localhost:52233/getInfo.html) 14:21:21 INFO - PROCESS | 2558 | __metrics Screen width/height:1600/1200 14:21:21 INFO - PROCESS | 2558 | colorDepth:24 14:21:21 INFO - PROCESS | 2558 | Browser inner width/height: 1024/689 14:21:21 INFO - PROCESS | 2558 | __metrics 14:21:21 INFO - PROCESS | 2558 | 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" 14:21:21 INFO - PROCESS | 2558 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:21:22 INFO - TEST-INFO | 2558: exit 0 14:21:22 INFO - Browser initialized. 14:21:22 INFO - Running cycle 1/1 for dromaeo_css test... 14:21:22 INFO - TEST-INFO | started process 2560 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/tmpzdGJpC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:21:34 INFO - PROCESS | 2560 | RSS: Main: 244039680 14:21:34 INFO - PROCESS | 2560 | 14:22:25 INFO - PROCESS | 2560 | 1480890145657 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:24:39 INFO - PROCESS | 2560 | Cycle 1(1): loaded http://localhost:52233/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52233/tests/dromaeo/cssquery-ext.html) 14:24:41 INFO - PROCESS | 2560 | RSS: Main: 406364160 14:24:41 INFO - PROCESS | 2560 | 14:27:44 INFO - PROCESS | 2560 | Cycle 1(1): loaded http://localhost:52233/tests/dromaeo/cssquery-ext.html (next: http://localhost:52233/tests/dromaeo/cssquery-jquery.html) 14:27:45 INFO - PROCESS | 2560 | RSS: Main: 372416512 14:27:45 INFO - PROCESS | 2560 | 14:30:47 INFO - PROCESS | 2560 | Cycle 1(1): loaded http://localhost:52233/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52233/tests/dromaeo/cssquery-mootools.html) 14:30:48 INFO - PROCESS | 2560 | RSS: Main: 351133696 14:30:48 INFO - PROCESS | 2560 | 14:33:50 INFO - PROCESS | 2560 | Cycle 1(1): loaded http://localhost:52233/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52233/tests/dromaeo/cssquery-prototype.html) 14:33:51 INFO - PROCESS | 2560 | RSS: Main: 338739200 14:33:51 INFO - PROCESS | 2560 | 14:36:54 INFO - PROCESS | 2560 | Cycle 1(1): loaded http://localhost:52233/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52233/tests/dromaeo/cssquery-yui.html) 14:36:55 INFO - PROCESS | 2560 | RSS: Main: 329248768 14:36:55 INFO - PROCESS | 2560 | 14:39:58 INFO - PROCESS | 2560 | Cycle 1(1): loaded http://localhost:52233/tests/dromaeo/cssquery-yui.html (next: http://localhost:52233/tests/dromaeo/cssquery-dojo.html) 14:39:58 INFO - PROCESS | 2560 | RSS: Main: 401375232 14:39:58 INFO - PROCESS | 2560 | 14:39:58 INFO - PROCESS | 2560 | __start_tp_report 14:39:58 INFO - PROCESS | 2560 | _x_x_mozilla_page_load 14:39:58 INFO - PROCESS | 2560 | _x_x_mozilla_page_load_details 14:39:58 INFO - PROCESS | 2560 | |i|pagename|runs| 14:39:58 INFO - PROCESS | 2560 | |0;dojo.html;3304.768666193366;3308.387948229577;3320.2695407010456;3326.6340702522702;3366.6296707362185;5567.860803479915;5653.406392328803;5666.801661941833;5673.035583950728;5732.770689172438;5658.236138121352;5662.122371032487;5691.630044047134;5695.829125126243;5817.185594016841;5143.665661731994;5181.1451110566895;5225.477452254763;5226.8693282667855;5236.947630523703;5108.540231379176;5237.947620523803;5240.60695447841;5241.39723931747;5263.894722105556;5251;5268.1834315681135;5275.894482110355;5281.017394419447;5302.867428314304;5126.179811230222;5165.586753059746;5180.6373553851245;5214.713190774506;5232.424433312332;4293.355996600504;4438.201123797715;5096.802251470901;5102.928385039147;5186.974065129688;5479.123340265538;5601.29983752031;5680.204771332017;5680.744366503476;5701.743421546041;6105.053716673922;6195.132681424604;6201.007838745779;6213.378662133796;6231.096491008779;6173.259208894961;6191.0713392990965;6204.317525072239;6227.470664993481;6235.282942461629;5806.419358064244;5813.593048486566;5821.010428227211;5840.182374467578;5848.736806843703;6112.724927378279;6226.377362263737;6239.594426362272;6264.060390941395;6266.154069200599;5927.911081333784;5947.1079338099635;5983.521318294526;6101.725422355916;6141.477974372139;6140.565599444434;6188.628682279078;6191.288001879841;6241.34465881085;6254.15568898202;6174.5060395168275;6176.382361763787;6183.84540386485;6197.597156184834;6202.658853762996;6075.878482430327;6151.84620384494;6155.538334624921;6218.253809542884;6232.532560058014;4832.323474713543;4835;4889.3888263967;4890.266460031024;4896.853094407174;4382.474103107647;4411;4459.643228541709;4462.888427789331;4470.128324976663;5681.034224181899;5765.394633563499;5766.654000759968;5775.306963164448;5813.534917206698;6137.171481849893;6144.064619644798;6166.229221347332;6224.470919971853;6268.028455589391;5652;5670.121131224667;5695.857603559944;5712.8286151414695;5762.7694892203845;5347.117725575236;5348.277982472394;5350.785968561214;5351.384590772033;5353.197020446886;6214.844628884314;6277.78027769035;6285.74857005733;6289.685515724195;6303.747850085945;6132.202813634199;6140.140380346845;6147.924113280247;6158.107074474086;6193.473554747897;6219.067139928866;6250;6273.404026617464;6283.59156654816;6297.937020629735;6185.567010309415;6190;6191.4118158774845;6195.132681424514;6205.379462053758;6117.96941015292;6155.692215389123;6269.529785266214;6276.152719382825;6292.622442653273;5355.768173320081;5663.631863928831;5969.761209551743;6042.667653279112;6049.122877182872;5986.880262394815;6030.5778595497895;6032.00471922128;6063.757449701962;6090.451859332681;5807.448292412214;5865;5927.911081333697;5934.821955341346;5946;5927.170196172453;5976.013957696931;5992.790252341147;6029.8191054268445;6067.362926892612;5756.280464941882;5894.734736936934;5937.109433584997;5942.702864856827;5948.643081415129 14:39:58 INFO - PROCESS | 2560 | |1;ext.html;456.8675084225575;459.59785187960534;469.60318530841425;534.8609361565995;536.549298589185;30003.099907002797;37618.87143385699;38476.61523384765;38608.99999999996;40281.19437611246;32431.837840810822;38841.61158388415;39048.82853514399;39267;39335.606643933555;9076.137766912148;9260.861087083698;9264.027277135905;9281;9282.164605185531;8360.411521810836;8562.743117706448;10861.076808471249;11103.888961110406;11127.833082503728;10987.725306867313;11071.72320691985;11079.224454288204;11082.390468524229;11155.330680159217;8345.874811877766;9396.48319342436;10848.349099054043;10960.725981850477;11011.779764404668;8267.421280510367;10356.79286414275;10539.683809485728;10550.630727924487;10557.788844223072;37823.432648510294;38069.85790426264;38103;38108.61891381079;38195.85412437631;3208.2620997170548;3259.429599820022;3317.784344017631;3634.4548317752283;3847.942280865789;23465;28808.567871481944;29180.562291565642;29272.975445859505;29425;3069.155982104917;3119.485284927984;3127.3276245607303;3163.715265626082;3255.186203449138;350266.248668755;353747;357433;362434;363775.18112409534;45008.77495612501;53285;53857;53900.73049634727;54151.729241354325;54086;55584.44415555873;55910.72044639832;55941.7202913991;56094.43905560892;14563;15085.019473734172;15092.622684432758;15113.924430377778;15301;10921.290116142425;11193.776124477465;11796.646100616996;11888.643340699793;11912.344821034752;10722.303050301705;12956.740865182643;13025.544105956245;13074.607761767162;14208.786868196985;6830.311631718816;6893.17281926162;6942.819720647502;6993.335633114846;7033.8944915826305;811.6347643560422;956.1108169402384;959.2613687460756;1058.7300238439302;1066.9413182274893;27524.724752752216;28403;28797.28006799847;28951.7104828949;28976.247256510596;978.9804203915882;983.9963237497712;1008.8436292374694;1009.9646512372032;1077.7767234189096;13418;14772.926135369255;14833.480828170963;14880.032797868103;14891.015391012847;518664.2200366997;567606;573753;581490;587591;53129;53313.466865331626;53316;53358.733206333716;53475;1176.2178151529308;1326.4694122351136;1346.9259190744408;1359.3067535557134;1368.6167872995577;27327.590086148328;28509.572356414257;28544.000959966303;28728.569071464364;29290.7070929288;44193;44232.33651495166;44276.77861610671;44406.3339049921;44542.77728611336;524498;524558.3772081116;524978;535669;540794;35960.28079438449;36296;36544.81727591345;36950.63049369472;37186.25627487381;42223;42755.786221068694;43025.354619681355;43347.133057339306;44107.55892441035;32650.83674581612;35641.82179089088;35722.464163038094;36718;36730.63269367272;28932.98734544281;33889;34610.65389346175;36593.81703091467;36958.63041369552;29584.704152958195;35688;36228.4565731509;36513.63486365102;36657.08357291089;30876.22809429782;31529.369412611162;32315.19212019718;32315.838420807744;32434.513482298258;21063.6815920398;24381.878090609433;24476.388090297885;24523.615574134947;24819.751802481744 14:39:58 INFO - PROCESS | 2560 | |2;jquery.html;346.2054584728049;363.2535140286711;368.68477451778745;374.9325121478134;393.87002289244555;12145.696357591065;13757.243351615669;15088.47190348338;19865.900670496663;20424.59150816983;19029;19827.801721982774;20139.29512467064;20322.491937701565;20594;5460.836174914749;5812.041013232812;5820.767169313222;5824.796132135376;5827.592068555203;5319.468053194669;5354.785808567653;5768.855778605526;5790.623609465371;5800.158976948361;5742.569307301969;5746.281714785652;5746.396628354026;5756.366799652035;5774.422557744213;5454.754536045868;5662.546996240311;5729.255196824386;5730;5732;4773.71357718538;5031.245313203012;5036.093503169464;5042.067217564762;5052.873678158038;24279.150229742052;24332.02671893122;24626.87686561556;25034.374140646447;25631;2225.6995305633695;2228.3760547046854;2325.8837058147024;2332.5684748321446;2397.29279862441;12763.36183190846;14615.342309596093;15105;15373.692526149527;16020.4392846251;1781.2251670523235;1819.199552197029;1831.1210618903;1884.8303652671325;1903.6097599991967;90048;108890;110358;112128;114675;10309.278350515391;10533.736656583493;10601.681949541526;10869.728256793644;11109.83335249972;13593.932030339984;13643.317834108255;13645.658858528417;13673.384697688627;13709.17744935307;8012.238837310446;8310.002799664078;8328.791780205422;8464.44981076228;8496.362772792065;8314.127016663164;8344.290735287446;8367.581620918929;8528.829423411496;8550.529720865412;6404.327545607737;6506.60960342381;6559.44244739193;6560.967195163994;6561.2782593914635;1768.089433941521;1801.4865763257408;1818.1182825221906;1842.9078546072642;1855.471190710641;615.1510914937357;730.9744158954411;932.7901222225081;957.6696039866235;970.815545046439;20665.690014649794;21600.351989440343;21663.67504487434;21699.566008680053;21974.670379944313;902.7878448564582;954.4798085043668;981.1415011864618;985.9753506162403;1030.5362586835954;10939.671809845717;11681.941590291994;11816.99555537789;11824.645260642195;11874.76250475003;525073;539428;539586;543675.5632443625;546488;82054;113235;113886;117112;119781;976.2629214942673;981.8379967305458;1032.0917592518535;1039.5374058543875;1041.2711102228318;19135.043247837275;19503.927283999517;19532.804671953098;19561.608767824848;19711.014449277765;48672.75663621659;49496;49654.00691986212;49733;49840;67223;68292.31707682859;69172.65413672899;69307.65346173236;69751.30248697448;7686.884696729442;7866.7639970800965;8010.239027292398;8084;8087.474314169795;9992.903619154138;12535.93732031334;13184.208947463183;13232.00759942989;13307;11306.321620702784;11355.479342797802;11618;11638.301701897914;11687.240329378563;11120.165987550805;11161.386123763272;11311.773764524827;11354.221774153115;11568.710782230175;11471.311721296748;11598.884011160118;11785;11790.764184716429;11851.585194518151;7848.568328741974;7988.800279993046;8039.598020099089;8043.436959412785;8179.219822134546;11136.710062720467;11482.138839586898;11582.189246752647;11625.069994400259;11702.765944680888 14:39:58 INFO - PROCESS | 2560 | |3;mootools.html;1271.3516106785537;1418.3475601223436;1523.9771403428952;1574.9133797641125;1739.791225052994;7911.248431399015;8280.710175143857;8291.709790157345;8301.169883011697;8429.283510901565;6158.846028849281;7518.135414427343;7538.698452061924;7602.201768814278;7602.581857997808;2065.7934206579334;2105.347342323877;2207.3708992937018;2294.8393612447135;2295.8622482651012;2320.3387034695115;2323.0939933425975;2324.2794733632627;2324.337563794319;2331.393837602219;2250.651149071888;2267.319804058784;2294.242899843048;2296.7588403217674;2300.482391461916;2255.154317131076;2256.909723611054;2263.6265016272296;2278.453171238907;2279.5213005268915;2240.4958884251078;2272.7272727272666;2289.7710228977135;2298.218605674079;2300;8120.472169308976;8203.71287004958;8204.056533498664;8204.220599043081;8236.50580965144;4925.876853078702;5103.157978933508;5103.54068133866;5111.642185047048;5121.743912804345;3359.3785149747373;3380.5632606142535;3517.4899639552123;3520.06718219672;3524.8942531724088;1045.937243765369;1049.0610903241632;1064.2018486135398;1080.9621663241828;1084.414416215243;10523.579056837718;10571.154307655446;10613.310134841287;10627.41549214793;10644.308119972176;4117.011917139865;4308.784560771949;4333.349997500401;4379.1460665170625;4407.867763967086;8425.07324194338;8441.915580844236;8456.196661317164;8460.619272132768;8482.279006284534;4883.145449546315;4981;4981.850544483671;4993.9512702332195;4994;4518.186726389215;4669.929951050737;4703.2004559225015;4703.576678098988;4705.576498115118;3352.0949343677557;3452.913677158041;3453.499242609858;3526.7707599006494;3570.321638888603;1108.451316598289;1118.5413980268052;1126.0766171739094;1129.1362107987395;1130.214500921868;705.9541129826545;876.8640860666607;882.8366752150744;887.933404994628;907.5734404829719;5245.318108645852;5484.698341591251;5489.890202195934;5542.11326187808;5653.604247702621;853.53482352117;862.8921384826897;871.9258862996589;876.8640860666607;937.2548823685187;3287.3260981498734;3437.7452229935893;3661.3409586274724;3692.2430901665093;3728.738988270795;9269.119433653792;9669.226461883032;9740.512974351395;9852.408855468695;9898.65354712596;9707.514624268759;9881.555330010024;9916.206703463706;9918;9920.603175872884;7224.819379515449;7574.469787114849;7635.770926872203;7641.885371719429;7740.651670674946;5368.7047212403695;5480.3971563128825;5596.496315331477;5642.492175704207;5786.307934210266;9107.316951228551;9120.680776172801;9155.26757859383;9208.079192081006;9335.159835614828;9058.592363343534;9271.397359171633;9276.953615231881;9333.33999810051;9393.342466027312;7018.543794653331;7066.364027237573;7120.964395177991;7186.7125314986815;7196.280371962762;7557.35762460197;7632.313091821763;7644.044494438195;7761.650725717469;7771.9896413465885;6880.139982502187;6958.234594194736;6987.790366289019;6999.965000174967;7001.299870012958;6450.967745161244;6623.635700036544;6685.09751183584;6693.765718199839;6762.289959554176;6433.099366088658;6531.771388001397;6535.150430444012;6555.049517819794;6556.704948277244;4656.720596764205;4776.832810851603;4794.137055330074;4809.855704328876;4884.242942343943;4694.6009589185305;4789.928151077806;4830.130576496264;4842.055799119138;4961.454240033666 14:39:58 INFO - PROCESS | 2560 | |4;prototype.html;298.3406671256523;303.48407706898263;307.412841472787;314.4952351475881;315.8941754512238;4857.247126695368;5146.614003949705;5153.561947234485;5227.3465816772905;5306.416294207644;4201.70588058836;4747.90504189916;5019.6446959320965;5032.6477146599755;5175.792968281274;3972.880813575597;4038.2731108400476;4039.8284497495692;4054.1620865394193;4062.2281766464353;3330.533725278463;3802.5817160112365;3886.358750806128;4002.259581977329;4022.376531637586;3678.8528458861615;3771.208046310278;3828.7894165820867;4012.2978478766245;4020.1959608078355;3995.1011022519992;3995.5216569869044;3996.7402118862183;4010.5187377514594;4038.8788336349958;2798.3004248937764;3240.173755692307;3493.877714279988;3507.7895326280504;3528.9942366425703;4706.270528068155;4856.708597484127;5051.827714082943;5059.924101138449;5085.872853178663;4529.456465224194;4538.251188553918;4545.795439205243;4554.180247555439;4563.486115690933;5455.38973132478;5457.645253058578;5471.0456353569025;5486.436365635775;5491.9290738306045;3574.1779390740276;3836.884893453173;3850.4994350734223;3860.6911447084167;3873.845046198149;5349.22436246742;5421.430749771257;5632.971835140798;5710.857228569277;5717.855804073472;3600.1019179560703;3888.5392001119026;3898.7270891037924;3907.9218415631526;3924.274009308287;3487.843047062888;3968.4840970673627;3982.26328129297;3989.3417586097967;3998.580149084304;4273.252180868336;4524.660650451229;4559.449787072412;4566.109608626352;4575.794089265991;4533.9672963011035;4812.494688057704;5436.864078397993;5445.727713614304;5453.318335208099;1043.5512729526376;1185.6383802940186;1186.128195776104;1204.9578264760692;1238.9814152787715;832.2426591801432;841.6338892581747;850.1583432401877;874.6894852327332;887.9911200887908;4412.536683648235;4455.844045458458;4522.032915681689;4775.641826863;4776.731052749916;4418.977905110454;4538.319252112209;4825.9758701206265;5213.895722085537;5224.242484839677;4370.836435964155;4432.188119107584;4447.932496200889;4505.797239124247;4795.95204047962;2424.951500970006;2464.4473981391607;2634.315078079713;2774.9861250693616;2776.861156942185;4602.9769851151195;5001.824936127291;5083.491650834887;5403.891922161613;5419.349678038582;4720.63968015992;5023.748812559357;5286.841394758163;5302.681839089667;5768.3654797972185;5791.276090488689;5800.332961709373;5844.444777746107;5849.444302791228;5881.764729410861;5027.572656324107;5651.321841379061;5674.460926212003;5701.714914254354;5721.599488035964;4519.61583265413;5359.169328754049;5563.58273129525;5569.916451253315;5638.9436105638415;4955.40535135786;5081.745912704424;5823.126531020212;5838.8396293371725;5877.647341159544;3507.2810073935293;3795.1972812913646;3800.4109363047664;3823.464714939855;3836.271108489378;4128.60778226068;4470.754108524063;4814;5157.690538567698;5677.630953987978;4632.050429661844;5192.948070519397;5302.469753024667;5549.612596850788;5552.361478430033;4561.977190114028;4819;5474.562035037108;5498.917516237339;5520.696361700145;4753.310769938271;4984.900301994012;5380.838574842761;5458.6724796512335;5485.927880386996;4380.62764665007;4747.074320507468;5273.6572122811895;5483.945160548344;5630.831075067755;5371.973140134274;5376.462353764592;5384.138537834085;5390.218418329398;5393.083175860034 14:39:58 INFO - PROCESS | 2560 | |5;yui.html;676.9593824370537;707.3351050012988;713.9750108746194;772.7334069745935;774.3534148985597;14665.853341466582;15022.624434389145;15433.614159646015;15737.449189278377;15739.921300393482;13728.382222799974;13969.231692256923;14118.858811411883;14156.646083847883;14168.433262669507;816.3142959913671;831.3723139030054;834.3200291762195;836.2849763452252;836.477201748907;647.6696884588846;667.326000739252;793.5119901260712;821.4496287487398;824.9463784853965;869.3088994249587;870.5081628879694;873.724776695339;875.120503893586;875.4090988582712;870.4907629037021;871.5772850167664;872.0625327772669;873.0919843362894;873.2708188662474;503.1120073071033;520.828126718182;642.3865208725656;642.6818724731288;644.2333622988629;12261.816072758917;12500.24998500093;12512.186707864052;12517.43671534774;13911.79132313016;12930.676733081655;13644.249566273851;13770.311484425738;14171.078879872775;14335.06822056563;11622.825657615143;11699.76600467986;11727.296362218294;11773.234739741889;11800.46897889597;3595.352836489431;3671.889843304705;3683.963160368389;3692.2246328270826;3796.3925771876366;115482.33327196508;118554.40722796331;119897.80102198954;119952;122618;10404.323718958243;11019.559217631366;11062.723431914266;11140.49867755953;11298.943505282585;17332.91333543324;20262.797372026387;20455.79544204539;21085.051172697265;21158.682619760715;7157.785266442015;7443.8883416748795;7512.436567257478;7536.924630753732;7693.884591731128;3890.8832735017995;4176.394422808676;4193.370994350811;4197.223513649923;4200.726952748061;3224.725898298671;3442.586889573217;3448.9827550862087;3455.464403017486;3459.5329630500064;602.7408214467821;612.3111499562991;671.7514519627671;675.4731309578536;688.2291833146908;569.2485918587507;602.5631417222567;615.3876892491999;630.5019034962328;639.7536948274948;9255.722328330161;9273.768155796159;9304.069593040642;9328.440293582407;9414.858777118348;510.7548376779093;632.3117276870767;641.9358064193543;648.7859006527834;654.309703263062;4198.223328684203;4603.356406553446;4650.86047418578;4666.463356714022;4699.342092107107;109266.45366773116;117634.41182794032;118312;119250;119359;80668.38663226702;81039.59480202562;85778;90407.54796225976;97952.34810082303;77048.22951770635;80457.19542804614;81391.18608813954;83159.16840831636;83570.74643880347;9441.433513989183;9737.22102231834;9757.12185903272;9761.9023809761;9930;37311.6940907067;51467.48532514627;54711.17933231084;54715.35853924388;55352;69869.95195072179;71688.28311716816;73993.52012959818;75505;76243.61878190574;12013.879861201276;12164.939175304067;12291.139620226499;12497.625071247878;12853.16454430459;14307.427702891768;14455.349509272319;14817.27739598598;14828.332725027183;15269.541913742605;13469.663258418617;13834.723305534035;13957.930210348883;13989.510367137102;14283.285835707966;13420.93289533585;13566.525171618947;13965.511207107702;14043.859561404664;14248.216348100954;12986.675333116747;13230.669233269246;13379.53171638988;13518.932405338304;13701.45194192261;10888.67333979982;11164.776704466027;11537.480813363587;11610.70973225676;11808.11439142085;10756.623518176826;11175.10599152082;11520.654380368602;11591.5942942;11607.477663504993 14:39:58 INFO - PROCESS | 2560 | __end_tp_report 14:39:58 INFO - PROCESS | 2560 | __start_cc_report 14:39:58 INFO - PROCESS | 2560 | _x_x_mozilla_cycle_collect,1901 14:39:58 INFO - PROCESS | 2560 | __end_cc_report 14:39:58 INFO - PROCESS | 2560 | __startTimestamp1480891198931__endTimestamp 14:39:58 INFO - PROCESS | 2560 | 14:39:58 INFO - PROCESS | 2560 | ------- Summary: start ------- 14:39:58 INFO - PROCESS | 2560 | Number of tests: 6 14:39:58 INFO - PROCESS | 2560 | 14:39:58 INFO - PROCESS | 2560 | [#0] dojo.html Cycles:165 Average:5700.10 Median:5927.91 stddev:642.29 (10.8%) stddev-sans-first:616.15 14:39:58 INFO - PROCESS | 2560 | Values: 3304.8 3308.4 3320.3 3326.6 3366.6 5567.9 5653.4 5666.8 5673.0 5732.8 5658.2 5662.1 5691.6 5695.8 5817.2 5143.7 5181.1 5225.5 5226.9 5236.9 5108.5 5237.9 5240.6 5241.4 5263.9 5251.0 5268.2 5275.9 5281.0 5302.9 5126.2 5165.6 5180.6 5214.7 5232.4 4293.4 4438.2 5096.8 5102.9 5187.0 5479.1 5601.3 5680.2 5680.7 5701.7 6105.1 6195.1 6201.0 6213.4 6231.1 6173.3 6191.1 6204.3 6227.5 6235.3 5806.4 5813.6 5821.0 5840.2 5848.7 6112.7 6226.4 6239.6 6264.1 6266.2 5927.9 5947.1 5983.5 6101.7 6141.5 6140.6 6188.6 6191.3 6241.3 6254.2 6174.5 6176.4 6183.8 6197.6 6202.7 6075.9 6151.8 6155.5 6218.3 6232.5 4832.3 4835.0 4889.4 4890.3 4896.9 4382.5 4411.0 4459.6 4462.9 4470.1 5681.0 5765.4 5766.7 5775.3 5813.5 6137.2 6144.1 6166.2 6224.5 6268.0 5652.0 5670.1 5695.9 5712.8 5762.8 5347.1 5348.3 5350.8 5351.4 5353.2 6214.8 6277.8 6285.7 6289.7 6303.7 6132.2 6140.1 6147.9 6158.1 6193.5 6219.1 6250.0 6273.4 6283.6 6297.9 6185.6 6190.0 6191.4 6195.1 6205.4 6118.0 6155.7 6269.5 6276.2 6292.6 5355.8 5663.6 5969.8 6042.7 6049.1 5986.9 6030.6 6032.0 6063.8 6090.5 5807.4 5865.0 5927.9 5934.8 5946.0 5927.2 5976.0 5992.8 6029.8 6067.4 5756.3 5894.7 5937.1 5942.7 5948.6 14:39:58 INFO - PROCESS | 2560 | 14:39:58 INFO - PROCESS | 2560 | [#1] ext.html Cycles:180 Average:61620.46 Median:196696.64 stddev:131603.64 (66.9%) stddev-sans-first:131892.70 14:39:58 INFO - PROCESS | 2560 | Values: 456.9 459.6 469.6 534.9 536.5 30003.1 37618.9 38476.6 38609.0 40281.2 32431.8 38841.6 39048.8 39267.0 39335.6 9076.1 9260.9 9264.0 9281.0 9282.2 8360.4 8562.7 10861.1 11103.9 11127.8 10987.7 11071.7 11079.2 11082.4 11155.3 8345.9 9396.5 10848.3 10960.7 11011.8 8267.4 10356.8 10539.7 10550.6 10557.8 37823.4 38069.9 38103.0 38108.6 38195.9 3208.3 3259.4 3317.8 3634.5 3847.9 23465.0 28808.6 29180.6 29273.0 29425.0 3069.2 3119.5 3127.3 3163.7 3255.2 350266.2 353747.0 357433.0 362434.0 363775.2 45008.8 53285.0 53857.0 53900.7 54151.7 54086.0 55584.4 55910.7 55941.7 56094.4 14563.0 15085.0 15092.6 15113.9 15301.0 10921.3 11193.8 11796.6 11888.6 11912.3 10722.3 12956.7 13025.5 13074.6 14208.8 6830.3 6893.2 6942.8 6993.3 7033.9 811.6 956.1 959.3 1058.7 1066.9 27524.7 28403.0 28797.3 28951.7 28976.2 979.0 984.0 1008.8 1010.0 1077.8 13418.0 14772.9 14833.5 14880.0 14891.0 518664.2 567606.0 573753.0 581490.0 587591.0 53129.0 53313.5 53316.0 53358.7 53475.0 1176.2 1326.5 1346.9 1359.3 1368.6 27327.6 28509.6 28544.0 28728.6 29290.7 44193.0 44232.3 44276.8 44406.3 44542.8 524498.0 524558.4 524978.0 535669.0 540794.0 35960.3 36296.0 36544.8 36950.6 37186.3 42223.0 42755.8 43025.4 43347.1 44107.6 32650.8 35641.8 35722.5 36718.0 36730.6 28933.0 33889.0 34610.7 36593.8 36958.6 29584.7 35688.0 36228.5 36513.6 36657.1 30876.2 31529.4 32315.2 32315.8 32434.5 21063.7 24381.9 24476.4 24523.6 24819.8 14:39:58 INFO - PROCESS | 2560 | 14:39:58 INFO - PROCESS | 2560 | [#2] jquery.html Cycles:180 Average:32247.46 Median:13338.22 stddev:89660.80 (672.2%) stddev-sans-first:89880.32 14:39:58 INFO - PROCESS | 2560 | Values: 346.2 363.3 368.7 374.9 393.9 12145.7 13757.2 15088.5 19865.9 20424.6 19029.0 19827.8 20139.3 20322.5 20594.0 5460.8 5812.0 5820.8 5824.8 5827.6 5319.5 5354.8 5768.9 5790.6 5800.2 5742.6 5746.3 5746.4 5756.4 5774.4 5454.8 5662.5 5729.3 5730.0 5732.0 4773.7 5031.2 5036.1 5042.1 5052.9 24279.2 24332.0 24626.9 25034.4 25631.0 2225.7 2228.4 2325.9 2332.6 2397.3 12763.4 14615.3 15105.0 15373.7 16020.4 1781.2 1819.2 1831.1 1884.8 1903.6 90048.0 108890.0 110358.0 112128.0 114675.0 10309.3 10533.7 10601.7 10869.7 11109.8 13593.9 13643.3 13645.7 13673.4 13709.2 8012.2 8310.0 8328.8 8464.4 8496.4 8314.1 8344.3 8367.6 8528.8 8550.5 6404.3 6506.6 6559.4 6561.0 6561.3 1768.1 1801.5 1818.1 1842.9 1855.5 615.2 731.0 932.8 957.7 970.8 20665.7 21600.4 21663.7 21699.6 21974.7 902.8 954.5 981.1 986.0 1030.5 10939.7 11681.9 11817.0 11824.6 11874.8 525073.0 539428.0 539586.0 543675.6 546488.0 82054.0 113235.0 113886.0 117112.0 119781.0 976.3 981.8 1032.1 1039.5 1041.3 19135.0 19503.9 19532.8 19561.6 19711.0 48672.8 49496.0 49654.0 49733.0 49840.0 67223.0 68292.3 69172.7 69307.7 69751.3 7686.9 7866.8 8010.2 8084.0 8087.5 9992.9 12535.9 13184.2 13232.0 13307.0 11306.3 11355.5 11618.0 11638.3 11687.2 11120.2 11161.4 11311.8 11354.2 11568.7 11471.3 11598.9 11785.0 11790.8 11851.6 7848.6 7988.8 8039.6 8043.4 8179.2 11136.7 11482.1 11582.2 11625.1 11702.8 14:39:58 INFO - PROCESS | 2560 | 14:39:58 INFO - PROCESS | 2560 | [#3] mootools.html Cycles:180 Average:5283.44 Median:5307.01 stddev:2883.21 (54.3%) stddev-sans-first:2875.53 14:39:58 INFO - PROCESS | 2560 | Values: 1271.4 1418.3 1524.0 1574.9 1739.8 7911.2 8280.7 8291.7 8301.2 8429.3 6158.8 7518.1 7538.7 7602.2 7602.6 2065.8 2105.3 2207.4 2294.8 2295.9 2320.3 2323.1 2324.3 2324.3 2331.4 2250.7 2267.3 2294.2 2296.8 2300.5 2255.2 2256.9 2263.6 2278.5 2279.5 2240.5 2272.7 2289.8 2298.2 2300.0 8120.5 8203.7 8204.1 8204.2 8236.5 4925.9 5103.2 5103.5 5111.6 5121.7 3359.4 3380.6 3517.5 3520.1 3524.9 1045.9 1049.1 1064.2 1081.0 1084.4 10523.6 10571.2 10613.3 10627.4 10644.3 4117.0 4308.8 4333.3 4379.1 4407.9 8425.1 8441.9 8456.2 8460.6 8482.3 4883.1 4981.0 4981.9 4994.0 4994.0 4518.2 4669.9 4703.2 4703.6 4705.6 3352.1 3452.9 3453.5 3526.8 3570.3 1108.5 1118.5 1126.1 1129.1 1130.2 706.0 876.9 882.8 887.9 907.6 5245.3 5484.7 5489.9 5542.1 5653.6 853.5 862.9 871.9 876.9 937.3 3287.3 3437.7 3661.3 3692.2 3728.7 9269.1 9669.2 9740.5 9852.4 9898.7 9707.5 9881.6 9916.2 9918.0 9920.6 7224.8 7574.5 7635.8 7641.9 7740.7 5368.7 5480.4 5596.5 5642.5 5786.3 9107.3 9120.7 9155.3 9208.1 9335.2 9058.6 9271.4 9277.0 9333.3 9393.3 7018.5 7066.4 7121.0 7186.7 7196.3 7557.4 7632.3 7644.0 7761.7 7772.0 6880.1 6958.2 6987.8 7000.0 7001.3 6451.0 6623.6 6685.1 6693.8 6762.3 6433.1 6531.8 6535.2 6555.0 6556.7 4656.7 4776.8 4794.1 4809.9 4884.2 4694.6 4789.9 4830.1 4842.1 4961.5 14:39:58 INFO - PROCESS | 2560 | 14:39:58 INFO - PROCESS | 2560 | [#4] prototype.html Cycles:180 Average:4357.69 Median:4747.49 stddev:1329.16 (28.0%) stddev-sans-first:1297.50 14:39:58 INFO - PROCESS | 2560 | Values: 298.3 303.5 307.4 314.5 315.9 4857.2 5146.6 5153.6 5227.3 5306.4 4201.7 4747.9 5019.6 5032.6 5175.8 3972.9 4038.3 4039.8 4054.2 4062.2 3330.5 3802.6 3886.4 4002.3 4022.4 3678.9 3771.2 3828.8 4012.3 4020.2 3995.1 3995.5 3996.7 4010.5 4038.9 2798.3 3240.2 3493.9 3507.8 3529.0 4706.3 4856.7 5051.8 5059.9 5085.9 4529.5 4538.3 4545.8 4554.2 4563.5 5455.4 5457.6 5471.0 5486.4 5491.9 3574.2 3836.9 3850.5 3860.7 3873.8 5349.2 5421.4 5633.0 5710.9 5717.9 3600.1 3888.5 3898.7 3907.9 3924.3 3487.8 3968.5 3982.3 3989.3 3998.6 4273.3 4524.7 4559.4 4566.1 4575.8 4534.0 4812.5 5436.9 5445.7 5453.3 1043.6 1185.6 1186.1 1205.0 1239.0 832.2 841.6 850.2 874.7 888.0 4412.5 4455.8 4522.0 4775.6 4776.7 4419.0 4538.3 4826.0 5213.9 5224.2 4370.8 4432.2 4447.9 4505.8 4796.0 2425.0 2464.4 2634.3 2775.0 2776.9 4603.0 5001.8 5083.5 5403.9 5419.3 4720.6 5023.7 5286.8 5302.7 5768.4 5791.3 5800.3 5844.4 5849.4 5881.8 5027.6 5651.3 5674.5 5701.7 5721.6 4519.6 5359.2 5563.6 5569.9 5638.9 4955.4 5081.7 5823.1 5838.8 5877.6 3507.3 3795.2 3800.4 3823.5 3836.3 4128.6 4470.8 4814.0 5157.7 5677.6 4632.1 5192.9 5302.5 5549.6 5552.4 4562.0 4819.0 5474.6 5498.9 5520.7 4753.3 4984.9 5380.8 5458.7 5485.9 4380.6 4747.1 5273.7 5483.9 5630.8 5372.0 5376.5 5384.1 5390.2 5393.1 14:39:58 INFO - PROCESS | 2560 | 14:39:58 INFO - PROCESS | 2560 | [#5] yui.html Cycles:180 Average:21303.78 Median:3843.64 stddev:32035.26 (833.5%) stddev-sans-first:32087.69 14:39:58 INFO - PROCESS | 2560 | Values: 677.0 707.3 714.0 772.7 774.4 14665.9 15022.6 15433.6 15737.4 15739.9 13728.4 13969.2 14118.9 14156.6 14168.4 816.3 831.4 834.3 836.3 836.5 647.7 667.3 793.5 821.4 824.9 869.3 870.5 873.7 875.1 875.4 870.5 871.6 872.1 873.1 873.3 503.1 520.8 642.4 642.7 644.2 12261.8 12500.2 12512.2 12517.4 13911.8 12930.7 13644.2 13770.3 14171.1 14335.1 11622.8 11699.8 11727.3 11773.2 11800.5 3595.4 3671.9 3684.0 3692.2 3796.4 115482.3 118554.4 119897.8 119952.0 122618.0 10404.3 11019.6 11062.7 11140.5 11298.9 17332.9 20262.8 20455.8 21085.1 21158.7 7157.8 7443.9 7512.4 7536.9 7693.9 3890.9 4176.4 4193.4 4197.2 4200.7 3224.7 3442.6 3449.0 3455.5 3459.5 602.7 612.3 671.8 675.5 688.2 569.2 602.6 615.4 630.5 639.8 9255.7 9273.8 9304.1 9328.4 9414.9 510.8 632.3 641.9 648.8 654.3 4198.2 4603.4 4650.9 4666.5 4699.3 109266.5 117634.4 118312.0 119250.0 119359.0 80668.4 81039.6 85778.0 90407.5 97952.3 77048.2 80457.2 81391.2 83159.2 83570.7 9441.4 9737.2 9757.1 9761.9 9930.0 37311.7 51467.5 54711.2 54715.4 55352.0 69870.0 71688.3 73993.5 75505.0 76243.6 12013.9 12164.9 12291.1 12497.6 12853.2 14307.4 14455.3 14817.3 14828.3 15269.5 13469.7 13834.7 13957.9 13989.5 14283.3 13420.9 13566.5 13965.5 14043.9 14248.2 12986.7 13230.7 13379.5 13518.9 13701.5 10888.7 11164.8 11537.5 11610.7 11808.1 10756.6 11175.1 11520.7 11591.6 11607.5 14:39:58 INFO - PROCESS | 2560 | -------- Summary: end -------- 14:39:58 INFO - PROCESS | 2560 | 14:39:59 INFO - TEST-INFO | 2560: exit 0 14:39:59 INFO - TEST-OK | dromaeo_css | took 1121201ms 14:39:59 INFO - TEST-START | kraken 14:39:59 INFO - operating with platform_type : mac_ 14:39:59 INFO - Initialising browser for kraken test... 14:39:59 INFO - TEST-INFO | started process 2564 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/tmpZUHcNf/profile http://localhost:52233/getInfo.html) 14:40:02 INFO - PROCESS | 2564 | __metrics Screen width/height:1600/1200 14:40:02 INFO - PROCESS | 2564 | colorDepth:24 14:40:02 INFO - PROCESS | 2564 | Browser inner width/height: 1024/689 14:40:02 INFO - PROCESS | 2564 | __metrics 14:40:02 INFO - PROCESS | 2564 | 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" 14:40:02 INFO - PROCESS | 2564 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:40:03 INFO - TEST-INFO | 2564: exit 0 14:40:03 INFO - Browser initialized. 14:40:03 INFO - Running cycle 1/1 for kraken test... 14:40:03 INFO - TEST-INFO | started process 2565 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/tmpZUHcNf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:40:15 INFO - PROCESS | 2565 | RSS: Main: 236580864 14:40:15 INFO - PROCESS | 2565 | 14:40:18 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:52233/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52233/tests/kraken/driver.html?testName=audio-beat-detection) 14:40:19 INFO - PROCESS | 2565 | RSS: Main: 293191680 14:40:19 INFO - PROCESS | 2565 | 14:40:21 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:52233/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52233/tests/kraken/driver.html?testName=audio-dft) 14:40:22 INFO - PROCESS | 2565 | RSS: Main: 295391232 14:40:22 INFO - PROCESS | 2565 | 14:40:25 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:52233/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52233/tests/kraken/driver.html?testName=audio-fft) 14:40:26 INFO - PROCESS | 2565 | RSS: Main: 387739648 14:40:26 INFO - PROCESS | 2565 | 14:40:28 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:52233/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52233/tests/kraken/driver.html?testName=audio-oscillator) 14:40:29 INFO - PROCESS | 2565 | RSS: Main: 290783232 14:40:29 INFO - PROCESS | 2565 | 14:40:31 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:52233/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52233/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:40:31 INFO - PROCESS | 2565 | RSS: Main: 292978688 14:40:31 INFO - PROCESS | 2565 | 14:40:34 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:52233/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52233/tests/kraken/driver.html?testName=imaging-darkroom) 14:40:35 INFO - PROCESS | 2565 | RSS: Main: 335187968 14:40:35 INFO - PROCESS | 2565 | 14:40:38 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:52233/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52233/tests/kraken/driver.html?testName=imaging-desaturate) 14:40:38 INFO - PROCESS | 2565 | RSS: Main: 335429632 14:40:38 INFO - PROCESS | 2565 | 14:40:41 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:52233/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52233/tests/kraken/driver.html?testName=json-parse-financial) 14:40:42 INFO - PROCESS | 2565 | RSS: Main: 335126528 14:40:42 INFO - PROCESS | 2565 | 14:40:43 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:52233/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52233/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:40:44 INFO - PROCESS | 2565 | RSS: Main: 308875264 14:40:44 INFO - PROCESS | 2565 | 14:40:46 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:52233/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52233/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:40:47 INFO - PROCESS | 2565 | RSS: Main: 312664064 14:40:47 INFO - PROCESS | 2565 | 14:40:49 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:52233/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52233/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:40:49 INFO - PROCESS | 2565 | RSS: Main: 314597376 14:40:49 INFO - PROCESS | 2565 | 14:40:52 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:52233/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:40:53 INFO - PROCESS | 2565 | RSS: Main: 333230080 14:40:53 INFO - PROCESS | 2565 | 14:40:56 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:52233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:40:57 INFO - PROCESS | 2565 | RSS: Main: 326422528 14:40:57 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:52233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52233/tests/kraken/driver.html?testName=ai-astar) 14:40:59 INFO - PROCESS | 2565 | RSS: Main: 370647040 14:40:59 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | __start_tp_report 14:40:59 INFO - PROCESS | 2565 | _x_x_mozilla_page_load 14:40:59 INFO - PROCESS | 2565 | _x_x_mozilla_page_load_details 14:40:59 INFO - PROCESS | 2565 | |i|pagename|runs| 14:40:59 INFO - PROCESS | 2565 | |0;ai-astar;104;115;115;113;116;116;115;115;116;114 14:40:59 INFO - PROCESS | 2565 | |1;audio-beat-detection;151;116;115;153;116;114;115;112;135;115 14:40:59 INFO - PROCESS | 2565 | |2;audio-dft;185;184;184;186;183;183;181;183;183;184 14:40:59 INFO - PROCESS | 2565 | |3;audio-fft;80;59;60;89;62;60;60;60;77;75 14:40:59 INFO - PROCESS | 2565 | |4;audio-oscillator;88;71;86;70;68;70;81;68;70;83 14:40:59 INFO - PROCESS | 2565 | |5;imaging-gaussian-blur;117;90;91;88;92;88;92;87;91;87 14:40:59 INFO - PROCESS | 2565 | |6;imaging-darkroom;155;102;100;98;98;99;98;98;98;99 14:40:59 INFO - PROCESS | 2565 | |7;imaging-desaturate;86;85;85;85;86;86;85;92;85;85 14:40:59 INFO - PROCESS | 2565 | |8;json-parse-financial;56;57;56;57;57;57;57;55;56;56 14:40:59 INFO - PROCESS | 2565 | |9;json-stringify-tinderbox;65;76;68;75;74;71;70;71;71;72 14:40:59 INFO - PROCESS | 2565 | |10;stanford-crypto-aes;88;88;90;88;85;91;86;87;91;87 14:40:59 INFO - PROCESS | 2565 | |11;stanford-crypto-ccm;152;150;149;145;150;150;153;150;200;153 14:40:59 INFO - PROCESS | 2565 | |12;stanford-crypto-pbkdf2;176;173;176;176;176;176;174;175;172;160 14:40:59 INFO - PROCESS | 2565 | |13;stanford-crypto-sha256-iterative;70;69;70;69;68;71;72;79;86;86 14:40:59 INFO - PROCESS | 2565 | __end_tp_report 14:40:59 INFO - PROCESS | 2565 | __start_cc_report 14:40:59 INFO - PROCESS | 2565 | _x_x_mozilla_cycle_collect,2063 14:40:59 INFO - PROCESS | 2565 | __end_cc_report 14:40:59 INFO - PROCESS | 2565 | __startTimestamp1480891259405__endTimestamp 14:40:59 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | ------- Summary: start ------- 14:40:59 INFO - PROCESS | 2565 | Number of tests: 14 14:40:59 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | [#0] ai-astar Cycles:10 Average:113.90 Median:115.00 stddev:3.60 (3.1%) stddev-sans-first:1.00 14:40:59 INFO - PROCESS | 2565 | Values: 104.0 115.0 115.0 113.0 116.0 116.0 115.0 115.0 116.0 114.0 14:40:59 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | [#1] audio-beat-detection Cycles:10 Average:124.20 Median:116.00 stddev:16.01 (13.8%) stddev-sans-first:13.73 14:40:59 INFO - PROCESS | 2565 | Values: 151.0 116.0 115.0 153.0 116.0 114.0 115.0 112.0 135.0 115.0 14:40:59 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:1.35 (0.7%) stddev-sans-first:1.33 14:40:59 INFO - PROCESS | 2565 | Values: 185.0 184.0 184.0 186.0 183.0 183.0 181.0 183.0 183.0 184.0 14:40:59 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | [#3] audio-fft Cycles:10 Average:68.20 Median:68.50 stddev:10.99 (16.0%) stddev-sans-first:10.80 14:40:59 INFO - PROCESS | 2565 | Values: 80.0 59.0 60.0 89.0 62.0 60.0 60.0 60.0 77.0 75.0 14:40:59 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:76.00 stddev:8.00 (10.5%) stddev-sans-first:7.10 14:40:59 INFO - PROCESS | 2565 | Values: 88.0 71.0 86.0 70.0 68.0 70.0 81.0 68.0 70.0 83.0 14:40:59 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:90.50 stddev:8.90 (9.8%) stddev-sans-first:2.07 14:40:59 INFO - PROCESS | 2565 | Values: 117.0 90.0 91.0 88.0 92.0 88.0 92.0 87.0 91.0 87.0 14:40:59 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | [#6] imaging-darkroom Cycles:10 Average:104.50 Median:98.00 stddev:17.79 (18.2%) stddev-sans-first:1.36 14:40:59 INFO - PROCESS | 2565 | Values: 155.0 102.0 100.0 98.0 98.0 99.0 98.0 98.0 98.0 99.0 14:40:59 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:85.50 stddev:2.16 (2.5%) stddev-sans-first:2.29 14:40:59 INFO - PROCESS | 2565 | Values: 86.0 85.0 85.0 85.0 86.0 86.0 85.0 92.0 85.0 85.0 14:40:59 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 14:40:59 INFO - PROCESS | 2565 | Values: 56.0 57.0 56.0 57.0 57.0 57.0 57.0 55.0 56.0 56.0 14:40:59 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.50 stddev:3.27 (4.6%) stddev-sans-first:2.55 14:40:59 INFO - PROCESS | 2565 | Values: 65.0 76.0 68.0 75.0 74.0 71.0 70.0 71.0 71.0 72.0 14:40:59 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:88.00 stddev:2.02 (2.3%) stddev-sans-first:2.15 14:40:59 INFO - PROCESS | 2565 | Values: 88.0 88.0 90.0 88.0 85.0 91.0 86.0 87.0 91.0 87.0 14:40:59 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | [#11] stanford-crypto-ccm Cycles:10 Average:155.20 Median:151.00 stddev:15.91 (10.5%) stddev-sans-first:16.83 14:40:59 INFO - PROCESS | 2565 | Values: 152.0 150.0 149.0 145.0 150.0 150.0 153.0 150.0 200.0 153.0 14:40:59 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:176.00 stddev:4.93 (2.8%) stddev-sans-first:5.13 14:40:59 INFO - PROCESS | 2565 | Values: 176.0 173.0 176.0 176.0 176.0 176.0 174.0 175.0 172.0 160.0 14:40:59 INFO - PROCESS | 2565 | 14:40:59 INFO - PROCESS | 2565 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:71.50 stddev:7.02 (9.8%) stddev-sans-first:7.30 14:40:59 INFO - PROCESS | 2565 | Values: 70.0 69.0 70.0 69.0 68.0 71.0 72.0 79.0 86.0 86.0 14:40:59 INFO - PROCESS | 2565 | -------- Summary: end -------- 14:40:59 INFO - PROCESS | 2565 | 14:41:00 INFO - TEST-INFO | 2565: exit 0 14:41:00 INFO - TEST-OK | kraken | took 60982ms 14:41:00 INFO - SUITE-END | took 1182s 14:41:01 INFO - Completed test suite (00:19:42) 14:41:01 INFO - javascript benchmark 14:41:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3304.768666193366, 3308.387948229577, 3320.2695407010456, 3326.6340702522702, 3366.6296707362185, 5567.860803479915, 5653.406392328803, 5666.801661941833, 5673.035583950728, 5732.770689172438, 5658.236138121352, 5662.122371032487, 5691.630044047134, 5695.829125126243, 5817.185594016841, 5143.665661731994, 5181.1451110566895, 5225.477452254763, 5226.8693282667855, 5236.947630523703, 5108.540231379176, 5237.947620523803, 5240.60695447841, 5241.39723931747, 5263.894722105556, 5251.0, 5268.1834315681135, 5275.894482110355, 5281.017394419447, 5302.867428314304, 5126.179811230222, 5165.586753059746, 5180.6373553851245, 5214.713190774506, 5232.424433312332, 4293.355996600504, 4438.201123797715, 5096.802251470901, 5102.928385039147, 5186.974065129688, 5479.123340265538, 5601.29983752031, 5680.204771332017, 5680.744366503476, 5701.743421546041, 6105.053716673922, 6195.132681424604, 6201.007838745779, 6213.378662133796, 6231.096491008779, 6173.259208894961, 6191.0713392990965, 6204.317525072239, 6227.470664993481, 6235.282942461629, 5806.419358064244, 5813.593048486566, 5821.010428227211, 5840.182374467578, 5848.736806843703, 6112.724927378279, 6226.377362263737, 6239.594426362272, 6264.060390941395, 6266.154069200599, 5927.911081333784, 5947.1079338099635, 5983.521318294526, 6101.725422355916, 6141.477974372139, 6140.565599444434, 6188.628682279078, 6191.288001879841, 6241.34465881085, 6254.15568898202, 6174.5060395168275, 6176.382361763787, 6183.84540386485, 6197.597156184834, 6202.658853762996, 6075.878482430327, 6151.84620384494, 6155.538334624921, 6218.253809542884, 6232.532560058014, 4832.323474713543, 4835.0, 4889.3888263967, 4890.266460031024, 4896.853094407174, 4382.474103107647, 4411.0, 4459.643228541709, 4462.888427789331, 4470.128324976663, 5681.034224181899, 5765.394633563499, 5766.654000759968, 5775.306963164448, 5813.534917206698, 6137.171481849893, 6144.064619644798, 6166.229221347332, 6224.470919971853, 6268.028455589391, 5652.0, 5670.121131224667, 5695.857603559944, 5712.8286151414695, 5762.7694892203845, 5347.117725575236, 5348.277982472394, 5350.785968561214, 5351.384590772033, 5353.197020446886, 6214.844628884314, 6277.78027769035, 6285.74857005733, 6289.685515724195, 6303.747850085945, 6132.202813634199, 6140.140380346845, 6147.924113280247, 6158.107074474086, 6193.473554747897, 6219.067139928866, 6250.0, 6273.404026617464, 6283.59156654816, 6297.937020629735, 6185.567010309415, 6190.0, 6191.4118158774845, 6195.132681424514, 6205.379462053758, 6117.96941015292, 6155.692215389123, 6269.529785266214, 6276.152719382825, 6292.622442653273, 5355.768173320081, 5663.631863928831, 5969.761209551743, 6042.667653279112, 6049.122877182872, 5986.880262394815, 6030.5778595497895, 6032.00471922128, 6063.757449701962, 6090.451859332681, 5807.448292412214, 5865.0, 5927.911081333697, 5934.821955341346, 5946.0, 5927.170196172453, 5976.013957696931, 5992.790252341147, 6029.8191054268445, 6067.362926892612, 5756.280464941882, 5894.734736936934, 5937.109433584997, 5942.702864856827, 5948.643081415129], "value": 5658.048576423208, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.8675084225575, 459.59785187960534, 469.60318530841425, 534.8609361565995, 536.549298589185, 30003.099907002797, 37618.87143385699, 38476.61523384765, 38608.99999999996, 40281.19437611246, 32431.837840810822, 38841.61158388415, 39048.82853514399, 39267.0, 39335.606643933555, 9076.137766912148, 9260.861087083698, 9264.027277135905, 9281.0, 9282.164605185531, 8360.411521810836, 8562.743117706448, 10861.076808471249, 11103.888961110406, 11127.833082503728, 10987.725306867313, 11071.72320691985, 11079.224454288204, 11082.390468524229, 11155.330680159217, 8345.874811877766, 9396.48319342436, 10848.349099054043, 10960.725981850477, 11011.779764404668, 8267.421280510367, 10356.79286414275, 10539.683809485728, 10550.630727924487, 10557.788844223072, 37823.432648510294, 38069.85790426264, 38103.0, 38108.61891381079, 38195.85412437631, 3208.2620997170548, 3259.429599820022, 3317.784344017631, 3634.4548317752283, 3847.942280865789, 23465.0, 28808.567871481944, 29180.562291565642, 29272.975445859505, 29425.0, 3069.155982104917, 3119.485284927984, 3127.3276245607303, 3163.715265626082, 3255.186203449138, 350266.248668755, 353747.0, 357433.0, 362434.0, 363775.18112409534, 45008.77495612501, 53285.0, 53857.0, 53900.73049634727, 54151.729241354325, 54086.0, 55584.44415555873, 55910.72044639832, 55941.7202913991, 56094.43905560892, 14563.0, 15085.019473734172, 15092.622684432758, 15113.924430377778, 15301.0, 10921.290116142425, 11193.776124477465, 11796.646100616996, 11888.643340699793, 11912.344821034752, 10722.303050301705, 12956.740865182643, 13025.544105956245, 13074.607761767162, 14208.786868196985, 6830.311631718816, 6893.17281926162, 6942.819720647502, 6993.335633114846, 7033.8944915826305, 811.6347643560422, 956.1108169402384, 959.2613687460756, 1058.7300238439302, 1066.9413182274893, 27524.724752752216, 28403.0, 28797.28006799847, 28951.7104828949, 28976.247256510596, 978.9804203915882, 983.9963237497712, 1008.8436292374694, 1009.9646512372032, 1077.7767234189096, 13418.0, 14772.926135369255, 14833.480828170963, 14880.032797868103, 14891.015391012847, 518664.2200366997, 567606.0, 573753.0, 581490.0, 587591.0, 53129.0, 53313.466865331626, 53316.0, 53358.733206333716, 53475.0, 1176.2178151529308, 1326.4694122351136, 1346.9259190744408, 1359.3067535557134, 1368.6167872995577, 27327.590086148328, 28509.572356414257, 28544.000959966303, 28728.569071464364, 29290.7070929288, 44193.0, 44232.33651495166, 44276.77861610671, 44406.3339049921, 44542.77728611336, 524498.0, 524558.3772081116, 524978.0, 535669.0, 540794.0, 35960.28079438449, 36296.0, 36544.81727591345, 36950.63049369472, 37186.25627487381, 42223.0, 42755.786221068694, 43025.354619681355, 43347.133057339306, 44107.55892441035, 32650.83674581612, 35641.82179089088, 35722.464163038094, 36718.0, 36730.63269367272, 28932.98734544281, 33889.0, 34610.65389346175, 36593.81703091467, 36958.63041369552, 29584.704152958195, 35688.0, 36228.4565731509, 36513.63486365102, 36657.08357291089, 30876.22809429782, 31529.369412611162, 32315.19212019718, 32315.838420807744, 32434.513482298258, 21063.6815920398, 24381.878090609433, 24476.388090297885, 24523.615574134947, 24819.751802481744], "value": 18792.581983388754, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.2054584728049, 363.2535140286711, 368.68477451778745, 374.9325121478134, 393.87002289244555, 12145.696357591065, 13757.243351615669, 15088.47190348338, 19865.900670496663, 20424.59150816983, 19029.0, 19827.801721982774, 20139.29512467064, 20322.491937701565, 20594.0, 5460.836174914749, 5812.041013232812, 5820.767169313222, 5824.796132135376, 5827.592068555203, 5319.468053194669, 5354.785808567653, 5768.855778605526, 5790.623609465371, 5800.158976948361, 5742.569307301969, 5746.281714785652, 5746.396628354026, 5756.366799652035, 5774.422557744213, 5454.754536045868, 5662.546996240311, 5729.255196824386, 5730.0, 5732.0, 4773.71357718538, 5031.245313203012, 5036.093503169464, 5042.067217564762, 5052.873678158038, 24279.150229742052, 24332.02671893122, 24626.87686561556, 25034.374140646447, 25631.0, 2225.6995305633695, 2228.3760547046854, 2325.8837058147024, 2332.5684748321446, 2397.29279862441, 12763.36183190846, 14615.342309596093, 15105.0, 15373.692526149527, 16020.4392846251, 1781.2251670523235, 1819.199552197029, 1831.1210618903, 1884.8303652671325, 1903.6097599991967, 90048.0, 108890.0, 110358.0, 112128.0, 114675.0, 10309.278350515391, 10533.736656583493, 10601.681949541526, 10869.728256793644, 11109.83335249972, 13593.932030339984, 13643.317834108255, 13645.658858528417, 13673.384697688627, 13709.17744935307, 8012.238837310446, 8310.002799664078, 8328.791780205422, 8464.44981076228, 8496.362772792065, 8314.127016663164, 8344.290735287446, 8367.581620918929, 8528.829423411496, 8550.529720865412, 6404.327545607737, 6506.60960342381, 6559.44244739193, 6560.967195163994, 6561.2782593914635, 1768.089433941521, 1801.4865763257408, 1818.1182825221906, 1842.9078546072642, 1855.471190710641, 615.1510914937357, 730.9744158954411, 932.7901222225081, 957.6696039866235, 970.815545046439, 20665.690014649794, 21600.351989440343, 21663.67504487434, 21699.566008680053, 21974.670379944313, 902.7878448564582, 954.4798085043668, 981.1415011864618, 985.9753506162403, 1030.5362586835954, 10939.671809845717, 11681.941590291994, 11816.99555537789, 11824.645260642195, 11874.76250475003, 525073.0, 539428.0, 539586.0, 543675.5632443625, 546488.0, 82054.0, 113235.0, 113886.0, 117112.0, 119781.0, 976.2629214942673, 981.8379967305458, 1032.0917592518535, 1039.5374058543875, 1041.2711102228318, 19135.043247837275, 19503.927283999517, 19532.804671953098, 19561.608767824848, 19711.014449277765, 48672.75663621659, 49496.0, 49654.00691986212, 49733.0, 49840.0, 67223.0, 68292.31707682859, 69172.65413672899, 69307.65346173236, 69751.30248697448, 7686.884696729442, 7866.7639970800965, 8010.239027292398, 8084.0, 8087.474314169795, 9992.903619154138, 12535.93732031334, 13184.208947463183, 13232.00759942989, 13307.0, 11306.321620702784, 11355.479342797802, 11618.0, 11638.301701897914, 11687.240329378563, 11120.165987550805, 11161.386123763272, 11311.773764524827, 11354.221774153115, 11568.710782230175, 11471.311721296748, 11598.884011160118, 11785.0, 11790.764184716429, 11851.585194518151, 7848.568328741974, 7988.800279993046, 8039.598020099089, 8043.436959412785, 8179.219822134546, 11136.710062720467, 11482.138839586898, 11582.189246752647, 11625.069994400259, 11702.765944680888], "value": 9475.182666071521, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1271.3516106785537, 1418.3475601223436, 1523.9771403428952, 1574.9133797641125, 1739.791225052994, 7911.248431399015, 8280.710175143857, 8291.709790157345, 8301.169883011697, 8429.283510901565, 6158.846028849281, 7518.135414427343, 7538.698452061924, 7602.201768814278, 7602.581857997808, 2065.7934206579334, 2105.347342323877, 2207.3708992937018, 2294.8393612447135, 2295.8622482651012, 2320.3387034695115, 2323.0939933425975, 2324.2794733632627, 2324.337563794319, 2331.393837602219, 2250.651149071888, 2267.319804058784, 2294.242899843048, 2296.7588403217674, 2300.482391461916, 2255.154317131076, 2256.909723611054, 2263.6265016272296, 2278.453171238907, 2279.5213005268915, 2240.4958884251078, 2272.7272727272666, 2289.7710228977135, 2298.218605674079, 2300.0, 8120.472169308976, 8203.71287004958, 8204.056533498664, 8204.220599043081, 8236.50580965144, 4925.876853078702, 5103.157978933508, 5103.54068133866, 5111.642185047048, 5121.743912804345, 3359.3785149747373, 3380.5632606142535, 3517.4899639552123, 3520.06718219672, 3524.8942531724088, 1045.937243765369, 1049.0610903241632, 1064.2018486135398, 1080.9621663241828, 1084.414416215243, 10523.579056837718, 10571.154307655446, 10613.310134841287, 10627.41549214793, 10644.308119972176, 4117.011917139865, 4308.784560771949, 4333.349997500401, 4379.1460665170625, 4407.867763967086, 8425.07324194338, 8441.915580844236, 8456.196661317164, 8460.619272132768, 8482.279006284534, 4883.145449546315, 4981.0, 4981.850544483671, 4993.9512702332195, 4994.0, 4518.186726389215, 4669.929951050737, 4703.2004559225015, 4703.576678098988, 4705.576498115118, 3352.0949343677557, 3452.913677158041, 3453.499242609858, 3526.7707599006494, 3570.321638888603, 1108.451316598289, 1118.5413980268052, 1126.0766171739094, 1129.1362107987395, 1130.214500921868, 705.9541129826545, 876.8640860666607, 882.8366752150744, 887.933404994628, 907.5734404829719, 5245.318108645852, 5484.698341591251, 5489.890202195934, 5542.11326187808, 5653.604247702621, 853.53482352117, 862.8921384826897, 871.9258862996589, 876.8640860666607, 937.2548823685187, 3287.3260981498734, 3437.7452229935893, 3661.3409586274724, 3692.2430901665093, 3728.738988270795, 9269.119433653792, 9669.226461883032, 9740.512974351395, 9852.408855468695, 9898.65354712596, 9707.514624268759, 9881.555330010024, 9916.206703463706, 9918.0, 9920.603175872884, 7224.819379515449, 7574.469787114849, 7635.770926872203, 7641.885371719429, 7740.651670674946, 5368.7047212403695, 5480.3971563128825, 5596.496315331477, 5642.492175704207, 5786.307934210266, 9107.316951228551, 9120.680776172801, 9155.26757859383, 9208.079192081006, 9335.159835614828, 9058.592363343534, 9271.397359171633, 9276.953615231881, 9333.33999810051, 9393.342466027312, 7018.543794653331, 7066.364027237573, 7120.964395177991, 7186.7125314986815, 7196.280371962762, 7557.35762460197, 7632.313091821763, 7644.044494438195, 7761.650725717469, 7771.9896413465885, 6880.139982502187, 6958.234594194736, 6987.790366289019, 6999.965000174967, 7001.299870012958, 6450.967745161244, 6623.635700036544, 6685.09751183584, 6693.765718199839, 6762.289959554176, 6433.099366088658, 6531.771388001397, 6535.150430444012, 6555.049517819794, 6556.704948277244, 4656.720596764205, 4776.832810851603, 4794.137055330074, 4809.855704328876, 4884.242942343943, 4694.6009589185305, 4789.928151077806, 4830.130576496264, 4842.055799119138, 4961.454240033666], "value": 4283.6223970753, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.3406671256523, 303.48407706898263, 307.412841472787, 314.4952351475881, 315.8941754512238, 4857.247126695368, 5146.614003949705, 5153.561947234485, 5227.3465816772905, 5306.416294207644, 4201.70588058836, 4747.90504189916, 5019.6446959320965, 5032.6477146599755, 5175.792968281274, 3972.880813575597, 4038.2731108400476, 4039.8284497495692, 4054.1620865394193, 4062.2281766464353, 3330.533725278463, 3802.5817160112365, 3886.358750806128, 4002.259581977329, 4022.376531637586, 3678.8528458861615, 3771.208046310278, 3828.7894165820867, 4012.2978478766245, 4020.1959608078355, 3995.1011022519992, 3995.5216569869044, 3996.7402118862183, 4010.5187377514594, 4038.8788336349958, 2798.3004248937764, 3240.173755692307, 3493.877714279988, 3507.7895326280504, 3528.9942366425703, 4706.270528068155, 4856.708597484127, 5051.827714082943, 5059.924101138449, 5085.872853178663, 4529.456465224194, 4538.251188553918, 4545.795439205243, 4554.180247555439, 4563.486115690933, 5455.38973132478, 5457.645253058578, 5471.0456353569025, 5486.436365635775, 5491.9290738306045, 3574.1779390740276, 3836.884893453173, 3850.4994350734223, 3860.6911447084167, 3873.845046198149, 5349.22436246742, 5421.430749771257, 5632.971835140798, 5710.857228569277, 5717.855804073472, 3600.1019179560703, 3888.5392001119026, 3898.7270891037924, 3907.9218415631526, 3924.274009308287, 3487.843047062888, 3968.4840970673627, 3982.26328129297, 3989.3417586097967, 3998.580149084304, 4273.252180868336, 4524.660650451229, 4559.449787072412, 4566.109608626352, 4575.794089265991, 4533.9672963011035, 4812.494688057704, 5436.864078397993, 5445.727713614304, 5453.318335208099, 1043.5512729526376, 1185.6383802940186, 1186.128195776104, 1204.9578264760692, 1238.9814152787715, 832.2426591801432, 841.6338892581747, 850.1583432401877, 874.6894852327332, 887.9911200887908, 4412.536683648235, 4455.844045458458, 4522.032915681689, 4775.641826863, 4776.731052749916, 4418.977905110454, 4538.319252112209, 4825.9758701206265, 5213.895722085537, 5224.242484839677, 4370.836435964155, 4432.188119107584, 4447.932496200889, 4505.797239124247, 4795.95204047962, 2424.951500970006, 2464.4473981391607, 2634.315078079713, 2774.9861250693616, 2776.861156942185, 4602.9769851151195, 5001.824936127291, 5083.491650834887, 5403.891922161613, 5419.349678038582, 4720.63968015992, 5023.748812559357, 5286.841394758163, 5302.681839089667, 5768.3654797972185, 5791.276090488689, 5800.332961709373, 5844.444777746107, 5849.444302791228, 5881.764729410861, 5027.572656324107, 5651.321841379061, 5674.460926212003, 5701.714914254354, 5721.599488035964, 4519.61583265413, 5359.169328754049, 5563.58273129525, 5569.916451253315, 5638.9436105638415, 4955.40535135786, 5081.745912704424, 5823.126531020212, 5838.8396293371725, 5877.647341159544, 3507.2810073935293, 3795.1972812913646, 3800.4109363047664, 3823.464714939855, 3836.271108489378, 4128.60778226068, 4470.754108524063, 4814.0, 5157.690538567698, 5677.630953987978, 4632.050429661844, 5192.948070519397, 5302.469753024667, 5549.612596850788, 5552.361478430033, 4561.977190114028, 4819.0, 5474.562035037108, 5498.917516237339, 5520.696361700145, 4753.310769938271, 4984.900301994012, 5380.838574842761, 5458.6724796512335, 5485.927880386996, 4380.62764665007, 4747.074320507468, 5273.6572122811895, 5483.945160548344, 5630.831075067755, 5371.973140134274, 5376.462353764592, 5384.138537834085, 5390.218418329398, 5393.083175860034], "value": 3933.095372510263, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.9593824370537, 707.3351050012988, 713.9750108746194, 772.7334069745935, 774.3534148985597, 14665.853341466582, 15022.624434389145, 15433.614159646015, 15737.449189278377, 15739.921300393482, 13728.382222799974, 13969.231692256923, 14118.858811411883, 14156.646083847883, 14168.433262669507, 816.3142959913671, 831.3723139030054, 834.3200291762195, 836.2849763452252, 836.477201748907, 647.6696884588846, 667.326000739252, 793.5119901260712, 821.4496287487398, 824.9463784853965, 869.3088994249587, 870.5081628879694, 873.724776695339, 875.120503893586, 875.4090988582712, 870.4907629037021, 871.5772850167664, 872.0625327772669, 873.0919843362894, 873.2708188662474, 503.1120073071033, 520.828126718182, 642.3865208725656, 642.6818724731288, 644.2333622988629, 12261.816072758917, 12500.24998500093, 12512.186707864052, 12517.43671534774, 13911.79132313016, 12930.676733081655, 13644.249566273851, 13770.311484425738, 14171.078879872775, 14335.06822056563, 11622.825657615143, 11699.76600467986, 11727.296362218294, 11773.234739741889, 11800.46897889597, 3595.352836489431, 3671.889843304705, 3683.963160368389, 3692.2246328270826, 3796.3925771876366, 115482.33327196508, 118554.40722796331, 119897.80102198954, 119952.0, 122618.0, 10404.323718958243, 11019.559217631366, 11062.723431914266, 11140.49867755953, 11298.943505282585, 17332.91333543324, 20262.797372026387, 20455.79544204539, 21085.051172697265, 21158.682619760715, 7157.785266442015, 7443.8883416748795, 7512.436567257478, 7536.924630753732, 7693.884591731128, 3890.8832735017995, 4176.394422808676, 4193.370994350811, 4197.223513649923, 4200.726952748061, 3224.725898298671, 3442.586889573217, 3448.9827550862087, 3455.464403017486, 3459.5329630500064, 602.7408214467821, 612.3111499562991, 671.7514519627671, 675.4731309578536, 688.2291833146908, 569.2485918587507, 602.5631417222567, 615.3876892491999, 630.5019034962328, 639.7536948274948, 9255.722328330161, 9273.768155796159, 9304.069593040642, 9328.440293582407, 9414.858777118348, 510.7548376779093, 632.3117276870767, 641.9358064193543, 648.7859006527834, 654.309703263062, 4198.223328684203, 4603.356406553446, 4650.86047418578, 4666.463356714022, 4699.342092107107, 109266.45366773116, 117634.41182794032, 118312.0, 119250.0, 119359.0, 80668.38663226702, 81039.59480202562, 85778.0, 90407.54796225976, 97952.34810082303, 77048.22951770635, 80457.19542804614, 81391.18608813954, 83159.16840831636, 83570.74643880347, 9441.433513989183, 9737.22102231834, 9757.12185903272, 9761.9023809761, 9930.0, 37311.6940907067, 51467.48532514627, 54711.17933231084, 54715.35853924388, 55352.0, 69869.95195072179, 71688.28311716816, 73993.52012959818, 75505.0, 76243.61878190574, 12013.879861201276, 12164.939175304067, 12291.139620226499, 12497.625071247878, 12853.16454430459, 14307.427702891768, 14455.349509272319, 14817.27739598598, 14828.332725027183, 15269.541913742605, 13469.663258418617, 13834.723305534035, 13957.930210348883, 13989.510367137102, 14283.285835707966, 13420.93289533585, 13566.525171618947, 13965.511207107702, 14043.859561404664, 14248.216348100954, 12986.675333116747, 13230.669233269246, 13379.53171638988, 13518.932405338304, 13701.45194192261, 10888.67333979982, 11164.776704466027, 11537.480813363587, 11610.70973225676, 11808.11439142085, 10756.623518176826, 11175.10599152082, 11520.654380368602, 11591.5942942, 11607.477663504993], "value": 7378.009828632533, "unit": "score"}], "name": "dromaeo_css", "value": 7073.411573573192, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 115.0, 113.0, 116.0, 116.0, 115.0, 115.0, 116.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 116.0, 115.0, 153.0, 116.0, 114.0, 115.0, 112.0, 135.0, 115.0], "value": 124.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 186.0, 183.0, 183.0, 181.0, 183.0, 183.0, 184.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 60.0, 89.0, 62.0, 60.0, 60.0, 60.0, 77.0, 75.0], "value": 68.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 86.0, 70.0, 68.0, 70.0, 81.0, 68.0, 70.0, 83.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 90.0, 91.0, 88.0, 92.0, 88.0, 92.0, 87.0, 91.0, 87.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 102.0, 100.0, 98.0, 98.0, 99.0, 98.0, 98.0, 98.0, 99.0], "value": 104.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 86.0, 86.0, 85.0, 92.0, 85.0, 85.0], "value": 86.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 57.0, 57.0, 57.0, 57.0, 55.0, 56.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 76.0, 68.0, 75.0, 74.0, 71.0, 70.0, 71.0, 71.0, 72.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 90.0, 88.0, 85.0, 91.0, 86.0, 87.0, 91.0, 87.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 149.0, 145.0, 150.0, 150.0, 153.0, 150.0, 200.0, 153.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 173.0, 176.0, 176.0, 176.0, 176.0, 174.0, 175.0, 172.0, 160.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 69.0, 68.0, 71.0, 72.0, 79.0, 86.0, 86.0], "value": 74.0, "unit": "score"}], "name": "kraken", "value": 1466.6000000000001, "alertThreshold": 2.0}]} 14:41:01 INFO - Return code: 0 14:41:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:41:01 INFO - # TBPL SUCCESS # 14:41:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:41:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:41:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:41:01 INFO - 2016-12-04 14:41:01.191 screenresolution[2569:35110] starting screenresolution argv=screenresolution get 14:41:01 INFO - 2016-12-04 14:41:01.194 screenresolution[2569:35110] Display 0: 1600x1200x32@60 14:41:01 INFO - 2016-12-04 14:41:01.200 screenresolution[2570:35113] starting screenresolution argv=screenresolution list 14:41:01 INFO - Available Modes on Display 0 14:41:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:41:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:41:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:41:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:41:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:41:01 INFO - Intel Iris: 14:41:01 INFO - Chipset Model: Intel Iris 14:41:01 INFO - Type: GPU 14:41:01 INFO - Bus: Built-In 14:41:01 INFO - VRAM (Dynamic, Max): 1536 MB 14:41:01 INFO - Vendor: Intel (0x8086) 14:41:01 INFO - Device ID: 0x0a2e 14:41:01 INFO - Revision ID: 0x0009 14:41:01 INFO - Displays: 14:41:01 INFO - Display: 14:41:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:41:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:41:01 INFO - Display Serial Number: 1600x1200 60 14:41:01 INFO - Main Display: Yes 14:41:01 INFO - Mirror: Off 14:41:01 INFO - Online: Yes 14:41:01 INFO - Rotation: Supported 14:41:01 INFO - Return code: 0 14:41:01 INFO - Running post-action listener: _resource_record_post_action 14:41:01 INFO - [mozharness: 2016-12-04 22:41:01.434108Z] Finished run-tests step (success) 14:41:01 INFO - Running post-run listener: _resource_record_post_run 14:41:01 INFO - Total resource usage - Wall time: 1216s; CPU: 54.0%; Read bytes: 73728; Write bytes: 694955008; Read time: 2; Write time: 1975 14:41:01 INFO - TinderboxPrint: CPU usage
53.6% 14:41:01 INFO - TinderboxPrint: I/O read bytes / time
73,728 / 2 14:41:01 INFO - TinderboxPrint: I/O write bytes / time
694,955,008 / 1,975 14:41:01 INFO - TinderboxPrint: CPU idle
2,257.8 (46.4%) 14:41:01 INFO - TinderboxPrint: CPU system
978.5 (20.1%) 14:41:01 INFO - TinderboxPrint: CPU user
1,629.4 (33.5%) 14:41:01 INFO - TinderboxPrint: Swap in / out
383,303,680 / 0 14:41:01 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 376769024; Write bytes: 370570752; Read time: 28614; Write time: 766 14:41:01 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 73728; Write bytes: 307840512; Read time: 2; Write time: 1164 14:41:01 INFO - Running post-run listener: _upload_blobber_files 14:41:01 INFO - Blob upload gear active. 14:41:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:41:01 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 14:41:01 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'] 14:41:01 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 14:41:02 INFO - (blobuploader) - INFO - Open directory for files ... 14:41:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:41:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:41:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:41:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:41:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:41:03 INFO - (blobuploader) - INFO - Done attempting. 14:41:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:41:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:41:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:41:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:41:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:41:04 INFO - (blobuploader) - INFO - Done attempting. 14:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:41:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:41:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:41:06 INFO - (blobuploader) - INFO - Done attempting. 14:41:06 INFO - (blobuploader) - INFO - Iteration through files over. 14:41:06 INFO - Return code: 0 14:41:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:41:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:41:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b8960ad84955ed0cf077a0f8ce8cb930ebde6f97ef6aa7ba8e844610c343784d2c95d33a879e04bb220936688f84a6b0f2dff127b68d23e3c09669ad915252c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d7d91d83f71b3b6109e3b7bdc3f6f3ee482697f8cfc2178e34c70d374c68a1b8581caa495f0b6123418683a45b129d1deb8faa0ea6a4ef3a927c7dce852c74ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cb73be38b5c5a0d433664fedd82f444292c6753fe354815a7281f0695802748a7467acca101c942e93dffcac71c04eb8d481bd2bc94dcde6474f1e81042512c1"} 14:41:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:41:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:41:06 INFO - Contents: 14:41:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b8960ad84955ed0cf077a0f8ce8cb930ebde6f97ef6aa7ba8e844610c343784d2c95d33a879e04bb220936688f84a6b0f2dff127b68d23e3c09669ad915252c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d7d91d83f71b3b6109e3b7bdc3f6f3ee482697f8cfc2178e34c70d374c68a1b8581caa495f0b6123418683a45b129d1deb8faa0ea6a4ef3a927c7dce852c74ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cb73be38b5c5a0d433664fedd82f444292c6753fe354815a7281f0695802748a7467acca101c942e93dffcac71c04eb8d481bd2bc94dcde6474f1e81042512c1"} 14:41:06 INFO - Running post-run listener: copy_logs_to_upload_dir 14:41:06 INFO - Copying logs to upload dir... 14:41:06 INFO - mkdir: /builds/slave/test/build/upload/logs 14:41:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.578163 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-12-04 14:41:06.769439) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-04 14:41:06.773071) ========= 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.Dk7ZN1bqDn/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.pR7uoVFxJA/Listeners TMPDIR=/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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/b8960ad84955ed0cf077a0f8ce8cb930ebde6f97ef6aa7ba8e844610c343784d2c95d33a879e04bb220936688f84a6b0f2dff127b68d23e3c09669ad915252c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d7d91d83f71b3b6109e3b7bdc3f6f3ee482697f8cfc2178e34c70d374c68a1b8581caa495f0b6123418683a45b129d1deb8faa0ea6a4ef3a927c7dce852c74ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cb73be38b5c5a0d433664fedd82f444292c6753fe354815a7281f0695802748a7467acca101c942e93dffcac71c04eb8d481bd2bc94dcde6474f1e81042512c1"} build_url:https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011518 build_url: 'https://queue.taskcluster.net/v1/task/WmyoIkhBR4-IfrLvhAwWXg/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/b8960ad84955ed0cf077a0f8ce8cb930ebde6f97ef6aa7ba8e844610c343784d2c95d33a879e04bb220936688f84a6b0f2dff127b68d23e3c09669ad915252c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d7d91d83f71b3b6109e3b7bdc3f6f3ee482697f8cfc2178e34c70d374c68a1b8581caa495f0b6123418683a45b129d1deb8faa0ea6a4ef3a927c7dce852c74ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cb73be38b5c5a0d433664fedd82f444292c6753fe354815a7281f0695802748a7467acca101c942e93dffcac71c04eb8d481bd2bc94dcde6474f1e81042512c1"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-04 14:41:06.812231) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 14:41:06.812641) ========= 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.Dk7ZN1bqDn/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.pR7uoVFxJA/Listeners TMPDIR=/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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.005275 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 14:41:06.861545) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-04 14:41:06.861918) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-04 14:41:06.862306) ========= ========= Total master_lag: 0.19 =========