builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0221 starttime: 1468398610.93 results: success (0) buildid: 20160712233810 builduid: b3d856635cce4df9b0ab9743aca6f8c2 revision: c889eaf4dedd7699283c9955919e0dff26f43f64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 01:30:10.927950) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 01:30:10.928530) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 01:30:10.928867) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 01:30:10.961664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 01:30:10.962091) ========= 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.giLem85af8/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.lPNdA5vCgV/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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-07-13 01:30:10-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 156M=0s 2016-07-13 01:30:11 (156 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142967 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 01:30:11.128124) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 01:30:11.128526) ========= 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.giLem85af8/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.lPNdA5vCgV/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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.026048 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 01:30:11.177474) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 01:30:11.179441) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev c889eaf4dedd7699283c9955919e0dff26f43f64 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev c889eaf4dedd7699283c9955919e0dff26f43f64 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.giLem85af8/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.lPNdA5vCgV/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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-07-13 01:30:11,264 truncating revision to first 12 chars 2016-07-13 01:30:11,264 Setting DEBUG logging. 2016-07-13 01:30:11,265 attempt 1/10 2016-07-13 01:30:11,265 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/c889eaf4dedd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 01:30:12,456 unpacking tar archive at: autoland-c889eaf4dedd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.468440 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 01:30:12.673219) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 01:30:12.673541) ========= script_repo_revision: c889eaf4dedd7699283c9955919e0dff26f43f64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 01:30:12.677075) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 01:30:12.677367) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 01:30:12.695873) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-07-13 01:30:12.696293) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.giLem85af8/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.lPNdA5vCgV/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 01:30:12 INFO - MultiFileLogger online at 20160713 01:30:12 in /builds/slave/test 01:30:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 01:30:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:30:12 INFO - {'append_to_log': False, 01:30:12 INFO - 'base_work_dir': '/builds/slave/test', 01:30:12 INFO - 'blob_upload_branch': 'Autoland', 01:30:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:30:12 INFO - 'branch': 'Autoland', 01:30:12 INFO - 'buildbot_json_path': 'buildprops.json', 01:30:12 INFO - 'config_files': ('talos/mac_config.py',), 01:30:12 INFO - 'default_actions': ('clobber', 01:30:12 INFO - 'read-buildbot-config', 01:30:12 INFO - 'download-and-extract', 01:30:12 INFO - 'populate-webroot', 01:30:12 INFO - 'create-virtualenv', 01:30:12 INFO - 'install', 01:30:12 INFO - 'run-tests'), 01:30:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:30:12 INFO - 'download_minidump_stackwalk': True, 01:30:12 INFO - 'download_symbols': 'ondemand', 01:30:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:30:12 INFO - 'tooltool.py': '/tools/tooltool.py', 01:30:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:30:12 INFO - '/tools/misc-python/virtualenv.py')}, 01:30:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:30:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:30:12 INFO - 'installer_path': 'installer.exe', 01:30:12 INFO - 'log_level': 'info', 01:30:12 INFO - 'log_name': 'talos', 01:30:12 INFO - 'log_to_console': True, 01:30:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:30:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:30:12 INFO - 'opt_config_files': (), 01:30:12 INFO - 'pip_index': False, 01:30:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:30:12 INFO - 'cmd': ('bash', 01:30:12 INFO - '-c', 01:30:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:30:12 INFO - 'enabled': True, 01:30:12 INFO - 'halt_on_failure': False, 01:30:12 INFO - 'name': 'check_screen_resolution'},), 01:30:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:30:12 INFO - 'cmd': ('bash', 01:30:12 INFO - '-c', 01:30:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:30:12 INFO - 'enabled': True, 01:30:12 INFO - 'halt_on_failure': False, 01:30:12 INFO - 'name': 'check_screen_resolution'},), 01:30:12 INFO - 'run_cmd_checks_enabled': True, 01:30:12 INFO - 'sps_profile': False, 01:30:12 INFO - 'sps_profile_interval': 0, 01:30:12 INFO - 'suite': 'dromaeojs', 01:30:12 INFO - 'system_bits': '32', 01:30:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:30:12 INFO - 'title': 't-yosemite-r7-0221', 01:30:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:30:12 INFO - 'use_talos_json': True, 01:30:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:30:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:30:12 INFO - 'work_dir': 'build'} 01:30:12 INFO - ##### 01:30:12 INFO - ##### Running clobber step. 01:30:12 INFO - ##### 01:30:12 INFO - Running pre-action listener: _resource_record_pre_action 01:30:12 INFO - Running main action method: clobber 01:30:12 INFO - rmtree: /builds/slave/test/build 01:30:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:30:14 INFO - Running post-action listener: _resource_record_post_action 01:30:14 INFO - ##### 01:30:14 INFO - ##### Finished clobber step (success) 01:30:14 INFO - ##### 01:30:14 INFO - ##### 01:30:14 INFO - ##### Running read-buildbot-config step. 01:30:14 INFO - ##### 01:30:14 INFO - Running pre-action listener: _resource_record_pre_action 01:30:14 INFO - Running main action method: read_buildbot_config 01:30:14 INFO - Using buildbot properties: 01:30:14 INFO - { 01:30:14 INFO - "project": "", 01:30:14 INFO - "product": "firefox", 01:30:14 INFO - "script_repo_revision": "production", 01:30:14 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 01:30:14 INFO - "repository": "", 01:30:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 01:30:14 INFO - "buildid": "20160712233810", 01:30:14 INFO - "pgo_build": "False", 01:30:14 INFO - "basedir": "/builds/slave/test", 01:30:14 INFO - "buildnumber": 58, 01:30:14 INFO - "slavename": "t-yosemite-r7-0221", 01:30:14 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 01:30:14 INFO - "platform": "yosemite_r7", 01:30:14 INFO - "scheduler": "tests-autoland-macosx64-talos", 01:30:14 INFO - "branch": "autoland", 01:30:14 INFO - "repo_path": "integration/autoland", 01:30:14 INFO - "revision": "c889eaf4dedd7699283c9955919e0dff26f43f64", 01:30:14 INFO - "stage_platform": "macosx64", 01:30:14 INFO - "builduid": "b3d856635cce4df9b0ab9743aca6f8c2", 01:30:14 INFO - "slavebuilddir": "test" 01:30:14 INFO - } 01:30:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 01:30:14 INFO - Running post-action listener: _resource_record_post_action 01:30:14 INFO - ##### 01:30:14 INFO - ##### Finished read-buildbot-config step (success) 01:30:14 INFO - ##### 01:30:14 INFO - ##### 01:30:14 INFO - ##### Running download-and-extract step. 01:30:14 INFO - ##### 01:30:14 INFO - Running pre-action listener: _resource_record_pre_action 01:30:14 INFO - Running main action method: download_and_extract 01:30:14 INFO - mkdir: /builds/slave/test/build/tests 01:30:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:14 INFO - https://queue.taskcluster.net/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:30:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 01:30:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 01:30:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 01:30:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 01:30:16 INFO - Downloaded 1199 bytes. 01:30:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 01:30:16 INFO - Using the following test package requirements: 01:30:16 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 01:30:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 01:30:16 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 01:30:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 01:30:16 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 01:30:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 01:30:16 INFO - u'jsshell-mac.zip'], 01:30:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 01:30:16 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 01:30:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 01:30:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 01:30:16 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 01:30:16 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 01:30:16 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 01:30:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 01:30:16 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 01:30:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 01:30:16 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 01:30:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:16 INFO - https://queue.taskcluster.net/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:30:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 01:30:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 01:30:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 01:30:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:30:17 INFO - Downloaded 18822766 bytes. 01:30:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:30:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:30:20 INFO - Return code: 0 01:30:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:20 INFO - https://queue.taskcluster.net/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:30:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 01:30:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 01:30:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 01:30:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:30:24 INFO - Downloaded 18822766 bytes. 01:30:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:30:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:30:28 INFO - Return code: 0 01:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:28 INFO - https://queue.taskcluster.net/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:30:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 01:30:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 01:30:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 01:30:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:30:29 INFO - Downloaded 14403317 bytes. 01:30:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:30:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:30:29 INFO - Return code: 0 01:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:29 INFO - https://queue.taskcluster.net/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:30:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 01:30:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 01:30:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 01:30:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 01:30:32 INFO - Downloaded 112789269 bytes. 01:30:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 01:30:32 INFO - mkdir: /builds/slave/test/properties 01:30:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:30:32 INFO - Writing to file /builds/slave/test/properties/build_url 01:30:32 INFO - Contents: 01:30:32 INFO - build_url:https://queue.taskcluster.net/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 01:30:33 INFO - Running post-action listener: _resource_record_post_action 01:30:33 INFO - Running post-action listener: set_extra_try_arguments 01:30:33 INFO - ##### 01:30:33 INFO - ##### Finished download-and-extract step (success) 01:30:33 INFO - ##### 01:30:33 INFO - ##### 01:30:33 INFO - ##### Running populate-webroot step. 01:30:33 INFO - ##### 01:30:33 INFO - Running pre-action listener: _resource_record_pre_action 01:30:33 INFO - Running main action method: populate_webroot 01:30:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:30:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:30:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:30:33 INFO - '--tppagecycles', 01:30:33 INFO - '7'], 01:30:33 INFO - 'tests': ['tsvgm']}}, 01:30:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:30:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:30:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:30:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:30:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:30:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:30:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:30:33 INFO - 'talos_options': ['--disable-e10s'], 01:30:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:30:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:30:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:30:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:30:33 INFO - 'talos_options': ['--disable-e10s'], 01:30:33 INFO - 'tests': ['damp', 'tps']}, 01:30:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:30:33 INFO - 'tests': ['damp', 'tps']}, 01:30:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:30:33 INFO - 'tests': ['dromaeo_dom']}, 01:30:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:30:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:30:33 INFO - 'tests': ['basic_compositor_video']}, 01:30:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:30:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:30:33 INFO - 'tests': ['a11yr', 01:30:33 INFO - 'ts_paint', 01:30:33 INFO - 'tpaint', 01:30:33 INFO - 'sessionrestore', 01:30:33 INFO - 'sessionrestore_no_auto_restore', 01:30:33 INFO - 'tabpaint']}, 01:30:33 INFO - 'other-e10s': {'tests': ['a11yr', 01:30:33 INFO - 'ts_paint', 01:30:33 INFO - 'tpaint', 01:30:33 INFO - 'sessionrestore', 01:30:33 INFO - 'sessionrestore_no_auto_restore', 01:30:33 INFO - 'tabpaint']}, 01:30:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:30:33 INFO - 'ts_paint', 01:30:33 INFO - 'tpaint', 01:30:33 INFO - 'sessionrestore', 01:30:33 INFO - 'sessionrestore_no_auto_restore', 01:30:33 INFO - 'tabpaint']}, 01:30:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:30:33 INFO - 'ts_paint', 01:30:33 INFO - 'tpaint', 01:30:33 INFO - 'sessionrestore', 01:30:33 INFO - 'sessionrestore_no_auto_restore', 01:30:33 INFO - 'tabpaint']}, 01:30:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:30:33 INFO - 'tests': ['a11yr', 01:30:33 INFO - 'ts_paint', 01:30:33 INFO - 'tpaint', 01:30:33 INFO - 'sessionrestore', 01:30:33 INFO - 'sessionrestore_no_auto_restore', 01:30:33 INFO - 'tabpaint']}, 01:30:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:30:33 INFO - 'tests': ['a11yr', 01:30:33 INFO - 'ts_paint', 01:30:33 INFO - 'tpaint', 01:30:33 INFO - 'sessionrestore', 01:30:33 INFO - 'sessionrestore_no_auto_restore', 01:30:33 INFO - 'tabpaint']}, 01:30:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:30:33 INFO - 'tests': ['tsvgx', 01:30:33 INFO - 'tsvgr_opacity', 01:30:33 INFO - 'tart', 01:30:33 INFO - 'tscrollx', 01:30:33 INFO - 'cart']}, 01:30:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:30:33 INFO - 'tsvgr_opacity', 01:30:33 INFO - 'tart', 01:30:33 INFO - 'tscrollx', 01:30:33 INFO - 'cart']}, 01:30:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:30:33 INFO - 'talos_options': ['--disable-e10s'], 01:30:33 INFO - 'tests': ['tp5o']}, 01:30:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:30:33 INFO - 'tests': ['tp5o']}, 01:30:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:30:33 INFO - 'talos_options': ['--disable-e10s', 01:30:33 INFO - '--xperf_path', 01:30:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:30:33 INFO - 'tests': ['tp5n']}, 01:30:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:30:33 INFO - 'talos_options': ['--xperf_path', 01:30:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:30:33 INFO - 'tests': ['tp5n']}}, 01:30:33 INFO - 'talos.zip': {'path': '', 01:30:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:30:33 INFO - Running post-action listener: _resource_record_post_action 01:30:33 INFO - ##### 01:30:33 INFO - ##### Finished populate-webroot step (success) 01:30:33 INFO - ##### 01:30:33 INFO - ##### 01:30:33 INFO - ##### Running create-virtualenv step. 01:30:33 INFO - ##### 01:30:33 INFO - Running pre-action listener: _resource_record_pre_action 01:30:33 INFO - Running main action method: create_virtualenv 01:30:33 INFO - Creating virtualenv /builds/slave/test/build/venv 01:30:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:30:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:30:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:30:33 INFO - Using real prefix '/tools/python27' 01:30:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:30:34 INFO - Installing distribute.............................................................................................................................................................................................done. 01:30:37 INFO - Installing pip.................done. 01:30:37 INFO - Return code: 0 01:30:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa64b4dac60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dc3d30>, '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 0x105b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dbbb20>, '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.giLem85af8/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.lPNdA5vCgV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:30:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.giLem85af8/Render', 01:30:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:30:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:30:37 INFO - 'HOME': '/Users/cltbld', 01:30:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:30:37 INFO - 'LOGNAME': 'cltbld', 01:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:30:37 INFO - 'MOZ_NO_REMOTE': '1', 01:30:37 INFO - 'NO_EM_RESTART': '1', 01:30:37 INFO - 'PAGER': '/bin/cat', 01:30:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:30:37 INFO - 'PWD': '/builds/slave/test', 01:30:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:30:37 INFO - 'SHELL': '/bin/bash', 01:30:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lPNdA5vCgV/Listeners', 01:30:37 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 01:30:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:30:37 INFO - 'USER': 'cltbld', 01:30:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:30:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:30:37 INFO - 'XPC_FLAGS': '0x0', 01:30:37 INFO - 'XPC_SERVICE_NAME': '0', 01:30:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:30:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:30:37 INFO - Cleaning up... 01:30:37 INFO - Return code: 0 01:30:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa64b4dac60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dc3d30>, '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 0x105b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dbbb20>, '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.giLem85af8/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.lPNdA5vCgV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:30:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.giLem85af8/Render', 01:30:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:30:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:30:37 INFO - 'HOME': '/Users/cltbld', 01:30:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:30:37 INFO - 'LOGNAME': 'cltbld', 01:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:30:37 INFO - 'MOZ_NO_REMOTE': '1', 01:30:37 INFO - 'NO_EM_RESTART': '1', 01:30:37 INFO - 'PAGER': '/bin/cat', 01:30:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:30:37 INFO - 'PWD': '/builds/slave/test', 01:30:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:30:37 INFO - 'SHELL': '/bin/bash', 01:30:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lPNdA5vCgV/Listeners', 01:30:37 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 01:30:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:30:37 INFO - 'USER': 'cltbld', 01:30:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:30:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:30:37 INFO - 'XPC_FLAGS': '0x0', 01:30:37 INFO - 'XPC_SERVICE_NAME': '0', 01:30:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:30:37 INFO - Downloading/unpacking psutil>=3.1.1 01:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:30:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:30:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:30:40 INFO - Installing collected packages: psutil 01:30:40 INFO - Running setup.py install for psutil 01:30:40 INFO - building 'psutil._psutil_osx' extension 01:30:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 01:30:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 01:30:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 01:30:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 01:30:41 INFO - building 'psutil._psutil_posix' extension 01:30:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 01:30:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:30:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:30:41 INFO - ^ 01:30:41 INFO - 1 warning generated. 01:30:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 01:30:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:30:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:30:41 INFO - Successfully installed psutil 01:30:41 INFO - Cleaning up... 01:30:41 INFO - Return code: 0 01:30:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa64b4dac60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dc3d30>, '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 0x105b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dbbb20>, '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.giLem85af8/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.lPNdA5vCgV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:30:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:30:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.giLem85af8/Render', 01:30:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:30:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:30:41 INFO - 'HOME': '/Users/cltbld', 01:30:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:30:41 INFO - 'LOGNAME': 'cltbld', 01:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:30:41 INFO - 'MOZ_NO_REMOTE': '1', 01:30:41 INFO - 'NO_EM_RESTART': '1', 01:30:41 INFO - 'PAGER': '/bin/cat', 01:30:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:30:41 INFO - 'PWD': '/builds/slave/test', 01:30:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:30:41 INFO - 'SHELL': '/bin/bash', 01:30:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lPNdA5vCgV/Listeners', 01:30:41 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 01:30:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:30:41 INFO - 'USER': 'cltbld', 01:30:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:30:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:30:41 INFO - 'XPC_FLAGS': '0x0', 01:30:41 INFO - 'XPC_SERVICE_NAME': '0', 01:30:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:30:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:30:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:30:44 INFO - Installing collected packages: mozsystemmonitor 01:30:44 INFO - Running setup.py install for mozsystemmonitor 01:30:44 INFO - Successfully installed mozsystemmonitor 01:30:44 INFO - Cleaning up... 01:30:44 INFO - Return code: 0 01:30:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa64b4dac60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dc3d30>, '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 0x105b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dbbb20>, '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.giLem85af8/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.lPNdA5vCgV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:30: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==2.5.1'] in /builds/slave/test/build 01:30: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==2.5.1 01:30:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.giLem85af8/Render', 01:30:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:30:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:30:44 INFO - 'HOME': '/Users/cltbld', 01:30:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:30:44 INFO - 'LOGNAME': 'cltbld', 01:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:30:44 INFO - 'MOZ_NO_REMOTE': '1', 01:30:44 INFO - 'NO_EM_RESTART': '1', 01:30:44 INFO - 'PAGER': '/bin/cat', 01:30:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:30:44 INFO - 'PWD': '/builds/slave/test', 01:30:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:30:44 INFO - 'SHELL': '/bin/bash', 01:30:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lPNdA5vCgV/Listeners', 01:30:44 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 01:30:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:30:44 INFO - 'USER': 'cltbld', 01:30:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:30:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:30:44 INFO - 'XPC_FLAGS': '0x0', 01:30:44 INFO - 'XPC_SERVICE_NAME': '0', 01:30:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:30:44 INFO - Downloading/unpacking jsonschema==2.5.1 01:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:30:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:47 INFO - Downloading functools32-3.2.3-2.tar.gz 01:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:30:47 INFO - warning: no files found matching '*.txt' 01:30:47 INFO - no previously-included directories found matching 'build' 01:30:47 INFO - no previously-included directories found matching 'dist' 01:30:47 INFO - no previously-included directories found matching '.git*' 01:30:47 INFO - Installing collected packages: jsonschema, functools32 01:30:47 INFO - Running setup.py install for functools32 01:30:48 INFO - warning: no files found matching '*.txt' 01:30:48 INFO - no previously-included directories found matching 'build' 01:30:48 INFO - no previously-included directories found matching 'dist' 01:30:48 INFO - no previously-included directories found matching '.git*' 01:30:48 INFO - Successfully installed jsonschema functools32 01:30:48 INFO - Cleaning up... 01:30:48 INFO - Return code: 0 01:30:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa64b4dac60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dc3d30>, '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 0x105b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dbbb20>, '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.giLem85af8/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.lPNdA5vCgV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:30:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:30:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.giLem85af8/Render', 01:30:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:30:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:30:48 INFO - 'HOME': '/Users/cltbld', 01:30:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:30:48 INFO - 'LOGNAME': 'cltbld', 01:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:30:48 INFO - 'MOZ_NO_REMOTE': '1', 01:30:48 INFO - 'NO_EM_RESTART': '1', 01:30:48 INFO - 'PAGER': '/bin/cat', 01:30:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:30:48 INFO - 'PWD': '/builds/slave/test', 01:30:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:30:48 INFO - 'SHELL': '/bin/bash', 01:30:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lPNdA5vCgV/Listeners', 01:30:48 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 01:30:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:30:48 INFO - 'USER': 'cltbld', 01:30:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:30:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:30:48 INFO - 'XPC_FLAGS': '0x0', 01:30:48 INFO - 'XPC_SERVICE_NAME': '0', 01:30:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:30:48 INFO - Downloading/unpacking blobuploader==1.2.4 01:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:50 INFO - Downloading blobuploader-1.2.4.tar.gz 01:30:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:30:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:30:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:52 INFO - Downloading docopt-0.6.1.tar.gz 01:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:30:52 INFO - Installing collected packages: blobuploader, requests, docopt 01:30:52 INFO - Running setup.py install for blobuploader 01:30:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:30:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:30:52 INFO - Running setup.py install for requests 01:30:52 INFO - Running setup.py install for docopt 01:30:53 INFO - Successfully installed blobuploader requests docopt 01:30:53 INFO - Cleaning up... 01:30:53 INFO - Return code: 0 01:30:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:53 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 0x105e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa64b4dac60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dc3d30>, '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 0x105b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dbbb20>, '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.giLem85af8/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.lPNdA5vCgV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:30:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:30:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.giLem85af8/Render', 01:30:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:30:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:30:53 INFO - 'HOME': '/Users/cltbld', 01:30:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:30:53 INFO - 'LOGNAME': 'cltbld', 01:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:30:53 INFO - 'MOZ_NO_REMOTE': '1', 01:30:53 INFO - 'NO_EM_RESTART': '1', 01:30:53 INFO - 'PAGER': '/bin/cat', 01:30:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:30:53 INFO - 'PWD': '/builds/slave/test', 01:30:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:30:53 INFO - 'SHELL': '/bin/bash', 01:30:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lPNdA5vCgV/Listeners', 01:30:53 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 01:30:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:30:53 INFO - 'USER': 'cltbld', 01:30:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:30:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:30:53 INFO - 'XPC_FLAGS': '0x0', 01:30:53 INFO - 'XPC_SERVICE_NAME': '0', 01:30:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:30:53 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-849NbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:30:53 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-OsnBFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:30:53 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-iMZ_Jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:30:53 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-FqqPdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:30:53 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-Dr_aUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:30:53 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-ZqGb3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:30:53 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-asSJox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:30:54 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-7Vw60M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:30:54 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-yJiNrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:30:54 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-8DFfSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:30:54 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-JZGsMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:30:54 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-TyEHu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:30:54 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-gawlsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:30:54 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-jebMCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:30:54 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-gEm3SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:30:54 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-YlUT8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:30:55 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-ss3_A4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:30:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:30:55 INFO - Running setup.py install for manifestparser 01:30:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:30:55 INFO - Running setup.py install for mozcrash 01:30:55 INFO - Running setup.py install for mozdebug 01:30:55 INFO - Running setup.py install for mozdevice 01:30:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:30:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:30:55 INFO - Running setup.py install for mozfile 01:30:55 INFO - Running setup.py install for mozhttpd 01:30:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:30:56 INFO - Running setup.py install for mozinfo 01:30:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:30:56 INFO - Running setup.py install for mozInstall 01:30:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:30:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:30:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:30:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:30:56 INFO - Running setup.py install for mozleak 01:30:56 INFO - Running setup.py install for mozlog 01:30:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:30:56 INFO - Running setup.py install for moznetwork 01:30:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:30:56 INFO - Running setup.py install for mozprocess 01:30:56 INFO - Running setup.py install for mozprofile 01:30:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:30:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:30:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:30:57 INFO - Running setup.py install for mozrunner 01:30:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:30:57 INFO - Running setup.py install for mozscreenshot 01:30:57 INFO - Running setup.py install for moztest 01:30:57 INFO - Running setup.py install for mozversion 01:30:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:30:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:30:57 INFO - Cleaning up... 01:30:57 INFO - Return code: 0 01:30:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:57 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 0x105e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa64b4dac60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dc3d30>, '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 0x105b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dbbb20>, '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.giLem85af8/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.lPNdA5vCgV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:30:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:30:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.giLem85af8/Render', 01:30:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:30:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:30:57 INFO - 'HOME': '/Users/cltbld', 01:30:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:30:57 INFO - 'LOGNAME': 'cltbld', 01:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:30:57 INFO - 'MOZ_NO_REMOTE': '1', 01:30:57 INFO - 'NO_EM_RESTART': '1', 01:30:57 INFO - 'PAGER': '/bin/cat', 01:30:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:30:57 INFO - 'PWD': '/builds/slave/test', 01:30:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:30:57 INFO - 'SHELL': '/bin/bash', 01:30:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lPNdA5vCgV/Listeners', 01:30:57 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 01:30:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:30:57 INFO - 'USER': 'cltbld', 01:30:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:30:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:30:57 INFO - 'XPC_FLAGS': '0x0', 01:30:57 INFO - 'XPC_SERVICE_NAME': '0', 01:30:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:30:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-0rFGNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:30:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-RjrlKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:30:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-TcFnYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:30:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-M6zxqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:30:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-41_yRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:30:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-Nrbwyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:30:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-ViG9Jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:30:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-c_jyL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:30:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-Wl8tDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:30:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-pYBmnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:30:59 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-O2jJqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:30:59 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-CVNLDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:30:59 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)) 01:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:30:59 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-iWtu3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:30:59 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-d5LL9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:30:59 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-4YyKd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:30:59 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-vPVmkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:30:59 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)) 01:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:30:59 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-xfmZtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:30:59 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:30:59 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:30:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:02 INFO - Downloading blessings-1.6.tar.gz 01:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:31:02 INFO - Installing collected packages: blessings 01:31:02 INFO - Running setup.py install for blessings 01:31:02 INFO - Successfully installed blessings 01:31:02 INFO - Cleaning up... 01:31:02 INFO - Return code: 0 01:31:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:31:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:31:02 INFO - Reading from file tmpfile_stdout 01:31:02 INFO - Current package versions: 01:31:02 INFO - blessings == 1.6 01:31:02 INFO - blobuploader == 1.2.4 01:31:02 INFO - docopt == 0.6.1 01:31:02 INFO - functools32 == 3.2.3-2 01:31:02 INFO - jsonschema == 2.5.1 01:31:02 INFO - manifestparser == 1.1 01:31:02 INFO - mozInstall == 1.12 01:31:02 INFO - mozcrash == 0.17 01:31:02 INFO - mozdebug == 0.1 01:31:02 INFO - mozdevice == 0.48 01:31:02 INFO - mozfile == 1.2 01:31:02 INFO - mozhttpd == 0.7 01:31:02 INFO - mozinfo == 0.9 01:31:02 INFO - mozleak == 0.1 01:31:02 INFO - mozlog == 3.2 01:31:02 INFO - moznetwork == 0.27 01:31:02 INFO - mozprocess == 0.23 01:31:02 INFO - mozprofile == 0.28 01:31:02 INFO - mozrunner == 6.12 01:31:02 INFO - mozscreenshot == 0.1 01:31:02 INFO - mozsystemmonitor == 0.3 01:31:02 INFO - moztest == 0.7 01:31:02 INFO - mozversion == 1.4 01:31:02 INFO - psutil == 3.1.1 01:31:02 INFO - requests == 1.2.3 01:31:02 INFO - wsgiref == 0.1.2 01:31:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:31:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:02 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 0x105e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa64b4dac60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dc3d30>, '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 0x105b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dbbb20>, '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.giLem85af8/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.lPNdA5vCgV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:31:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:31:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.giLem85af8/Render', 01:31:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:31:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:31:02 INFO - 'HOME': '/Users/cltbld', 01:31:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:31:02 INFO - 'LOGNAME': 'cltbld', 01:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:02 INFO - 'MOZ_NO_REMOTE': '1', 01:31:02 INFO - 'NO_EM_RESTART': '1', 01:31:02 INFO - 'PAGER': '/bin/cat', 01:31:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:02 INFO - 'PWD': '/builds/slave/test', 01:31:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:31:02 INFO - 'SHELL': '/bin/bash', 01:31:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lPNdA5vCgV/Listeners', 01:31:02 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 01:31:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:31:02 INFO - 'USER': 'cltbld', 01:31:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:31:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:02 INFO - 'XPC_FLAGS': '0x0', 01:31:02 INFO - 'XPC_SERVICE_NAME': '0', 01:31:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:31:03 INFO - Cleaning up... 01:31:03 INFO - Return code: 0 01:31:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:31:03 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:03 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:03 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 0x105e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa64b4dac60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dc3d30>, '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 0x105b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dbbb20>, '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.giLem85af8/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.lPNdA5vCgV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:31:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:31:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.giLem85af8/Render', 01:31:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:31:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:31:03 INFO - 'HOME': '/Users/cltbld', 01:31:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:31:03 INFO - 'LOGNAME': 'cltbld', 01:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:03 INFO - 'MOZ_NO_REMOTE': '1', 01:31:03 INFO - 'NO_EM_RESTART': '1', 01:31:03 INFO - 'PAGER': '/bin/cat', 01:31:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:03 INFO - 'PWD': '/builds/slave/test', 01:31:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:31:03 INFO - 'SHELL': '/bin/bash', 01:31:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lPNdA5vCgV/Listeners', 01:31:03 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 01:31:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:31:03 INFO - 'USER': 'cltbld', 01:31:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:31:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:03 INFO - 'XPC_FLAGS': '0x0', 01:31:03 INFO - 'XPC_SERVICE_NAME': '0', 01:31:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:31:03 INFO - Cleaning up... 01:31:03 INFO - Return code: 0 01:31:03 INFO - Running post-action listener: _resource_record_post_action 01:31:03 INFO - Running post-action listener: _start_resource_monitoring 01:31:03 INFO - Starting resource monitoring. 01:31:03 INFO - ##### 01:31:03 INFO - ##### Finished create-virtualenv step (success) 01:31:03 INFO - ##### 01:31:03 INFO - ##### 01:31:03 INFO - ##### Running install step. 01:31:03 INFO - ##### 01:31:03 INFO - Running pre-action listener: _resource_record_pre_action 01:31:03 INFO - Running main action method: install 01:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:31:03 INFO - Reading from file tmpfile_stdout 01:31:03 INFO - Detecting whether we're running mozinstall >=1.0... 01:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:31:03 INFO - Reading from file tmpfile_stdout 01:31:03 INFO - Output received: 01:31:03 INFO - Usage: mozinstall [options] installer 01:31:03 INFO - Options: 01:31:03 INFO - -h, --help show this help message and exit 01:31:03 INFO - -d DEST, --destination=DEST 01:31:03 INFO - Directory to install application into. [default: 01:31:03 INFO - "/builds/slave/test"] 01:31:03 INFO - --app=APP Application being installed. [default: firefox] 01:31:03 INFO - mkdir: /builds/slave/test/build/application 01:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:31:38 INFO - Reading from file tmpfile_stdout 01:31:38 INFO - Output received: 01:31:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:31:38 INFO - Running post-action listener: _resource_record_post_action 01:31:38 INFO - ##### 01:31:38 INFO - ##### Finished install step (success) 01:31:38 INFO - ##### 01:31:38 INFO - ##### 01:31:38 INFO - ##### Running run-tests step. 01:31:38 INFO - ##### 01:31:38 INFO - Running pre-action listener: _resource_record_pre_action 01:31:38 INFO - Running main action method: run_tests 01:31:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:31:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:31:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:31:38 INFO - 2016-07-13 01:31:38.458 screenresolution[1633:7402] starting screenresolution argv=screenresolution get 01:31:38 INFO - 2016-07-13 01:31:38.461 screenresolution[1633:7402] Display 0: 1600x1200x32@60 01:31:38 INFO - 2016-07-13 01:31:38.467 screenresolution[1634:7404] starting screenresolution argv=screenresolution list 01:31:38 INFO - Available Modes on Display 0 01:31:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:31:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:31:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:31:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:31:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:31:38 INFO - Intel Iris: 01:31:38 INFO - Chipset Model: Intel Iris 01:31:38 INFO - Type: GPU 01:31:38 INFO - Bus: Built-In 01:31:38 INFO - VRAM (Dynamic, Max): 1536 MB 01:31:38 INFO - Vendor: Intel (0x8086) 01:31:38 INFO - Device ID: 0x0a2e 01:31:38 INFO - Revision ID: 0x0009 01:31:38 INFO - Displays: 01:31:38 INFO - Display: 01:31:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:31:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:31:38 INFO - Display Serial Number: 1600x1200 60 01:31:38 INFO - Main Display: Yes 01:31:38 INFO - Mirror: Off 01:31:38 INFO - Online: Yes 01:31:38 INFO - Rotation: Supported 01:31:38 INFO - Return code: 0 01:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:31:38 INFO - Python 2.7.3 01:31:38 INFO - Return code: 0 01:31:38 INFO - grabbing minidump binary from tooltool 01:31: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:31:38 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 0x105dc3d30>, '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 0x105b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dbbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:31:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:31:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 01:31:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:31:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:31:38 INFO - Return code: 0 01:31:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:31:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:31:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:31:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:31:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0221', '--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 01:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0221 --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 01:31:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.giLem85af8/Render', 01:31:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:31:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:31:38 INFO - 'HOME': '/Users/cltbld', 01:31:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:31:38 INFO - 'LOGNAME': 'cltbld', 01:31:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:31:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:38 INFO - 'MOZ_NO_REMOTE': '1', 01:31:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:31:38 INFO - 'NO_EM_RESTART': '1', 01:31:38 INFO - 'PAGER': '/bin/cat', 01:31:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:38 INFO - 'PWD': '/builds/slave/test', 01:31:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:31:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:31:38 INFO - 'SHELL': '/bin/bash', 01:31:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lPNdA5vCgV/Listeners', 01:31:38 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 01:31:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:31:38 INFO - 'USER': 'cltbld', 01:31:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:31:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:38 INFO - 'XPC_FLAGS': '0x0', 01:31:38 INFO - 'XPC_SERVICE_NAME': '0', 01:31:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:31:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0221', '--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 01:31:39 INFO - mozversion application_buildid: 20160712233810 01:31:39 INFO - mozversion application_changeset: c889eaf4dedd7699283c9955919e0dff26f43f64 01:31:39 INFO - mozversion application_display_name: Nightly 01:31:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:31:39 INFO - mozversion application_name: Firefox 01:31:39 INFO - mozversion application_remotingname: firefox 01:31:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 01:31:39 INFO - mozversion application_vendor: Mozilla 01:31:39 INFO - mozversion application_version: 50.0a1 01:31:39 INFO - mozversion platform_buildid: 20160712233810 01:31:39 INFO - mozversion platform_changeset: c889eaf4dedd7699283c9955919e0dff26f43f64 01:31:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 01:31:39 INFO - mozversion platform_version: 50.0a1 01:31:39 INFO - using testdate: 1468398699 01:31:39 INFO - actual date: 1468398699 01:31:39 INFO - starting webserver on 'localhost:49272' 01:31:39 INFO - SUITE-START | Running 2 tests 01:31:39 INFO - TEST-START | dromaeo_css 01:31:39 INFO - operating with platform_type : mac_ 01:31:39 INFO - Initialising browser for dromaeo_css test... 01:31:39 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/tmpbhRqnn/profile http://localhost:49272/getInfo.html) 01:31:41 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 01:31:41 INFO - PROCESS | 1644 | colorDepth:24 01:31:41 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 01:31:41 INFO - PROCESS | 1644 | __metrics 01:31:41 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:31:41 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:31:42 INFO - TEST-INFO | 1644: exit 0 01:31:42 INFO - Browser initialized. 01:31:42 INFO - Running cycle 1/1 for dromaeo_css test... 01:31:42 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/tmpbhRqnn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:31:54 INFO - PROCESS | 1646 | RSS: Main: 243843072 01:31:54 INFO - PROCESS | 1646 | 01:32:45 INFO - PROCESS | 1646 | 1468398765378 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] 01:34:57 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 01:34:58 INFO - PROCESS | 1646 | RSS: Main: 381403136 01:34:58 INFO - PROCESS | 1646 | 01:38:01 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 01:38:02 INFO - PROCESS | 1646 | RSS: Main: 379731968 01:38:02 INFO - PROCESS | 1646 | 01:41:04 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 01:41:05 INFO - PROCESS | 1646 | RSS: Main: 371355648 01:41:05 INFO - PROCESS | 1646 | 01:44:07 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 01:44:08 INFO - PROCESS | 1646 | RSS: Main: 374857728 01:44:08 INFO - PROCESS | 1646 | 01:47:11 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 01:47:12 INFO - PROCESS | 1646 | RSS: Main: 342638592 01:47:12 INFO - PROCESS | 1646 | 01:50:15 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 01:50:15 INFO - PROCESS | 1646 | RSS: Main: 386859008 01:50:15 INFO - PROCESS | 1646 | 01:50:15 INFO - PROCESS | 1646 | __start_tp_report 01:50:15 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 01:50:15 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 01:50:15 INFO - PROCESS | 1646 | |i|pagename|runs| 01:50:15 INFO - PROCESS | 1646 | |0;dojo.html;2831.617731606233;3345.163709072733;3357.5467311912885;3366.8653253869848;3408.5739282589675;5575.581831362654;5606.971965140179;5624.409437009116;5644.407337229588;5684.772609095637;5636;5680.573956953224;5697.974364614368;5701.173329867167;5710.543156547476;5102.489751024896;5136.409312929005;5150.510701483353;5168.992046550924;5218.6868787872845;5157.922631160535;5182.844514664566;5185.688858668492;5190.870228244286;5197.038547868638;5128.5640720538795;5148.433672296044;5151.381834179903;5165.431802501741;5186.118359878811;5198.740062996854;5223.947760522384;5227.921581176285;5228.111221092423;5289.523942845124;5052.69683818972;5066.240063990394;5068.366454193226;5160.92258616121;5162.045021671003;5591.496765291144;5640.971795141039;5658.688772117532;5685.800996965087;5693.174489699012;6207.658578778165;6218.906716399258;6224.439800417938;6226.750929962796;6236.594621349643;6068.150458935753;6170.2904166021035;6241.625502469821;6274.247090349188;6279;4815.4702982672225;5776.133579962955;5782.421757824184;5789.247397838339;5798.536117110621;6219.689015549205;6237.688115594202;6251.624902505864;6280.214973128359;6293.118963345135;5949.286085669747;6024.698765061729;6029.125776762345;6082.543809214327;6107.728430436195;6213.347598502182;6246.718897649616;6261.749530018748;6263.4362907338555;6268.404501572343;6107.4197951194565;6149.723262453201;6162.969185154046;6172.290186628506;6173.81478555635;6050.878982420327;6106.084087386838;6115.113308570232;6190.845228869314;6232.376762323732;4643.442786865598;4819.638527110481;4833.9033219335415;4883.267509873547;4902.166631672624;4378.321360189176;4381.978090109593;4391.231534481517;4402.933955990663;4443.4445694288215;5694.088945768657;5718.628289161191;5727.11229759388;5732.828015159552;5780.364159942403;6116.663583502861;6122.7550897964475;6198.783042593487;6242.687865606701;6252.6873656317;5708.286464191976;5729.140628905698;5733.996550603628;5735.053716136874;5780.219670344533;5310.92033619496;5350.732463376816;5353.544948679328;5367.597430192673;5371.409144994048;6171.475424588871;6200.782972596027;6244.781432649836;6252.718627661675;6296.590721603081;6264.718087685974;6271.686415679106;6272.059191121369;6277.686115694106;6286.5599408041;6175.289841668266;6221.4089661482085;6245.375462453719;6265.310815810349;6271.78048768291;6107.9083813741945;6109.17526133984;6111.652512877656;6132.171952247831;6145.631262124108;6200.503959683305;6222.253329600477;6222.471089957405;6236.75052997875;6243.843903902439;5871.853203669943;5921.61509501881;6043.365446628217;6075.149479072845;6086;5898.439648233411;5945.940540594539;5971.641701497924;6027.095935609694;6040.637561746309;5708.372079071216;5868.354481007001;5901.114832775118;5910.881782364243;5923.289205295392;6056.424639659225;6069.4840938518955;6070.605410648293;6079.392060793885;6111.236095488064;5680.886382272414;5708.372079071381;5841;5854.677992710272;5882.647041177372 01:50:15 INFO - PROCESS | 1646 | |1;ext.html;496.48861672477364;516.9121249387604;527.9498447647472;545.4109561673394;563.9013172694779;29511.26221844455;30307.393852122972;31599;31736.88920887772;40655;40812;43765.56234437654;43829.34255986163;43861.56138438615;43862.56137438625;9646.855297170565;9831.508424578778;9838.409695418262;9838.655647052354;9840.852387214198;8671.089535598767;8837.602307896128;8842.071582483843;9738.220942324597;9865.358751681119;8842.734717958472;8918.28653707705;11691.12316576256;11861.52553897843;11951.581694640689;11864.881351186465;11932.701682458008;11940.104492163036;11941.880581194251;11999.940000299986;11757.059435245159;11811.586594469152;11826.881731182664;11854.348010859485;11866.644000679993;31743.841280793447;40494.79752601247;40888.977775555846;40990;43139.92150196239;3662.267546490686;3675.4854320395166;3714.962850371489;4225.302825033866;4275.358696195595;31498.37003259922;31544.842275788473;31650.208744781336;32592.02223933286;32598;3268.509723541464;3277.705006549398;3297.934041319184;3301.1087006508346;3330.3505816365578;465596;475234.6238268821;475908;476072;478515;49817.501824981286;57277.713611431675;57591.71204144036;57890.131648025315;58327;60980;62000.37999620036;62104;65774.67112664405;65842.34157658363;16149;16330.591735206715;16345.346186152421;16351.59121021984;16373.42693005739;12715.618531444072;12790.552330668383;12796.61610151697;12808.6797830055;12812.295323757096;13670.726585468235;15459.227038648023;15498.457553985556;15499.302531386114;15550.688986220439;5389.973050134724;6324.620522768557;6346.555741098079;6361.2048493938255;6392.776252831129;923.1138107416821;972.5769290358717;1015.9492025398848;1069.5935544493043;1071.7749272652675;27671.723282766914;30085.398292034035;30089.24776880552;30713;30792.84603576968;1088.031651829872;1133.240728711765;1159.930404175752;1210.3403645013489;1260.0612543654852;15106.848931510543;15575.688486230212;15847.445339413065;16260.105694186697;16356.591085222964;691669;697660.5116974383;698000;698977;699935;50538.494615054115;59233.70383148057;59316.40683593195;59514;59560;1407.5636552668705;1430.4421275702484;1436.8563143685758;1437.9065360751517;1439.8848092152812;30970.070897873098;31687;31771.84114079415;32502.674973249967;32726.34547308993;50681.746591266805;51024.72438189075;51147;51251;51477.7426112867;515794;831798;853189;890685;891316;39794.80102599468;40936.181276374904;40954.59045409508;41174.79412602918;41376.37935430911;48389.51610483991;48460.273095902885;49133.263001055726;49413.01173976572;49451.50548494469;33562.993110206735;38184.80907595444;38580.614193858826;40315.596844031184;40381.596184037786;39262.4110638335;39476;39995;40355;41023;35454.46818297676;38395.6160438392;39067.21865562729;39157.60842391539;39186.608133919435;28373.716262837108;31266.687333126378;34196.65803341935;35247.647523524436;35509.82245088758;21328;22954.622722636694;24244.39389015289;25299.861506231897;26162.86918565395 01:50:15 INFO - PROCESS | 1646 | |2;jquery.html;316.6074068155487;352.7654110016839;357.2569056362766;381.5192857000179;385.3833865814696;15942.521724348273;18046.909765451186;20791.54513125824;20974.790252097475;21021.789782102176;21294.680579791315;21485.57028859422;22173.667394989046;22410.879456027174;22478.438039049033;5303.734813259341;5835.503982161521;6067.332593414721;6098.695065246742;6133.417325354084;5913.793017244398;5920.4671579557835;5950.583459157839;5969.731362088694;5978.043513037915;5792;5925.644461332312;5927.110933360009;6121.908171377433;6133.969330153365;5918.526517878559;5934.080217566284;6101.60339577926;6128.540359473035;6143.170671959273;5923.08192230205;5927.170196172539;5965.671888046156;5968.134620480006;5970.850728731773;13580.253086080262;13841.723165536734;21759.891200543894;26494.602580961302;26512.86743566289;2091.215794077221;2298.9425264368356;2375.904963801446;2608.804339674532;2676.37105280259;10091.29360944734;10120.797584048352;10222.846657300146;10571.154307655446;10620.946895265552;1914.8946807925558;1917.712343148525;1955.735975643284;1962.5878565501262;1978.495483651674;125094;133311;133982;135045.3247733765;137116;11443.198976071595;11537.769244615229;11729.178957473066;11768;11852.229605075814;12019;14392.208428536322;14510.85489145095;14532.63668408277;14543.27283635814;7021.262767409348;8411.074781774;8585.871211931826;8660.95669521661;8673;8534.829303413897;8546.914530854736;8549.658013679507;8653.480791152551;8674.86987695185;4508.278675411918;4608.953910460919;4622.722636641813;4640.234361330343;4672.766361681903;1711.9828801711824;1778.36867911892;1890.9432717018512;1933.8936358500137;1934.912928918174;384.9049454302561;386.8994061544019;423.41568635283727;807.5719868469721;889.9065598112105;9933.403995760278;12073.87926120745;12222.877771222174;12259.325737084368;12293.323867187391;428.93565965105483;439.1743522178284;441.77027945468177;444.22704494179897;445.3208856493808;6181.289151747516;6203;6256.249250090018;6311.116443697886;6370.140031095835;583503.0824845849;584338;586770;625537;629771;86668;127398.36300818437;141538;149418;151521;438.35342869268214;445.96655250856315;446.55790767140945;448.25142012838637;978.6574698855486;19260.32588859383;19924.50188745293;20211.292604758764;20917.163313467292;21536.569268614854;59728;60370.698146508985;60510.39489605048;61593.07610385938;62048.37951620426;61099.861504848894;81586.59206703928;86208.56895715481;86670;86733.13266867503;7930.9603451982375;8306.335493160654;8386.161383861565;8422.410431269998;8536.31709463229;9676.564554595201;10484.056434920589;13213.537526186537;13252.536161234311;13654.385552650354;11302.660920172408;11530;11560.30638161713;11567.826482602599;11852.229605075643;10925.508352124014;11421.31472111676;11654;11773.705657358634;11933.701657458285;11730.002949749025;11812.82280765772;11871.347075910908;11997.460114295052;12198.75602487963;8369.24245908366;8395.412321137463;8536.871946920677;8666;8722;10212;11748.471318790504;11782.882171178178;11814.409279536161;11913.285202887855 01:50:15 INFO - PROCESS | 1646 | |3;mootools.html;1552.0842702805342;1587.3650539784085;1782.896182504645;1915.0424787606196;1927.4795805132605;8526.616302266397;8788.824223515527;8947.373683842126;8953.641854325819;8981.640734370618;7880.605969701521;8121.390895682818;8498.022727386353;8756.992945811233;8767.254783343424;2358.398608354867;2383.843835739665;2390.5457962987066;2397.3766820626674;2398.95202095958;2364.7871691547757;2371.4664200554826;2405.3505553500545;2405.518896220754;2409.2772168349425;2103.6739305407687;2173.989095070792;2178.4009397415757;2188.8796116213603;2383.2969274064194;2322.1524143687516;2384.4515761374983;2386.642003699442;2396.628522579003;2401.6877805885297;2025.574629327843;2367.4791545860057;2370.4903445759073;2377.1442280778906;2383.9523209535887;8770.912290877073;8825.823483530294;8827.249683776823;8836.337274704423;8842;5171.974140129275;5285.550728188108;5334.573234141299;5343.973280133613;5349.786008559653;2931.325795067125;3585.3904836177653;3630.2376500934834;3659.1035196376793;3666.853325866962;1087.7008822573775;1101.1136035491427;1104.6023431564631;1128.351198061118;1130.5477808876433;11478.311301321864;11535.480903359368;11543.07655387567;11549.595764148215;11552.711182220428;4505.481869584974;4586.495485496593;4753.738544380092;4756.7145971241835;4801.615870730333;9794.314397992215;9817.754556136153;9821.312508124363;9837.262205334486;9869.555869985868;4800.879978000508;5297.576193904479;5315.6013299002725;5320.840374788762;5331.920021199685;4374.737515749065;4507.098580283956;4703.247480403187;4744.810207591658;4871.171900776876;3915.060385507458;3964.147708242742;3990.880273591797;4041.2523683118716;4075.919881231476;1268.6783186768191;1278.8081787731728;1283.9101262911693;1289.1362786932777;1298.078364361314;651.7067319706151;788.9329407000355;810.6676262732251;881.8721285413579;992.4789485520015;5001.149804533238;6066.181065556182;6073.635581865102;6073.969630151821;6161;928.8746019287445;931.4923366765129;965.7199412170391;971.2958105373548;1010.8332125199407;3911.5501717302304;4023.3562629979065;4053.351463765783;4101.938470922939;4128.8348466061625;10315.948420258;10597;10680.51937662807;10701.83947240792;10718.142548596094;10657.467126643636;10661;10665.84001239982;10670.786584268271;10686.946565267279;7736.845263094707;7970.242826931432;7990.64042118106;8121.79695507617;8145.266925976691;6045.063015232646;6047.637141771508;6126.264848218242;6154.5384096192065;6193.6903154841175;9698.6120555177;9917.851232231667;9942;9942.850857237292;9977.800443991226;9538.618455261712;9862.408255504693;10219.080282774587;10262.743431414274;10267.281290309607;7524.887126692995;7569.735059272899;7650.273224043707;7659.885101723367;7678.731244406643;6970.756023539152;8137.145599711945;8145.79635509117;8242.958785206036;8278.83442331138;7186.748463803742;7204.9639751800905;7275.490715649854;7365.963170184329;7371.152317483558;7026.332498412643;7094.361507464353;7115.146182458138;7240.637968101679;7244.927550724636;7067.57594544329;7093.716251349888;7094.4679149062995;7129.180144283474;7147.499675022907;4793.832215872428;4963.255511673278;5021.598272138147;5027.01973115239;5032.220005899091;4706.882327941828;4977.178765503651;5026.4973502649445;5088.160453525127;5166.199239117943 01:50:15 INFO - PROCESS | 1646 | |4;prototype.html;304.83386554327893;311.954766558849;314.2708915316466;319.8992317420014;322.9418704633165;5394.244805727197;5455.781768729256;5462.426445223254;5468.976478702885;5484.287042684456;4469.7541635210055;5333.2000199970025;5394.946050539494;5418;5427.538659213962;3822.9426558601645;3872.419137129425;3976.8210430530694;4057.2696914555368;4088.2028004539125;3381.3575420670118;3443.655634436549;4025.2352053109817;4100.883328670217;4151.107511884944;3622.329868974235;4054.3918412238254;4063.796810159495;4086.2031903778775;4117.279476091672;3163.889263875776;3904.3167445697172;4013.919721605581;4083.2650122977852;4149.958500415018;3371.9157021074425;3547.5388199534154;3554.591222009476;3598.604153543108;3634.509341238952;4431.40176076232;5233.581313494949;5241;5262.184361423985;5262.394824595182;4497.572730590588;4589.426321709786;4704.905901881977;4709.764511774431;4724.338592597039;5622.690752008638;5650.1242307442;5673.290838645169;5678.290213723285;5679.864027194536;3633.872814451508;3774.5470543534675;3833.290841194388;3977.8607748728655;4028.1339512004765;5503.889922201573;5655.87904535799;5739.799107031234;5997.760089596454;6022.6687532185715;3459.290845376692;4024.6981476389387;4027.718059735849;4088.713790034669;4109.130345692703;4154.863078375867;4156.605122513356;4181.749095054306;4191.832326706897;4202.432671589297;4364.781760911942;4607.585317321457;4710.24636058229;4787.114383839001;4797;4893.266010098442;5604.41153678866;5699.316082070178;5749.626274292157;5754.136879468113;1387.049870838479;1412.11037046662;1421.147311613024;1422.2248874363497;1430.9212993285469;781.6521647866645;819.9262066414051;837.6774941647387;871.5053682933799;902.5261737587819;4014.5182578090817;5071.518205770446;5157.742112894341;5277.340332458442;5336.813211537577;5114.411842638145;5441.401445840955;5499.587530935196;5811.535077193815;5873.089671100986;4301.65586753059;4338.60952514269;4591.380163677861;5151.660568252281;5256.448072952285;2829.900953466619;3017.728404443567;3028.2140430803715;3084.1981084917634;3106.5495503151915;4607.861764147081;5454;6021.277446706424;6048.788292409745;6061.393860613904;5570.356744760305;5925.762969481259;5962.522998160137;6087.54343424245;6120.234970628671;5100.438951715234;5716.628419152742;6075.878482430327;6084.414123997372;6103.657195417001;5431.565474762088;5604.486788567146;5866.3547009828035;5924.4667979882015;5953.945888668402;5023.723695196799;5810.912836307543;5823.388544202798;5847.8245652630485;5850.297964244318;5090.581973562528;5303.761330740203;5480.903819236089;5628.579710724428;6179.196704428396;3702.2140789401947;3890.7276490646514;3920.5883382244456;3925.2728799328206;3938.2517321708783;5527.839153777591;5536.584756143225;5830.708464576839;5831.504322132666;5844.766209351578;5739.540836733135;5749.281339832521;5754.856128596819;5767.913481297868;5773.278340207474;5425.972870135624;5534.418886017072;5701.572382071278;5713.457221563945;5775.191473193672;5539.390667026704;5546.4453554644215;5570.721463926707;5581.246531718329;5660.547156227574;5442.836714898559;5453.918191227055;5489.639455034374;5534.584906132137;5651.92613403452;4046;5505.018193450274;5614.29821272341;5623.8594035149445;5640.887182256414 01:50:15 INFO - PROCESS | 1646 | |5;yui.html;651.6741629185407;744.4677055905026;751.6730222353277;794.9046114466263;799.2087833045287;13838.654033649163;14854.628634284149;14976.400943962228;15606.843931560681;15688.921555392235;15158.242087895616;15376.846231537682;15384.38462461503;15387.307571159297;15519.612009699735;691.0532570378564;715.0489848501506;866.9003064647583;879.4767113567417;884.4958373726978;879.5909901895617;883.1257055515058;898.4519443139679;903.6385445821658;905.4612505559181;934.2666007184362;936.494293081735;936.8173206224789;937.3953799799125;940.4404379394249;738.7119023580781;759.4835511851938;762.3596179209491;764.4228607401432;933.5239028095687;683.5044592670324;704.1128178495081;705.8235441139715;709.9254578269259;710.605613884294;13109.410076546483;15669.13819739914;15682.607934801606;15722.685546289125;15728.134952577604;14415.639609009859;14551.272436378138;14588;14595.78106328406;14647.853521464756;13133.802992955114;13403;13449;13491.190528568317;13877.097988630707;4551.385562948993;4681.361523466793;4854.902901941977;4859.222524396115;4905.730184839832;117698;120390.3980480092;121427;121694;121827;11033.668989930315;11222.943885280521;11545.249558778652;11621.825672614917;11809.654404896704;23410;23419.414514637272;23431.648525272136;23437.531249374915;23464.530709385715;7781.377489800802;7787.4548781584745;8099.757007289791;8143.714969976022;8169.142240064826;4291.29193683045;4377.671674624352;4409.250427427345;4508.887277818081;4537.001859590885;3517.577890653138;3634.109643137448;3637.8181090945345;3637.999550123684;3645.872394466234;647.3170804800981;655.0599889159072;668.0113432120489;669.7220653428869;680.5236334565824;519.5479932458785;612.4671535763825;626.6803929995643;644.1239913717341;651.850074482862;8513.233808957224;8806.691765788295;8842.867356989651;8994.235489983294;9030.503322317205;582.5863636817907;625.1643537239449;625.1747693045137;632.3234139470815;637.3339859846471;3904.824282907219;4305.138972205571;4458.286674132123;4504.24507224069;4515.88710282239;88892.5555372219;118008;147863;149876;160399;101743.98256017345;107175;109641;114520.42739786248;132290;113253;113622.43188784004;114354;114803;115488;9542.618295268112;9582.712518624452;9681.66114186;9831.754206144904;9850.60597576089;62688.68655656693;65081;65466;65588.67205664131;67970;82593;94569.5271523638;99418;101192.49403752934;104771;11745.236559623598;12540.623781286577;13464.192148471124;13503.987200959771;14154.78767818463;15222.845262726501;15407.537773866801;15447.07317560905;15612.84387156114;15842.52472425829;13926.30368481592;14108.224047677477;14132.717345653235;14295.28523573838;14416.783748243995;13310.534131305358;13363.866361336262;13401.262930538915;13625.523106691218;13697;13840.584782456543;13930.303484825921;14001.5099471518;14186.361613727613;14384.712305753617;11209.55161793519;11545;11585.826212606986;11603.129765267808;11808.409579521162;10902.890971090188;11017.944910275397;11404.087672986307;11643.88356116428;11926.821097683714 01:50:15 INFO - PROCESS | 1646 | __end_tp_report 01:50:15 INFO - PROCESS | 1646 | __start_cc_report 01:50:15 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1444 01:50:15 INFO - PROCESS | 1646 | __end_cc_report 01:50:15 INFO - PROCESS | 1646 | __startTimestamp1468399815603__endTimestamp 01:50:15 INFO - PROCESS | 1646 | 01:50:15 INFO - PROCESS | 1646 | ------- Summary: start ------- 01:50:15 INFO - PROCESS | 1646 | Number of tests: 6 01:50:15 INFO - PROCESS | 1646 | 01:50:15 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5695.15 Median:5882.65 stddev:649.77 (11.0%) stddev-sans-first:611.70 01:50:15 INFO - PROCESS | 1646 | Values: 2831.6 3345.2 3357.5 3366.9 3408.6 5575.6 5607.0 5624.4 5644.4 5684.8 5636.0 5680.6 5698.0 5701.2 5710.5 5102.5 5136.4 5150.5 5169.0 5218.7 5157.9 5182.8 5185.7 5190.9 5197.0 5128.6 5148.4 5151.4 5165.4 5186.1 5198.7 5223.9 5227.9 5228.1 5289.5 5052.7 5066.2 5068.4 5160.9 5162.0 5591.5 5641.0 5658.7 5685.8 5693.2 6207.7 6218.9 6224.4 6226.8 6236.6 6068.2 6170.3 6241.6 6274.2 6279.0 4815.5 5776.1 5782.4 5789.2 5798.5 6219.7 6237.7 6251.6 6280.2 6293.1 5949.3 6024.7 6029.1 6082.5 6107.7 6213.3 6246.7 6261.7 6263.4 6268.4 6107.4 6149.7 6163.0 6172.3 6173.8 6050.9 6106.1 6115.1 6190.8 6232.4 4643.4 4819.6 4833.9 4883.3 4902.2 4378.3 4382.0 4391.2 4402.9 4443.4 5694.1 5718.6 5727.1 5732.8 5780.4 6116.7 6122.8 6198.8 6242.7 6252.7 5708.3 5729.1 5734.0 5735.1 5780.2 5310.9 5350.7 5353.5 5367.6 5371.4 6171.5 6200.8 6244.8 6252.7 6296.6 6264.7 6271.7 6272.1 6277.7 6286.6 6175.3 6221.4 6245.4 6265.3 6271.8 6107.9 6109.2 6111.7 6132.2 6145.6 6200.5 6222.3 6222.5 6236.8 6243.8 5871.9 5921.6 6043.4 6075.1 6086.0 5898.4 5945.9 5971.6 6027.1 6040.6 5708.4 5868.4 5901.1 5910.9 5923.3 6056.4 6069.5 6070.6 6079.4 6111.2 5680.9 5708.4 5841.0 5854.7 5882.6 01:50:15 INFO - PROCESS | 1646 | 01:50:15 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:77770.67 Median:39172.11 stddev:181591.66 (463.6%) stddev-sans-first:182008.39 01:50:15 INFO - PROCESS | 1646 | Values: 496.5 516.9 527.9 545.4 563.9 29511.3 30307.4 31599.0 31736.9 40655.0 40812.0 43765.6 43829.3 43861.6 43862.6 9646.9 9831.5 9838.4 9838.7 9840.9 8671.1 8837.6 8842.1 9738.2 9865.4 8842.7 8918.3 11691.1 11861.5 11951.6 11864.9 11932.7 11940.1 11941.9 11999.9 11757.1 11811.6 11826.9 11854.3 11866.6 31743.8 40494.8 40889.0 40990.0 43139.9 3662.3 3675.5 3715.0 4225.3 4275.4 31498.4 31544.8 31650.2 32592.0 32598.0 3268.5 3277.7 3297.9 3301.1 3330.4 465596.0 475234.6 475908.0 476072.0 478515.0 49817.5 57277.7 57591.7 57890.1 58327.0 60980.0 62000.4 62104.0 65774.7 65842.3 16149.0 16330.6 16345.3 16351.6 16373.4 12715.6 12790.6 12796.6 12808.7 12812.3 13670.7 15459.2 15498.5 15499.3 15550.7 5390.0 6324.6 6346.6 6361.2 6392.8 923.1 972.6 1015.9 1069.6 1071.8 27671.7 30085.4 30089.2 30713.0 30792.8 1088.0 1133.2 1159.9 1210.3 1260.1 15106.8 15575.7 15847.4 16260.1 16356.6 691669.0 697660.5 698000.0 698977.0 699935.0 50538.5 59233.7 59316.4 59514.0 59560.0 1407.6 1430.4 1436.9 1437.9 1439.9 30970.1 31687.0 31771.8 32502.7 32726.3 50681.7 51024.7 51147.0 51251.0 51477.7 515794.0 831798.0 853189.0 890685.0 891316.0 39794.8 40936.2 40954.6 41174.8 41376.4 48389.5 48460.3 49133.3 49413.0 49451.5 33563.0 38184.8 38580.6 40315.6 40381.6 39262.4 39476.0 39995.0 40355.0 41023.0 35454.5 38395.6 39067.2 39157.6 39186.6 28373.7 31266.7 34196.7 35247.6 35509.8 21328.0 22954.6 24244.4 25299.9 26162.9 01:50:15 INFO - PROCESS | 1646 | 01:50:15 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:35514.04 Median:383.21 stddev:101211.13 (26411.3%) stddev-sans-first:101460.54 01:50:15 INFO - PROCESS | 1646 | Values: 316.6 352.8 357.3 381.5 385.4 15942.5 18046.9 20791.5 20974.8 21021.8 21294.7 21485.6 22173.7 22410.9 22478.4 5303.7 5835.5 6067.3 6098.7 6133.4 5913.8 5920.5 5950.6 5969.7 5978.0 5792.0 5925.6 5927.1 6121.9 6134.0 5918.5 5934.1 6101.6 6128.5 6143.2 5923.1 5927.2 5965.7 5968.1 5970.9 13580.3 13841.7 21759.9 26494.6 26512.9 2091.2 2298.9 2375.9 2608.8 2676.4 10091.3 10120.8 10222.8 10571.2 10620.9 1914.9 1917.7 1955.7 1962.6 1978.5 125094.0 133311.0 133982.0 135045.3 137116.0 11443.2 11537.8 11729.2 11768.0 11852.2 12019.0 14392.2 14510.9 14532.6 14543.3 7021.3 8411.1 8585.9 8661.0 8673.0 8534.8 8546.9 8549.7 8653.5 8674.9 4508.3 4609.0 4622.7 4640.2 4672.8 1712.0 1778.4 1890.9 1933.9 1934.9 384.9 386.9 423.4 807.6 889.9 9933.4 12073.9 12222.9 12259.3 12293.3 428.9 439.2 441.8 444.2 445.3 6181.3 6203.0 6256.2 6311.1 6370.1 583503.1 584338.0 586770.0 625537.0 629771.0 86668.0 127398.4 141538.0 149418.0 151521.0 438.4 446.0 446.6 448.3 978.7 19260.3 19924.5 20211.3 20917.2 21536.6 59728.0 60370.7 60510.4 61593.1 62048.4 61099.9 81586.6 86208.6 86670.0 86733.1 7931.0 8306.3 8386.2 8422.4 8536.3 9676.6 10484.1 13213.5 13252.5 13654.4 11302.7 11530.0 11560.3 11567.8 11852.2 10925.5 11421.3 11654.0 11773.7 11933.7 11730.0 11812.8 11871.3 11997.5 12198.8 8369.2 8395.4 8536.9 8666.0 8722.0 10212.0 11748.5 11782.9 11814.4 11913.3 01:50:15 INFO - PROCESS | 1646 | 01:50:15 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5684.30 Median:5024.05 stddev:3162.32 (62.9%) stddev-sans-first:3155.95 01:50:15 INFO - PROCESS | 1646 | Values: 1552.1 1587.4 1782.9 1915.0 1927.5 8526.6 8788.8 8947.4 8953.6 8981.6 7880.6 8121.4 8498.0 8757.0 8767.3 2358.4 2383.8 2390.5 2397.4 2399.0 2364.8 2371.5 2405.4 2405.5 2409.3 2103.7 2174.0 2178.4 2188.9 2383.3 2322.2 2384.5 2386.6 2396.6 2401.7 2025.6 2367.5 2370.5 2377.1 2384.0 8770.9 8825.8 8827.2 8836.3 8842.0 5172.0 5285.6 5334.6 5344.0 5349.8 2931.3 3585.4 3630.2 3659.1 3666.9 1087.7 1101.1 1104.6 1128.4 1130.5 11478.3 11535.5 11543.1 11549.6 11552.7 4505.5 4586.5 4753.7 4756.7 4801.6 9794.3 9817.8 9821.3 9837.3 9869.6 4800.9 5297.6 5315.6 5320.8 5331.9 4374.7 4507.1 4703.2 4744.8 4871.2 3915.1 3964.1 3990.9 4041.3 4075.9 1268.7 1278.8 1283.9 1289.1 1298.1 651.7 788.9 810.7 881.9 992.5 5001.1 6066.2 6073.6 6074.0 6161.0 928.9 931.5 965.7 971.3 1010.8 3911.6 4023.4 4053.4 4101.9 4128.8 10315.9 10597.0 10680.5 10701.8 10718.1 10657.5 10661.0 10665.8 10670.8 10686.9 7736.8 7970.2 7990.6 8121.8 8145.3 6045.1 6047.6 6126.3 6154.5 6193.7 9698.6 9917.9 9942.0 9942.9 9977.8 9538.6 9862.4 10219.1 10262.7 10267.3 7524.9 7569.7 7650.3 7659.9 7678.7 6970.8 8137.1 8145.8 8243.0 8278.8 7186.7 7205.0 7275.5 7366.0 7371.2 7026.3 7094.4 7115.1 7240.6 7244.9 7067.6 7093.7 7094.5 7129.2 7147.5 4793.8 4963.3 5021.6 5027.0 5032.2 4706.9 4977.2 5026.5 5088.2 5166.2 01:50:15 INFO - PROCESS | 1646 | 01:50:15 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4603.33 Median:5269.87 stddev:1416.38 (26.9%) stddev-sans-first:1383.12 01:50:15 INFO - PROCESS | 1646 | Values: 304.8 312.0 314.3 319.9 322.9 5394.2 5455.8 5462.4 5469.0 5484.3 4469.8 5333.2 5394.9 5418.0 5427.5 3822.9 3872.4 3976.8 4057.3 4088.2 3381.4 3443.7 4025.2 4100.9 4151.1 3622.3 4054.4 4063.8 4086.2 4117.3 3163.9 3904.3 4013.9 4083.3 4150.0 3371.9 3547.5 3554.6 3598.6 3634.5 4431.4 5233.6 5241.0 5262.2 5262.4 4497.6 4589.4 4704.9 4709.8 4724.3 5622.7 5650.1 5673.3 5678.3 5679.9 3633.9 3774.5 3833.3 3977.9 4028.1 5503.9 5655.9 5739.8 5997.8 6022.7 3459.3 4024.7 4027.7 4088.7 4109.1 4154.9 4156.6 4181.7 4191.8 4202.4 4364.8 4607.6 4710.2 4787.1 4797.0 4893.3 5604.4 5699.3 5749.6 5754.1 1387.0 1412.1 1421.1 1422.2 1430.9 781.7 819.9 837.7 871.5 902.5 4014.5 5071.5 5157.7 5277.3 5336.8 5114.4 5441.4 5499.6 5811.5 5873.1 4301.7 4338.6 4591.4 5151.7 5256.4 2829.9 3017.7 3028.2 3084.2 3106.5 4607.9 5454.0 6021.3 6048.8 6061.4 5570.4 5925.8 5962.5 6087.5 6120.2 5100.4 5716.6 6075.9 6084.4 6103.7 5431.6 5604.5 5866.4 5924.5 5953.9 5023.7 5810.9 5823.4 5847.8 5850.3 5090.6 5303.8 5480.9 5628.6 6179.2 3702.2 3890.7 3920.6 3925.3 3938.3 5527.8 5536.6 5830.7 5831.5 5844.8 5739.5 5749.3 5754.9 5767.9 5773.3 5426.0 5534.4 5701.6 5713.5 5775.2 5539.4 5546.4 5570.7 5581.2 5660.5 5442.8 5453.9 5489.6 5534.6 5651.9 4046.0 5505.0 5614.3 5623.9 5640.9 01:50:15 INFO - PROCESS | 1646 | 01:50:15 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:24861.38 Median:13491.05 stddev:38701.31 (286.9%) stddev-sans-first:38767.19 01:50:15 INFO - PROCESS | 1646 | Values: 651.7 744.5 751.7 794.9 799.2 13838.7 14854.6 14976.4 15606.8 15688.9 15158.2 15376.8 15384.4 15387.3 15519.6 691.1 715.0 866.9 879.5 884.5 879.6 883.1 898.5 903.6 905.5 934.3 936.5 936.8 937.4 940.4 738.7 759.5 762.4 764.4 933.5 683.5 704.1 705.8 709.9 710.6 13109.4 15669.1 15682.6 15722.7 15728.1 14415.6 14551.3 14588.0 14595.8 14647.9 13133.8 13403.0 13449.0 13491.2 13877.1 4551.4 4681.4 4854.9 4859.2 4905.7 117698.0 120390.4 121427.0 121694.0 121827.0 11033.7 11222.9 11545.2 11621.8 11809.7 23410.0 23419.4 23431.6 23437.5 23464.5 7781.4 7787.5 8099.8 8143.7 8169.1 4291.3 4377.7 4409.3 4508.9 4537.0 3517.6 3634.1 3637.8 3638.0 3645.9 647.3 655.1 668.0 669.7 680.5 519.5 612.5 626.7 644.1 651.9 8513.2 8806.7 8842.9 8994.2 9030.5 582.6 625.2 625.2 632.3 637.3 3904.8 4305.1 4458.3 4504.2 4515.9 88892.6 118008.0 147863.0 149876.0 160399.0 101744.0 107175.0 109641.0 114520.4 132290.0 113253.0 113622.4 114354.0 114803.0 115488.0 9542.6 9582.7 9681.7 9831.8 9850.6 62688.7 65081.0 65466.0 65588.7 67970.0 82593.0 94569.5 99418.0 101192.5 104771.0 11745.2 12540.6 13464.2 13504.0 14154.8 15222.8 15407.5 15447.1 15612.8 15842.5 13926.3 14108.2 14132.7 14295.3 14416.8 13310.5 13363.9 13401.3 13625.5 13697.0 13840.6 13930.3 14001.5 14186.4 14384.7 11209.6 11545.0 11585.8 11603.1 11808.4 10902.9 11017.9 11404.1 11643.9 11926.8 01:50:15 INFO - PROCESS | 1646 | -------- Summary: end -------- 01:50:15 INFO - PROCESS | 1646 | 01:50:16 INFO - TEST-INFO | 1646: exit 0 01:50:16 INFO - TEST-OK | dromaeo_css | took 1117173ms 01:50:16 INFO - TEST-START | kraken 01:50:16 INFO - operating with platform_type : mac_ 01:50:16 INFO - Initialising browser for kraken test... 01:50:16 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/tmpLQSHF5/profile http://localhost:49272/getInfo.html) 01:50:18 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 01:50:18 INFO - PROCESS | 1655 | colorDepth:24 01:50:18 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 01:50:18 INFO - PROCESS | 1655 | __metrics 01:50:18 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:50:18 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:50:19 INFO - TEST-INFO | 1655: exit 0 01:50:19 INFO - Browser initialized. 01:50:19 INFO - Running cycle 1/1 for kraken test... 01:50:19 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/tmpLQSHF5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:50:31 INFO - PROCESS | 1656 | RSS: Main: 243965952 01:50:31 INFO - PROCESS | 1656 | 01:50:34 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 01:50:35 INFO - PROCESS | 1656 | RSS: Main: 294486016 01:50:35 INFO - PROCESS | 1656 | 01:50:37 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 01:50:38 INFO - PROCESS | 1656 | RSS: Main: 304918528 01:50:38 INFO - PROCESS | 1656 | 01:50:42 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 01:50:42 INFO - PROCESS | 1656 | RSS: Main: 390672384 01:50:42 INFO - PROCESS | 1656 | 01:50:44 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 01:50:45 INFO - PROCESS | 1656 | RSS: Main: 291733504 01:50:45 INFO - PROCESS | 1656 | 01:50:47 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:50:48 INFO - PROCESS | 1656 | RSS: Main: 295399424 01:50:48 INFO - PROCESS | 1656 | 01:50:51 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 01:50:51 INFO - PROCESS | 1656 | RSS: Main: 332664832 01:50:51 INFO - PROCESS | 1656 | 01:50:54 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 01:50:55 INFO - PROCESS | 1656 | RSS: Main: 335020032 01:50:55 INFO - PROCESS | 1656 | 01:50:57 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 01:50:58 INFO - PROCESS | 1656 | RSS: Main: 332984320 01:50:58 INFO - PROCESS | 1656 | 01:51:00 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:51:00 INFO - PROCESS | 1656 | RSS: Main: 312070144 01:51:00 INFO - PROCESS | 1656 | 01:51:02 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:51:03 INFO - PROCESS | 1656 | RSS: Main: 318664704 01:51:03 INFO - PROCESS | 1656 | 01:51:05 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:51:06 INFO - PROCESS | 1656 | RSS: Main: 316284928 01:51:06 INFO - PROCESS | 1656 | 01:51:09 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:51:09 INFO - PROCESS | 1656 | RSS: Main: 326291456 01:51:09 INFO - PROCESS | 1656 | 01:51:12 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:51:13 INFO - PROCESS | 1656 | RSS: Main: 328306688 01:51:13 INFO - PROCESS | 1656 | 01:51:14 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 01:51:15 INFO - PROCESS | 1656 | RSS: Main: 371544064 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - PROCESS | 1656 | __start_tp_report 01:51:15 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 01:51:15 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 01:51:15 INFO - PROCESS | 1656 | |i|pagename|runs| 01:51:15 INFO - PROCESS | 1656 | |0;ai-astar;102;115;112;112;119;169;158;113;112;113 01:51:15 INFO - PROCESS | 1656 | |1;audio-beat-detection;142;108;107;156;108;105;125;98;145;92 01:51:15 INFO - PROCESS | 1656 | |2;audio-dft;181;184;182;184;182;184;183;184;181;183 01:51:15 INFO - PROCESS | 1656 | |3;audio-fft;79;73;58;106;58;57;57;68;105;101 01:51:15 INFO - PROCESS | 1656 | |4;audio-oscillator;82;98;121;97;96;68;96;70;68;99 01:51:15 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;91;87;92;88;91;87;91;88;91;87 01:51:15 INFO - PROCESS | 1656 | |6;imaging-darkroom;95;95;95;96;96;95;96;96;95;95 01:51:15 INFO - PROCESS | 1656 | |7;imaging-desaturate;87;87;85;87;85;87;85;85;87;85 01:51:15 INFO - PROCESS | 1656 | |8;json-parse-financial;56;57;56;57;55;56;53;53;55;55 01:51:15 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;67;76;79;82;71;73;71;71;75;72 01:51:15 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;84;82;93;97;95;79;83;99;101;99 01:51:15 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;136;137;137;132;133;134;136;138;218;138 01:51:15 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;165;164;168;162;162;164;165;163;160;159 01:51:15 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;66;66;66;66;66;66;67;66;66;65 01:51:15 INFO - PROCESS | 1656 | __end_tp_report 01:51:15 INFO - PROCESS | 1656 | __start_cc_report 01:51:15 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2091 01:51:15 INFO - PROCESS | 1656 | __end_cc_report 01:51:15 INFO - PROCESS | 1656 | __startTimestamp1468399875171__endTimestamp 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - PROCESS | 1656 | ------- Summary: start ------- 01:51:15 INFO - PROCESS | 1656 | Number of tests: 14 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:122.50 Median:114.00 stddev:22.17 (19.4%) stddev-sans-first:22.24 01:51:15 INFO - PROCESS | 1656 | Values: 102.0 115.0 112.0 112.0 119.0 169.0 158.0 113.0 112.0 113.0 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:118.60 Median:143.50 stddev:22.01 (15.3%) stddev-sans-first:21.66 01:51:15 INFO - PROCESS | 1656 | Values: 142.0 108.0 107.0 156.0 108.0 105.0 125.0 98.0 145.0 92.0 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.50 stddev:1.23 (0.7%) stddev-sans-first:1.12 01:51:15 INFO - PROCESS | 1656 | Values: 181.0 184.0 182.0 184.0 182.0 184.0 183.0 184.0 181.0 183.0 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:76.20 Median:58.00 stddev:20.60 (35.5%) stddev-sans-first:21.82 01:51:15 INFO - PROCESS | 1656 | Values: 79.0 73.0 58.0 106.0 58.0 57.0 57.0 68.0 105.0 101.0 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:96.00 stddev:17.18 (17.9%) stddev-sans-first:18.01 01:51:15 INFO - PROCESS | 1656 | Values: 82.0 98.0 121.0 97.0 96.0 68.0 96.0 70.0 68.0 99.0 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:89.30 Median:91.00 stddev:2.06 (2.3%) stddev-sans-first:2.09 01:51:15 INFO - PROCESS | 1656 | Values: 91.0 87.0 92.0 88.0 91.0 87.0 91.0 88.0 91.0 87.0 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:51:15 INFO - PROCESS | 1656 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:87.00 stddev:1.05 (1.2%) stddev-sans-first:1.05 01:51:15 INFO - PROCESS | 1656 | Values: 87.0 87.0 85.0 87.0 85.0 87.0 85.0 85.0 87.0 85.0 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:1.42 (2.5%) stddev-sans-first:1.48 01:51:15 INFO - PROCESS | 1656 | Values: 56.0 57.0 56.0 57.0 55.0 56.0 53.0 53.0 55.0 55.0 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:73.70 Median:74.00 stddev:4.40 (5.9%) stddev-sans-first:3.94 01:51:15 INFO - PROCESS | 1656 | Values: 67.0 76.0 79.0 82.0 71.0 73.0 71.0 71.0 75.0 72.0 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:94.00 stddev:8.31 (8.8%) stddev-sans-first:8.40 01:51:15 INFO - PROCESS | 1656 | Values: 84.0 82.0 93.0 97.0 95.0 79.0 83.0 99.0 101.0 99.0 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:137.00 stddev:26.12 (19.1%) stddev-sans-first:27.54 01:51:15 INFO - PROCESS | 1656 | Values: 136.0 137.0 137.0 132.0 133.0 134.0 136.0 138.0 218.0 138.0 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:164.00 stddev:2.62 (1.6%) stddev-sans-first:2.69 01:51:15 INFO - PROCESS | 1656 | Values: 165.0 164.0 168.0 162.0 162.0 164.0 165.0 163.0 160.0 159.0 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 01:51:15 INFO - PROCESS | 1656 | Values: 66.0 66.0 66.0 66.0 66.0 66.0 67.0 66.0 66.0 65.0 01:51:15 INFO - PROCESS | 1656 | -------- Summary: end -------- 01:51:15 INFO - PROCESS | 1656 | 01:51:15 INFO - TEST-INFO | 1656: exit 0 01:51:15 INFO - TEST-OK | kraken | took 59753ms 01:51:15 INFO - SUITE-END | took 1176s 01:51:16 INFO - Completed test suite (00:19:37) 01:51:16 INFO - javascript benchmark 01:51:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2831.617731606233, 3345.163709072733, 3357.5467311912885, 3366.8653253869848, 3408.5739282589675, 5575.581831362654, 5606.971965140179, 5624.409437009116, 5644.407337229588, 5684.772609095637, 5636.0, 5680.573956953224, 5697.974364614368, 5701.173329867167, 5710.543156547476, 5102.489751024896, 5136.409312929005, 5150.510701483353, 5168.992046550924, 5218.6868787872845, 5157.922631160535, 5182.844514664566, 5185.688858668492, 5190.870228244286, 5197.038547868638, 5128.5640720538795, 5148.433672296044, 5151.381834179903, 5165.431802501741, 5186.118359878811, 5198.740062996854, 5223.947760522384, 5227.921581176285, 5228.111221092423, 5289.523942845124, 5052.69683818972, 5066.240063990394, 5068.366454193226, 5160.92258616121, 5162.045021671003, 5591.496765291144, 5640.971795141039, 5658.688772117532, 5685.800996965087, 5693.174489699012, 6207.658578778165, 6218.906716399258, 6224.439800417938, 6226.750929962796, 6236.594621349643, 6068.150458935753, 6170.2904166021035, 6241.625502469821, 6274.247090349188, 6279.0, 4815.4702982672225, 5776.133579962955, 5782.421757824184, 5789.247397838339, 5798.536117110621, 6219.689015549205, 6237.688115594202, 6251.624902505864, 6280.214973128359, 6293.118963345135, 5949.286085669747, 6024.698765061729, 6029.125776762345, 6082.543809214327, 6107.728430436195, 6213.347598502182, 6246.718897649616, 6261.749530018748, 6263.4362907338555, 6268.404501572343, 6107.4197951194565, 6149.723262453201, 6162.969185154046, 6172.290186628506, 6173.81478555635, 6050.878982420327, 6106.084087386838, 6115.113308570232, 6190.845228869314, 6232.376762323732, 4643.442786865598, 4819.638527110481, 4833.9033219335415, 4883.267509873547, 4902.166631672624, 4378.321360189176, 4381.978090109593, 4391.231534481517, 4402.933955990663, 4443.4445694288215, 5694.088945768657, 5718.628289161191, 5727.11229759388, 5732.828015159552, 5780.364159942403, 6116.663583502861, 6122.7550897964475, 6198.783042593487, 6242.687865606701, 6252.6873656317, 5708.286464191976, 5729.140628905698, 5733.996550603628, 5735.053716136874, 5780.219670344533, 5310.92033619496, 5350.732463376816, 5353.544948679328, 5367.597430192673, 5371.409144994048, 6171.475424588871, 6200.782972596027, 6244.781432649836, 6252.718627661675, 6296.590721603081, 6264.718087685974, 6271.686415679106, 6272.059191121369, 6277.686115694106, 6286.5599408041, 6175.289841668266, 6221.4089661482085, 6245.375462453719, 6265.310815810349, 6271.78048768291, 6107.9083813741945, 6109.17526133984, 6111.652512877656, 6132.171952247831, 6145.631262124108, 6200.503959683305, 6222.253329600477, 6222.471089957405, 6236.75052997875, 6243.843903902439, 5871.853203669943, 5921.61509501881, 6043.365446628217, 6075.149479072845, 6086.0, 5898.439648233411, 5945.940540594539, 5971.641701497924, 6027.095935609694, 6040.637561746309, 5708.372079071216, 5868.354481007001, 5901.114832775118, 5910.881782364243, 5923.289205295392, 6056.424639659225, 6069.4840938518955, 6070.605410648293, 6079.392060793885, 6111.236095488064, 5680.886382272414, 5708.372079071381, 5841.0, 5854.677992710272, 5882.647041177372], "value": 5651.695488186107, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.48861672477364, 516.9121249387604, 527.9498447647472, 545.4109561673394, 563.9013172694779, 29511.26221844455, 30307.393852122972, 31599.0, 31736.88920887772, 40655.0, 40812.0, 43765.56234437654, 43829.34255986163, 43861.56138438615, 43862.56137438625, 9646.855297170565, 9831.508424578778, 9838.409695418262, 9838.655647052354, 9840.852387214198, 8671.089535598767, 8837.602307896128, 8842.071582483843, 9738.220942324597, 9865.358751681119, 8842.734717958472, 8918.28653707705, 11691.12316576256, 11861.52553897843, 11951.581694640689, 11864.881351186465, 11932.701682458008, 11940.104492163036, 11941.880581194251, 11999.940000299986, 11757.059435245159, 11811.586594469152, 11826.881731182664, 11854.348010859485, 11866.644000679993, 31743.841280793447, 40494.79752601247, 40888.977775555846, 40990.0, 43139.92150196239, 3662.267546490686, 3675.4854320395166, 3714.962850371489, 4225.302825033866, 4275.358696195595, 31498.37003259922, 31544.842275788473, 31650.208744781336, 32592.02223933286, 32598.0, 3268.509723541464, 3277.705006549398, 3297.934041319184, 3301.1087006508346, 3330.3505816365578, 465596.0, 475234.6238268821, 475908.0, 476072.0, 478515.0, 49817.501824981286, 57277.713611431675, 57591.71204144036, 57890.131648025315, 58327.0, 60980.0, 62000.37999620036, 62104.0, 65774.67112664405, 65842.34157658363, 16149.0, 16330.591735206715, 16345.346186152421, 16351.59121021984, 16373.42693005739, 12715.618531444072, 12790.552330668383, 12796.61610151697, 12808.6797830055, 12812.295323757096, 13670.726585468235, 15459.227038648023, 15498.457553985556, 15499.302531386114, 15550.688986220439, 5389.973050134724, 6324.620522768557, 6346.555741098079, 6361.2048493938255, 6392.776252831129, 923.1138107416821, 972.5769290358717, 1015.9492025398848, 1069.5935544493043, 1071.7749272652675, 27671.723282766914, 30085.398292034035, 30089.24776880552, 30713.0, 30792.84603576968, 1088.031651829872, 1133.240728711765, 1159.930404175752, 1210.3403645013489, 1260.0612543654852, 15106.848931510543, 15575.688486230212, 15847.445339413065, 16260.105694186697, 16356.591085222964, 691669.0, 697660.5116974383, 698000.0, 698977.0, 699935.0, 50538.494615054115, 59233.70383148057, 59316.40683593195, 59514.0, 59560.0, 1407.5636552668705, 1430.4421275702484, 1436.8563143685758, 1437.9065360751517, 1439.8848092152812, 30970.070897873098, 31687.0, 31771.84114079415, 32502.674973249967, 32726.34547308993, 50681.746591266805, 51024.72438189075, 51147.0, 51251.0, 51477.7426112867, 515794.0, 831798.0, 853189.0, 890685.0, 891316.0, 39794.80102599468, 40936.181276374904, 40954.59045409508, 41174.79412602918, 41376.37935430911, 48389.51610483991, 48460.273095902885, 49133.263001055726, 49413.01173976572, 49451.50548494469, 33562.993110206735, 38184.80907595444, 38580.614193858826, 40315.596844031184, 40381.596184037786, 39262.4110638335, 39476.0, 39995.0, 40355.0, 41023.0, 35454.46818297676, 38395.6160438392, 39067.21865562729, 39157.60842391539, 39186.608133919435, 28373.716262837108, 31266.687333126378, 34196.65803341935, 35247.647523524436, 35509.82245088758, 21328.0, 22954.622722636694, 24244.39389015289, 25299.861506231897, 26162.86918565395], "value": 20631.74245030204, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.6074068155487, 352.7654110016839, 357.2569056362766, 381.5192857000179, 385.3833865814696, 15942.521724348273, 18046.909765451186, 20791.54513125824, 20974.790252097475, 21021.789782102176, 21294.680579791315, 21485.57028859422, 22173.667394989046, 22410.879456027174, 22478.438039049033, 5303.734813259341, 5835.503982161521, 6067.332593414721, 6098.695065246742, 6133.417325354084, 5913.793017244398, 5920.4671579557835, 5950.583459157839, 5969.731362088694, 5978.043513037915, 5792.0, 5925.644461332312, 5927.110933360009, 6121.908171377433, 6133.969330153365, 5918.526517878559, 5934.080217566284, 6101.60339577926, 6128.540359473035, 6143.170671959273, 5923.08192230205, 5927.170196172539, 5965.671888046156, 5968.134620480006, 5970.850728731773, 13580.253086080262, 13841.723165536734, 21759.891200543894, 26494.602580961302, 26512.86743566289, 2091.215794077221, 2298.9425264368356, 2375.904963801446, 2608.804339674532, 2676.37105280259, 10091.29360944734, 10120.797584048352, 10222.846657300146, 10571.154307655446, 10620.946895265552, 1914.8946807925558, 1917.712343148525, 1955.735975643284, 1962.5878565501262, 1978.495483651674, 125094.0, 133311.0, 133982.0, 135045.3247733765, 137116.0, 11443.198976071595, 11537.769244615229, 11729.178957473066, 11768.0, 11852.229605075814, 12019.0, 14392.208428536322, 14510.85489145095, 14532.63668408277, 14543.27283635814, 7021.262767409348, 8411.074781774, 8585.871211931826, 8660.95669521661, 8673.0, 8534.829303413897, 8546.914530854736, 8549.658013679507, 8653.480791152551, 8674.86987695185, 4508.278675411918, 4608.953910460919, 4622.722636641813, 4640.234361330343, 4672.766361681903, 1711.9828801711824, 1778.36867911892, 1890.9432717018512, 1933.8936358500137, 1934.912928918174, 384.9049454302561, 386.8994061544019, 423.41568635283727, 807.5719868469721, 889.9065598112105, 9933.403995760278, 12073.87926120745, 12222.877771222174, 12259.325737084368, 12293.323867187391, 428.93565965105483, 439.1743522178284, 441.77027945468177, 444.22704494179897, 445.3208856493808, 6181.289151747516, 6203.0, 6256.249250090018, 6311.116443697886, 6370.140031095835, 583503.0824845849, 584338.0, 586770.0, 625537.0, 629771.0, 86668.0, 127398.36300818437, 141538.0, 149418.0, 151521.0, 438.35342869268214, 445.96655250856315, 446.55790767140945, 448.25142012838637, 978.6574698855486, 19260.32588859383, 19924.50188745293, 20211.292604758764, 20917.163313467292, 21536.569268614854, 59728.0, 60370.698146508985, 60510.39489605048, 61593.07610385938, 62048.37951620426, 61099.861504848894, 81586.59206703928, 86208.56895715481, 86670.0, 86733.13266867503, 7930.9603451982375, 8306.335493160654, 8386.161383861565, 8422.410431269998, 8536.31709463229, 9676.564554595201, 10484.056434920589, 13213.537526186537, 13252.536161234311, 13654.385552650354, 11302.660920172408, 11530.0, 11560.30638161713, 11567.826482602599, 11852.229605075643, 10925.508352124014, 11421.31472111676, 11654.0, 11773.705657358634, 11933.701657458285, 11730.002949749025, 11812.82280765772, 11871.347075910908, 11997.460114295052, 12198.75602487963, 8369.24245908366, 8395.412321137463, 8536.871946920677, 8666.0, 8722.0, 10212.0, 11748.471318790504, 11782.882171178178, 11814.409279536161, 11913.285202887855], "value": 8960.819369801899, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1552.0842702805342, 1587.3650539784085, 1782.896182504645, 1915.0424787606196, 1927.4795805132605, 8526.616302266397, 8788.824223515527, 8947.373683842126, 8953.641854325819, 8981.640734370618, 7880.605969701521, 8121.390895682818, 8498.022727386353, 8756.992945811233, 8767.254783343424, 2358.398608354867, 2383.843835739665, 2390.5457962987066, 2397.3766820626674, 2398.95202095958, 2364.7871691547757, 2371.4664200554826, 2405.3505553500545, 2405.518896220754, 2409.2772168349425, 2103.6739305407687, 2173.989095070792, 2178.4009397415757, 2188.8796116213603, 2383.2969274064194, 2322.1524143687516, 2384.4515761374983, 2386.642003699442, 2396.628522579003, 2401.6877805885297, 2025.574629327843, 2367.4791545860057, 2370.4903445759073, 2377.1442280778906, 2383.9523209535887, 8770.912290877073, 8825.823483530294, 8827.249683776823, 8836.337274704423, 8842.0, 5171.974140129275, 5285.550728188108, 5334.573234141299, 5343.973280133613, 5349.786008559653, 2931.325795067125, 3585.3904836177653, 3630.2376500934834, 3659.1035196376793, 3666.853325866962, 1087.7008822573775, 1101.1136035491427, 1104.6023431564631, 1128.351198061118, 1130.5477808876433, 11478.311301321864, 11535.480903359368, 11543.07655387567, 11549.595764148215, 11552.711182220428, 4505.481869584974, 4586.495485496593, 4753.738544380092, 4756.7145971241835, 4801.615870730333, 9794.314397992215, 9817.754556136153, 9821.312508124363, 9837.262205334486, 9869.555869985868, 4800.879978000508, 5297.576193904479, 5315.6013299002725, 5320.840374788762, 5331.920021199685, 4374.737515749065, 4507.098580283956, 4703.247480403187, 4744.810207591658, 4871.171900776876, 3915.060385507458, 3964.147708242742, 3990.880273591797, 4041.2523683118716, 4075.919881231476, 1268.6783186768191, 1278.8081787731728, 1283.9101262911693, 1289.1362786932777, 1298.078364361314, 651.7067319706151, 788.9329407000355, 810.6676262732251, 881.8721285413579, 992.4789485520015, 5001.149804533238, 6066.181065556182, 6073.635581865102, 6073.969630151821, 6161.0, 928.8746019287445, 931.4923366765129, 965.7199412170391, 971.2958105373548, 1010.8332125199407, 3911.5501717302304, 4023.3562629979065, 4053.351463765783, 4101.938470922939, 4128.8348466061625, 10315.948420258, 10597.0, 10680.51937662807, 10701.83947240792, 10718.142548596094, 10657.467126643636, 10661.0, 10665.84001239982, 10670.786584268271, 10686.946565267279, 7736.845263094707, 7970.242826931432, 7990.64042118106, 8121.79695507617, 8145.266925976691, 6045.063015232646, 6047.637141771508, 6126.264848218242, 6154.5384096192065, 6193.6903154841175, 9698.6120555177, 9917.851232231667, 9942.0, 9942.850857237292, 9977.800443991226, 9538.618455261712, 9862.408255504693, 10219.080282774587, 10262.743431414274, 10267.281290309607, 7524.887126692995, 7569.735059272899, 7650.273224043707, 7659.885101723367, 7678.731244406643, 6970.756023539152, 8137.145599711945, 8145.79635509117, 8242.958785206036, 8278.83442331138, 7186.748463803742, 7204.9639751800905, 7275.490715649854, 7365.963170184329, 7371.152317483558, 7026.332498412643, 7094.361507464353, 7115.146182458138, 7240.637968101679, 7244.927550724636, 7067.57594544329, 7093.716251349888, 7094.4679149062995, 7129.180144283474, 7147.499675022907, 4793.832215872428, 4963.255511673278, 5021.598272138147, 5027.01973115239, 5032.220005899091, 4706.882327941828, 4977.178765503651, 5026.4973502649445, 5088.160453525127, 5166.199239117943], "value": 4579.971513697036, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.83386554327893, 311.954766558849, 314.2708915316466, 319.8992317420014, 322.9418704633165, 5394.244805727197, 5455.781768729256, 5462.426445223254, 5468.976478702885, 5484.287042684456, 4469.7541635210055, 5333.2000199970025, 5394.946050539494, 5418.0, 5427.538659213962, 3822.9426558601645, 3872.419137129425, 3976.8210430530694, 4057.2696914555368, 4088.2028004539125, 3381.3575420670118, 3443.655634436549, 4025.2352053109817, 4100.883328670217, 4151.107511884944, 3622.329868974235, 4054.3918412238254, 4063.796810159495, 4086.2031903778775, 4117.279476091672, 3163.889263875776, 3904.3167445697172, 4013.919721605581, 4083.2650122977852, 4149.958500415018, 3371.9157021074425, 3547.5388199534154, 3554.591222009476, 3598.604153543108, 3634.509341238952, 4431.40176076232, 5233.581313494949, 5241.0, 5262.184361423985, 5262.394824595182, 4497.572730590588, 4589.426321709786, 4704.905901881977, 4709.764511774431, 4724.338592597039, 5622.690752008638, 5650.1242307442, 5673.290838645169, 5678.290213723285, 5679.864027194536, 3633.872814451508, 3774.5470543534675, 3833.290841194388, 3977.8607748728655, 4028.1339512004765, 5503.889922201573, 5655.87904535799, 5739.799107031234, 5997.760089596454, 6022.6687532185715, 3459.290845376692, 4024.6981476389387, 4027.718059735849, 4088.713790034669, 4109.130345692703, 4154.863078375867, 4156.605122513356, 4181.749095054306, 4191.832326706897, 4202.432671589297, 4364.781760911942, 4607.585317321457, 4710.24636058229, 4787.114383839001, 4797.0, 4893.266010098442, 5604.41153678866, 5699.316082070178, 5749.626274292157, 5754.136879468113, 1387.049870838479, 1412.11037046662, 1421.147311613024, 1422.2248874363497, 1430.9212993285469, 781.6521647866645, 819.9262066414051, 837.6774941647387, 871.5053682933799, 902.5261737587819, 4014.5182578090817, 5071.518205770446, 5157.742112894341, 5277.340332458442, 5336.813211537577, 5114.411842638145, 5441.401445840955, 5499.587530935196, 5811.535077193815, 5873.089671100986, 4301.65586753059, 4338.60952514269, 4591.380163677861, 5151.660568252281, 5256.448072952285, 2829.900953466619, 3017.728404443567, 3028.2140430803715, 3084.1981084917634, 3106.5495503151915, 4607.861764147081, 5454.0, 6021.277446706424, 6048.788292409745, 6061.393860613904, 5570.356744760305, 5925.762969481259, 5962.522998160137, 6087.54343424245, 6120.234970628671, 5100.438951715234, 5716.628419152742, 6075.878482430327, 6084.414123997372, 6103.657195417001, 5431.565474762088, 5604.486788567146, 5866.3547009828035, 5924.4667979882015, 5953.945888668402, 5023.723695196799, 5810.912836307543, 5823.388544202798, 5847.8245652630485, 5850.297964244318, 5090.581973562528, 5303.761330740203, 5480.903819236089, 5628.579710724428, 6179.196704428396, 3702.2140789401947, 3890.7276490646514, 3920.5883382244456, 3925.2728799328206, 3938.2517321708783, 5527.839153777591, 5536.584756143225, 5830.708464576839, 5831.504322132666, 5844.766209351578, 5739.540836733135, 5749.281339832521, 5754.856128596819, 5767.913481297868, 5773.278340207474, 5425.972870135624, 5534.418886017072, 5701.572382071278, 5713.457221563945, 5775.191473193672, 5539.390667026704, 5546.4453554644215, 5570.721463926707, 5581.246531718329, 5660.547156227574, 5442.836714898559, 5453.918191227055, 5489.639455034374, 5534.584906132137, 5651.92613403452, 4046.0, 5505.018193450274, 5614.29821272341, 5623.8594035149445, 5640.887182256414], "value": 4151.624306722085, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.6741629185407, 744.4677055905026, 751.6730222353277, 794.9046114466263, 799.2087833045287, 13838.654033649163, 14854.628634284149, 14976.400943962228, 15606.843931560681, 15688.921555392235, 15158.242087895616, 15376.846231537682, 15384.38462461503, 15387.307571159297, 15519.612009699735, 691.0532570378564, 715.0489848501506, 866.9003064647583, 879.4767113567417, 884.4958373726978, 879.5909901895617, 883.1257055515058, 898.4519443139679, 903.6385445821658, 905.4612505559181, 934.2666007184362, 936.494293081735, 936.8173206224789, 937.3953799799125, 940.4404379394249, 738.7119023580781, 759.4835511851938, 762.3596179209491, 764.4228607401432, 933.5239028095687, 683.5044592670324, 704.1128178495081, 705.8235441139715, 709.9254578269259, 710.605613884294, 13109.410076546483, 15669.13819739914, 15682.607934801606, 15722.685546289125, 15728.134952577604, 14415.639609009859, 14551.272436378138, 14588.0, 14595.78106328406, 14647.853521464756, 13133.802992955114, 13403.0, 13449.0, 13491.190528568317, 13877.097988630707, 4551.385562948993, 4681.361523466793, 4854.902901941977, 4859.222524396115, 4905.730184839832, 117698.0, 120390.3980480092, 121427.0, 121694.0, 121827.0, 11033.668989930315, 11222.943885280521, 11545.249558778652, 11621.825672614917, 11809.654404896704, 23410.0, 23419.414514637272, 23431.648525272136, 23437.531249374915, 23464.530709385715, 7781.377489800802, 7787.4548781584745, 8099.757007289791, 8143.714969976022, 8169.142240064826, 4291.29193683045, 4377.671674624352, 4409.250427427345, 4508.887277818081, 4537.001859590885, 3517.577890653138, 3634.109643137448, 3637.8181090945345, 3637.999550123684, 3645.872394466234, 647.3170804800981, 655.0599889159072, 668.0113432120489, 669.7220653428869, 680.5236334565824, 519.5479932458785, 612.4671535763825, 626.6803929995643, 644.1239913717341, 651.850074482862, 8513.233808957224, 8806.691765788295, 8842.867356989651, 8994.235489983294, 9030.503322317205, 582.5863636817907, 625.1643537239449, 625.1747693045137, 632.3234139470815, 637.3339859846471, 3904.824282907219, 4305.138972205571, 4458.286674132123, 4504.24507224069, 4515.88710282239, 88892.5555372219, 118008.0, 147863.0, 149876.0, 160399.0, 101743.98256017345, 107175.0, 109641.0, 114520.42739786248, 132290.0, 113253.0, 113622.43188784004, 114354.0, 114803.0, 115488.0, 9542.618295268112, 9582.712518624452, 9681.66114186, 9831.754206144904, 9850.60597576089, 62688.68655656693, 65081.0, 65466.0, 65588.67205664131, 67970.0, 82593.0, 94569.5271523638, 99418.0, 101192.49403752934, 104771.0, 11745.236559623598, 12540.623781286577, 13464.192148471124, 13503.987200959771, 14154.78767818463, 15222.845262726501, 15407.537773866801, 15447.07317560905, 15612.84387156114, 15842.52472425829, 13926.30368481592, 14108.224047677477, 14132.717345653235, 14295.28523573838, 14416.783748243995, 13310.534131305358, 13363.866361336262, 13401.262930538915, 13625.523106691218, 13697.0, 13840.584782456543, 13930.303484825921, 14001.5099471518, 14186.361613727613, 14384.712305753617, 11209.55161793519, 11545.0, 11585.826212606986, 11603.129765267808, 11808.409579521162, 10902.890971090188, 11017.944910275397, 11404.087672986307, 11643.88356116428, 11926.821097683714], "value": 7967.456140005547, "unit": "score"}], "name": "dromaeo_css", "value": 7355.03621852151, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 112.0, 112.0, 119.0, 169.0, 158.0, 113.0, 112.0, 113.0], "value": 122.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 107.0, 156.0, 108.0, 105.0, 125.0, 98.0, 145.0, 92.0], "value": 118.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 182.0, 184.0, 182.0, 184.0, 183.0, 184.0, 181.0, 183.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 58.0, 106.0, 58.0, 57.0, 57.0, 68.0, 105.0, 101.0], "value": 76.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 98.0, 121.0, 97.0, 96.0, 68.0, 96.0, 70.0, 68.0, 99.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 92.0, 88.0, 91.0, 87.0, 91.0, 88.0, 91.0, 87.0], "value": 89.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 85.0, 87.0, 85.0, 87.0, 85.0, 85.0, 87.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, 55.0, 56.0, 53.0, 53.0, 55.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 76.0, 79.0, 82.0, 71.0, 73.0, 71.0, 71.0, 75.0, 72.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 93.0, 97.0, 95.0, 79.0, 83.0, 99.0, 101.0, 99.0], "value": 91.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 137.0, 132.0, 133.0, 134.0, 136.0, 138.0, 218.0, 138.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 168.0, 162.0, 162.0, 164.0, 165.0, 163.0, 160.0, 159.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1453.6, "alertThreshold": 2.0}]} 01:51:16 INFO - Return code: 0 01:51:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:51:16 INFO - # TBPL SUCCESS # 01:51:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:51:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:51:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:51:16 INFO - 2016-07-13 01:51:16.470 screenresolution[1660:9592] starting screenresolution argv=screenresolution get 01:51:16 INFO - 2016-07-13 01:51:16.473 screenresolution[1660:9592] Display 0: 1600x1200x32@60 01:51:16 INFO - 2016-07-13 01:51:16.479 screenresolution[1661:9595] starting screenresolution argv=screenresolution list 01:51:16 INFO - Available Modes on Display 0 01:51:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:51:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:51:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:51:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:51:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:51:16 INFO - Intel Iris: 01:51:16 INFO - Chipset Model: Intel Iris 01:51:16 INFO - Type: GPU 01:51:16 INFO - Bus: Built-In 01:51:16 INFO - VRAM (Dynamic, Max): 1536 MB 01:51:16 INFO - Vendor: Intel (0x8086) 01:51:16 INFO - Device ID: 0x0a2e 01:51:16 INFO - Revision ID: 0x0009 01:51:16 INFO - Displays: 01:51:16 INFO - Display: 01:51:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:51:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:51:16 INFO - Display Serial Number: 1600x1200 60 01:51:16 INFO - Main Display: Yes 01:51:16 INFO - Mirror: Off 01:51:16 INFO - Online: Yes 01:51:16 INFO - Rotation: Supported 01:51:16 INFO - Return code: 0 01:51:16 INFO - Running post-action listener: _resource_record_post_action 01:51:16 INFO - ##### 01:51:16 INFO - ##### Finished run-tests step (success) 01:51:16 INFO - ##### 01:51:16 INFO - Running post-run listener: _resource_record_post_run 01:51:16 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 36943360; Write bytes: 702279168; Read time: 236; Write time: 1942 01:51:16 INFO - TinderboxPrint: CPU usage
53.8% 01:51:16 INFO - TinderboxPrint: I/O read bytes / time
36,943,360 / 236 01:51:16 INFO - TinderboxPrint: I/O write bytes / time
702,279,168 / 1,942 01:51:16 INFO - TinderboxPrint: CPU idle
2,240.7 (46.2%) 01:51:16 INFO - TinderboxPrint: CPU system
976.5 (20.1%) 01:51:16 INFO - TinderboxPrint: CPU user
1,632.5 (33.7%) 01:51:16 INFO - TinderboxPrint: Swap in / out
443,781,120 / 0 01:51:16 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 408039936; Write bytes: 410076672; Read time: 30605; Write time: 853 01:51:16 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 34346496; Write bytes: 290596864; Read time: 212; Write time: 1079 01:51:17 INFO - Running post-run listener: _upload_blobber_files 01:51:17 INFO - Blob upload gear active. 01:51:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:51:17 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 01:51:17 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:51:17 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:51:17 INFO - (blobuploader) - INFO - Open directory for files ... 01:51:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:51:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:51:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:51:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:51:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:51:19 INFO - (blobuploader) - INFO - Done attempting. 01:51:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:51:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:51:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:51:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:51:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:51:20 INFO - (blobuploader) - INFO - Done attempting. 01:51:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:51:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:51:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:51:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:51:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:51:23 INFO - (blobuploader) - INFO - Done attempting. 01:51:23 INFO - (blobuploader) - INFO - Iteration through files over. 01:51:23 INFO - Return code: 0 01:51:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:51:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:51:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5a57fe08ecd77c17d4c004070ecb0afb4147fb2e820fcb6d50eeb355142dc1e75f3555fcd824264713a6f0dcf31f63e9a963fb829725d3ca3baada0ed2ddca49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/674734f195b81811aa010c78d9a82d9a1c8b059a45566baee96c2a2ade104dab4e69f2e4e43c74576e56a59ba8298fb1261777ca347002a106b16eb61a11623d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3dfbc6b66db9c67d83a9c239621216169ae747a85517e62ab04fa06f177a11305292b4771ff1daa75ed6e142571ca6e3fc9551fbffcfcc0d442a98abb21c8d20"} 01:51:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:51:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:51:23 INFO - Contents: 01:51:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5a57fe08ecd77c17d4c004070ecb0afb4147fb2e820fcb6d50eeb355142dc1e75f3555fcd824264713a6f0dcf31f63e9a963fb829725d3ca3baada0ed2ddca49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/674734f195b81811aa010c78d9a82d9a1c8b059a45566baee96c2a2ade104dab4e69f2e4e43c74576e56a59ba8298fb1261777ca347002a106b16eb61a11623d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3dfbc6b66db9c67d83a9c239621216169ae747a85517e62ab04fa06f177a11305292b4771ff1daa75ed6e142571ca6e3fc9551fbffcfcc0d442a98abb21c8d20"} 01:51:23 INFO - Running post-run listener: copy_logs_to_upload_dir 01:51:23 INFO - Copying logs to upload dir... 01:51:23 INFO - mkdir: /builds/slave/test/build/upload/logs 01:51:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.517650 ========= master_lag: 0.87 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-07-13 01:51:24.080199) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 01:51:24.084198) ========= 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.giLem85af8/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.lPNdA5vCgV/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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/Autoland/sha512/5a57fe08ecd77c17d4c004070ecb0afb4147fb2e820fcb6d50eeb355142dc1e75f3555fcd824264713a6f0dcf31f63e9a963fb829725d3ca3baada0ed2ddca49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/674734f195b81811aa010c78d9a82d9a1c8b059a45566baee96c2a2ade104dab4e69f2e4e43c74576e56a59ba8298fb1261777ca347002a106b16eb61a11623d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3dfbc6b66db9c67d83a9c239621216169ae747a85517e62ab04fa06f177a11305292b4771ff1daa75ed6e142571ca6e3fc9551fbffcfcc0d442a98abb21c8d20"} build_url:https://queue.taskcluster.net/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010950 build_url: 'https://queue.taskcluster.net/v1/task/PIxqd12bTZiUNmLYLvFu1Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5a57fe08ecd77c17d4c004070ecb0afb4147fb2e820fcb6d50eeb355142dc1e75f3555fcd824264713a6f0dcf31f63e9a963fb829725d3ca3baada0ed2ddca49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/674734f195b81811aa010c78d9a82d9a1c8b059a45566baee96c2a2ade104dab4e69f2e4e43c74576e56a59ba8298fb1261777ca347002a106b16eb61a11623d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3dfbc6b66db9c67d83a9c239621216169ae747a85517e62ab04fa06f177a11305292b4771ff1daa75ed6e142571ca6e3fc9551fbffcfcc0d442a98abb21c8d20"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 01:51:24.167117) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 01:51:24.167438) ========= 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.giLem85af8/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.lPNdA5vCgV/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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.005196 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 01:51:24.191834) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 01:51:24.192117) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 01:51:24.192415) ========= ========= Total master_lag: 1.03 =========