builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0348 starttime: 1468242799.45 results: success (0) buildid: 20160711043826 builduid: d424a2d0fa9f48fdb9cbe969dab7c27d revision: 8f80e6e64a015c1b112765bd39a208c962f46824 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 06:13:19.447207) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 06:13:19.447880) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 06:13:19.448380) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 06:13:19.473313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:13:19.473602) ========= 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.MDIHrNvfkE/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.4WTDsZEJKt/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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-11 06:13:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 165M=0s 2016-07-11 06:13:19 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132047 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:13:19.638818) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:13:19.639107) ========= 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.MDIHrNvfkE/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.4WTDsZEJKt/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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.024883 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:13:19.688319) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-11 06:13:19.688701) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8f80e6e64a015c1b112765bd39a208c962f46824 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8f80e6e64a015c1b112765bd39a208c962f46824 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MDIHrNvfkE/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.4WTDsZEJKt/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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-11 06:13:19,771 truncating revision to first 12 chars 2016-07-11 06:13:19,771 Setting DEBUG logging. 2016-07-11 06:13:19,771 attempt 1/10 2016-07-11 06:13:19,772 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8f80e6e64a01?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 06:13:21,848 unpacking tar archive at: fx-team-8f80e6e64a01/testing/mozharness/ program finished with exit code 0 elapsedTime=2.352878 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-11 06:13:22.064240) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 06:13:22.064563) ========= script_repo_revision: 8f80e6e64a015c1b112765bd39a208c962f46824 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 06:13:22.064937) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 06:13:22.065214) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 06:13:22.085574) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-11 06:13:22.086091) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MDIHrNvfkE/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.4WTDsZEJKt/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 06:13:22 INFO - MultiFileLogger online at 20160711 06:13:22 in /builds/slave/test 06:13:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:13:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:13:22 INFO - {'append_to_log': False, 06:13:22 INFO - 'base_work_dir': '/builds/slave/test', 06:13:22 INFO - 'blob_upload_branch': 'Fx-Team', 06:13:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:13:22 INFO - 'branch': 'Fx-Team', 06:13:22 INFO - 'buildbot_json_path': 'buildprops.json', 06:13:22 INFO - 'config_files': ('talos/mac_config.py',), 06:13:22 INFO - 'default_actions': ('clobber', 06:13:22 INFO - 'read-buildbot-config', 06:13:22 INFO - 'download-and-extract', 06:13:22 INFO - 'populate-webroot', 06:13:22 INFO - 'create-virtualenv', 06:13:22 INFO - 'install', 06:13:22 INFO - 'run-tests'), 06:13:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:13:22 INFO - 'download_minidump_stackwalk': True, 06:13:22 INFO - 'download_symbols': 'ondemand', 06:13:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:13:22 INFO - 'tooltool.py': '/tools/tooltool.py', 06:13:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:13:22 INFO - '/tools/misc-python/virtualenv.py')}, 06:13:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:13:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:13:22 INFO - 'installer_path': 'installer.exe', 06:13:22 INFO - 'log_level': 'info', 06:13:22 INFO - 'log_name': 'talos', 06:13:22 INFO - 'log_to_console': True, 06:13:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:13:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:13:22 INFO - 'opt_config_files': (), 06:13:22 INFO - 'pip_index': False, 06:13:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:13:22 INFO - 'cmd': ('bash', 06:13:22 INFO - '-c', 06:13:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:13:22 INFO - 'enabled': True, 06:13:22 INFO - 'halt_on_failure': False, 06:13:22 INFO - 'name': 'check_screen_resolution'},), 06:13:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:13:22 INFO - 'cmd': ('bash', 06:13:22 INFO - '-c', 06:13:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:13:22 INFO - 'enabled': True, 06:13:22 INFO - 'halt_on_failure': False, 06:13:22 INFO - 'name': 'check_screen_resolution'},), 06:13:22 INFO - 'run_cmd_checks_enabled': True, 06:13:22 INFO - 'sps_profile': False, 06:13:22 INFO - 'sps_profile_interval': 0, 06:13:22 INFO - 'suite': 'dromaeojs', 06:13:22 INFO - 'system_bits': '32', 06:13:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:13:22 INFO - 'title': 't-yosemite-r7-0348', 06:13:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:13:22 INFO - 'use_talos_json': True, 06:13:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:13:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:13:22 INFO - 'work_dir': 'build'} 06:13:22 INFO - ##### 06:13:22 INFO - ##### Running clobber step. 06:13:22 INFO - ##### 06:13:22 INFO - Running pre-action listener: _resource_record_pre_action 06:13:22 INFO - Running main action method: clobber 06:13:22 INFO - rmtree: /builds/slave/test/build 06:13:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:13:24 INFO - Running post-action listener: _resource_record_post_action 06:13:24 INFO - ##### 06:13:24 INFO - ##### Finished clobber step (success) 06:13:24 INFO - ##### 06:13:24 INFO - ##### 06:13:24 INFO - ##### Running read-buildbot-config step. 06:13:24 INFO - ##### 06:13:24 INFO - Running pre-action listener: _resource_record_pre_action 06:13:24 INFO - Running main action method: read_buildbot_config 06:13:24 INFO - Using buildbot properties: 06:13:24 INFO - { 06:13:24 INFO - "project": "", 06:13:24 INFO - "product": "firefox", 06:13:24 INFO - "script_repo_revision": "production", 06:13:24 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:13:24 INFO - "repository": "", 06:13:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:13:24 INFO - "buildid": "20160711043826", 06:13:24 INFO - "pgo_build": "False", 06:13:24 INFO - "basedir": "/builds/slave/test", 06:13:24 INFO - "buildnumber": 797, 06:13:24 INFO - "slavename": "t-yosemite-r7-0348", 06:13:24 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:13:24 INFO - "platform": "yosemite_r7", 06:13:24 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:13:24 INFO - "branch": "fx-team", 06:13:24 INFO - "repo_path": "integration/fx-team", 06:13:24 INFO - "revision": "8f80e6e64a015c1b112765bd39a208c962f46824", 06:13:24 INFO - "stage_platform": "macosx64", 06:13:24 INFO - "builduid": "d424a2d0fa9f48fdb9cbe969dab7c27d", 06:13:24 INFO - "slavebuilddir": "test" 06:13:24 INFO - } 06:13:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 06:13:24 INFO - Running post-action listener: _resource_record_post_action 06:13:24 INFO - ##### 06:13:24 INFO - ##### Finished read-buildbot-config step (success) 06:13:24 INFO - ##### 06:13:24 INFO - ##### 06:13:24 INFO - ##### Running download-and-extract step. 06:13:24 INFO - ##### 06:13:24 INFO - Running pre-action listener: _resource_record_pre_action 06:13:24 INFO - Running main action method: download_and_extract 06:13:24 INFO - mkdir: /builds/slave/test/build/tests 06:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:13:24 INFO - https://queue.taskcluster.net/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:13:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 06:13:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 06:13:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/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 06:13:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/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 06:13:25 INFO - Downloaded 1199 bytes. 06:13:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 06:13:25 INFO - Using the following test package requirements: 06:13:25 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 06:13:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:13:25 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 06:13:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:13:25 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 06:13:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:13:25 INFO - u'jsshell-mac.zip'], 06:13:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:13:25 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 06:13:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 06:13:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:13:25 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 06:13:25 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:13:25 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 06:13:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:13:25 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 06:13:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:13:25 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 06:13:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:13:25 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')]} 06:13:25 INFO - https://queue.taskcluster.net/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:13:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:13:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:13:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/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 06:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/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 06:13:27 INFO - Downloaded 18806840 bytes. 06:13:27 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'] 06:13:27 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 06:13:30 INFO - Return code: 0 06:13:30 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 06:13:30 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')]} 06:13:30 INFO - https://queue.taskcluster.net/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:13:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:13:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:13:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/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 06:13:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/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 06:13:31 INFO - Downloaded 18806840 bytes. 06:13:31 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'] 06:13:31 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 06:13:34 INFO - Return code: 0 06:13:34 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')]} 06:13:34 INFO - https://queue.taskcluster.net/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:13:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:13:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:13:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/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 06:13:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/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 06:13:35 INFO - Downloaded 14403333 bytes. 06:13:35 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'] 06:13:35 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 06:13:35 INFO - Return code: 0 06:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:13:35 INFO - https://queue.taskcluster.net/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:13:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:13:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:13:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 06:13:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/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 06:13:39 INFO - Downloaded 112356388 bytes. 06:13:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:13:39 INFO - mkdir: /builds/slave/test/properties 06:13:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:13:39 INFO - Writing to file /builds/slave/test/properties/build_url 06:13:39 INFO - Contents: 06:13:39 INFO - build_url:https://queue.taskcluster.net/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:13:40 INFO - Running post-action listener: _resource_record_post_action 06:13:40 INFO - Running post-action listener: set_extra_try_arguments 06:13:40 INFO - ##### 06:13:40 INFO - ##### Finished download-and-extract step (success) 06:13:40 INFO - ##### 06:13:40 INFO - ##### 06:13:40 INFO - ##### Running populate-webroot step. 06:13:40 INFO - ##### 06:13:40 INFO - Running pre-action listener: _resource_record_pre_action 06:13:40 INFO - Running main action method: populate_webroot 06:13:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:13:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:13:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:13:40 INFO - '--tppagecycles', 06:13:40 INFO - '7'], 06:13:40 INFO - 'tests': ['tsvgm']}}, 06:13:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:13:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:13:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:13:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:13:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:13:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:13:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:40 INFO - 'talos_options': ['--disable-e10s'], 06:13:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:13:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:13:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:40 INFO - 'talos_options': ['--disable-e10s'], 06:13:40 INFO - 'tests': ['damp', 'tps']}, 06:13:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:40 INFO - 'tests': ['damp', 'tps']}, 06:13:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:13:40 INFO - 'tests': ['dromaeo_dom']}, 06:13:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:13:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:13:40 INFO - 'tests': ['basic_compositor_video']}, 06:13:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:13:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:13:40 INFO - 'tests': ['a11yr', 06:13:40 INFO - 'ts_paint', 06:13:40 INFO - 'tpaint', 06:13:40 INFO - 'sessionrestore', 06:13:40 INFO - 'sessionrestore_no_auto_restore', 06:13:40 INFO - 'tabpaint']}, 06:13:40 INFO - 'other-e10s': {'tests': ['a11yr', 06:13:40 INFO - 'ts_paint', 06:13:40 INFO - 'tpaint', 06:13:40 INFO - 'sessionrestore', 06:13:40 INFO - 'sessionrestore_no_auto_restore', 06:13:40 INFO - 'tabpaint']}, 06:13:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:13:40 INFO - 'ts_paint', 06:13:40 INFO - 'tpaint', 06:13:40 INFO - 'sessionrestore', 06:13:40 INFO - 'sessionrestore_no_auto_restore', 06:13:40 INFO - 'tabpaint']}, 06:13:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:13:40 INFO - 'ts_paint', 06:13:40 INFO - 'tpaint', 06:13:40 INFO - 'sessionrestore', 06:13:40 INFO - 'sessionrestore_no_auto_restore', 06:13:40 INFO - 'tabpaint']}, 06:13:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:13:40 INFO - 'tests': ['a11yr', 06:13:40 INFO - 'ts_paint', 06:13:40 INFO - 'tpaint', 06:13:40 INFO - 'sessionrestore', 06:13:40 INFO - 'sessionrestore_no_auto_restore', 06:13:40 INFO - 'tabpaint']}, 06:13:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:13:40 INFO - 'tests': ['a11yr', 06:13:40 INFO - 'ts_paint', 06:13:40 INFO - 'tpaint', 06:13:40 INFO - 'sessionrestore', 06:13:40 INFO - 'sessionrestore_no_auto_restore', 06:13:40 INFO - 'tabpaint']}, 06:13:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:13:40 INFO - 'tests': ['tsvgx', 06:13:40 INFO - 'tsvgr_opacity', 06:13:40 INFO - 'tart', 06:13:40 INFO - 'tscrollx', 06:13:40 INFO - 'cart']}, 06:13:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:13:40 INFO - 'tsvgr_opacity', 06:13:40 INFO - 'tart', 06:13:40 INFO - 'tscrollx', 06:13:40 INFO - 'cart']}, 06:13:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:40 INFO - 'talos_options': ['--disable-e10s'], 06:13:40 INFO - 'tests': ['tp5o']}, 06:13:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:40 INFO - 'tests': ['tp5o']}, 06:13:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:40 INFO - 'talos_options': ['--disable-e10s', 06:13:40 INFO - '--xperf_path', 06:13:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:13:40 INFO - 'tests': ['tp5n']}, 06:13:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:40 INFO - 'talos_options': ['--xperf_path', 06:13:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:13:40 INFO - 'tests': ['tp5n']}}, 06:13:40 INFO - 'talos.zip': {'path': '', 06:13:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:13:40 INFO - Running post-action listener: _resource_record_post_action 06:13:40 INFO - ##### 06:13:40 INFO - ##### Finished populate-webroot step (success) 06:13:40 INFO - ##### 06:13:40 INFO - ##### 06:13:40 INFO - ##### Running create-virtualenv step. 06:13:40 INFO - ##### 06:13:40 INFO - Running pre-action listener: _resource_record_pre_action 06:13:40 INFO - Running main action method: create_virtualenv 06:13:40 INFO - Creating virtualenv /builds/slave/test/build/venv 06:13:40 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 06:13:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:13:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:13:40 INFO - Using real prefix '/tools/python27' 06:13:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:13:41 INFO - Installing distribute.............................................................................................................................................................................................done. 06:13:44 INFO - Installing pip.................done. 06:13:44 INFO - Return code: 0 06:13:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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')]} 06:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107261a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd14259d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c5d30>, '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 0x106f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071bdb20>, '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.MDIHrNvfkE/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.4WTDsZEJKt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 06:13: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', 'pip>=1.5'] in /builds/slave/test/build 06:13: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 pip>=1.5 06:13:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MDIHrNvfkE/Render', 06:13:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:44 INFO - 'HOME': '/Users/cltbld', 06:13:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:44 INFO - 'LOGNAME': 'cltbld', 06:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:44 INFO - 'MOZ_NO_REMOTE': '1', 06:13:44 INFO - 'NO_EM_RESTART': '1', 06:13:44 INFO - 'PAGER': '/bin/cat', 06:13:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:44 INFO - 'PWD': '/builds/slave/test', 06:13:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:44 INFO - 'SHELL': '/bin/bash', 06:13:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4WTDsZEJKt/Listeners', 06:13:44 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 06:13:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:44 INFO - 'USER': 'cltbld', 06:13:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:44 INFO - 'XPC_FLAGS': '0x0', 06:13:44 INFO - 'XPC_SERVICE_NAME': '0', 06:13:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:44 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 06:13:44 INFO - Cleaning up... 06:13:44 INFO - Return code: 0 06:13:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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')]} 06:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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', '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 0x107261a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd14259d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c5d30>, '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 0x106f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071bdb20>, '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.MDIHrNvfkE/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.4WTDsZEJKt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 06:13: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', 'psutil>=3.1.1'] in /builds/slave/test/build 06:13: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 psutil>=3.1.1 06:13:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MDIHrNvfkE/Render', 06:13:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:44 INFO - 'HOME': '/Users/cltbld', 06:13:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:44 INFO - 'LOGNAME': 'cltbld', 06:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:44 INFO - 'MOZ_NO_REMOTE': '1', 06:13:44 INFO - 'NO_EM_RESTART': '1', 06:13:44 INFO - 'PAGER': '/bin/cat', 06:13:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:44 INFO - 'PWD': '/builds/slave/test', 06:13:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:44 INFO - 'SHELL': '/bin/bash', 06:13:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4WTDsZEJKt/Listeners', 06:13:44 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 06:13:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:44 INFO - 'USER': 'cltbld', 06:13:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:44 INFO - 'XPC_FLAGS': '0x0', 06:13:44 INFO - 'XPC_SERVICE_NAME': '0', 06:13:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:44 INFO - Downloading/unpacking psutil>=3.1.1 06:13: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 06:13: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 06:13: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 06:13: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 06:13: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 06:13: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 06:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:13:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:13:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:13:47 INFO - Installing collected packages: psutil 06:13:47 INFO - Running setup.py install for psutil 06:13:47 INFO - building 'psutil._psutil_osx' extension 06:13:47 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 06:13:48 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 06:13:48 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 06:13:48 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 06:13:48 INFO - building 'psutil._psutil_posix' extension 06:13:48 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 06:13:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:13:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:13:48 INFO - ^ 06:13:48 INFO - 1 warning generated. 06:13:48 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 06:13:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:13:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:13:48 INFO - Successfully installed psutil 06:13:48 INFO - Cleaning up... 06:13:48 INFO - Return code: 0 06:13:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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')]} 06:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107261a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd14259d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c5d30>, '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 0x106f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071bdb20>, '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.MDIHrNvfkE/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.4WTDsZEJKt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 06:13: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:13: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 mozsystemmonitor==0.3 06:13:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MDIHrNvfkE/Render', 06:13:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:48 INFO - 'HOME': '/Users/cltbld', 06:13:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:48 INFO - 'LOGNAME': 'cltbld', 06:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:48 INFO - 'MOZ_NO_REMOTE': '1', 06:13:48 INFO - 'NO_EM_RESTART': '1', 06:13:48 INFO - 'PAGER': '/bin/cat', 06:13:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:48 INFO - 'PWD': '/builds/slave/test', 06:13:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:48 INFO - 'SHELL': '/bin/bash', 06:13:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4WTDsZEJKt/Listeners', 06:13:48 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 06:13:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:48 INFO - 'USER': 'cltbld', 06:13:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:48 INFO - 'XPC_FLAGS': '0x0', 06:13:48 INFO - 'XPC_SERVICE_NAME': '0', 06:13:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:13:49 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 06:13:49 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 06:13:49 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 06:13:49 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 06:13:49 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 06:13:49 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 06:13:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:13:51 INFO - Installing collected packages: mozsystemmonitor 06:13:51 INFO - Running setup.py install for mozsystemmonitor 06:13:51 INFO - Successfully installed mozsystemmonitor 06:13:51 INFO - Cleaning up... 06:13:51 INFO - Return code: 0 06:13:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:51 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 0x107261a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd14259d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c5d30>, '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 0x106f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071bdb20>, '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.MDIHrNvfkE/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.4WTDsZEJKt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 06:13:51 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 06:13:51 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 06:13:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MDIHrNvfkE/Render', 06:13:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:51 INFO - 'HOME': '/Users/cltbld', 06:13:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:51 INFO - 'LOGNAME': 'cltbld', 06:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:51 INFO - 'MOZ_NO_REMOTE': '1', 06:13:51 INFO - 'NO_EM_RESTART': '1', 06:13:51 INFO - 'PAGER': '/bin/cat', 06:13:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:51 INFO - 'PWD': '/builds/slave/test', 06:13:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:51 INFO - 'SHELL': '/bin/bash', 06:13:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4WTDsZEJKt/Listeners', 06:13:51 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 06:13:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:51 INFO - 'USER': 'cltbld', 06:13:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:51 INFO - 'XPC_FLAGS': '0x0', 06:13:51 INFO - 'XPC_SERVICE_NAME': '0', 06:13:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:52 INFO - Downloading/unpacking jsonschema==2.5.1 06:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:13:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:13:54 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 06:13:54 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 06:13:54 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 06:13:54 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 06:13:54 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 06:13:54 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 06:13:55 INFO - Downloading functools32-3.2.3-2.tar.gz 06:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:13:55 INFO - warning: no files found matching '*.txt' 06:13:55 INFO - no previously-included directories found matching 'build' 06:13:55 INFO - no previously-included directories found matching 'dist' 06:13:55 INFO - no previously-included directories found matching '.git*' 06:13:55 INFO - Installing collected packages: jsonschema, functools32 06:13:55 INFO - Running setup.py install for functools32 06:13:55 INFO - warning: no files found matching '*.txt' 06:13:55 INFO - no previously-included directories found matching 'build' 06:13:55 INFO - no previously-included directories found matching 'dist' 06:13:55 INFO - no previously-included directories found matching '.git*' 06:13:55 INFO - Successfully installed jsonschema functools32 06:13:55 INFO - Cleaning up... 06:13:55 INFO - Return code: 0 06:13:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107261a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd14259d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c5d30>, '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 0x106f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071bdb20>, '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.MDIHrNvfkE/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.4WTDsZEJKt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 06:13:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:13:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MDIHrNvfkE/Render', 06:13:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:55 INFO - 'HOME': '/Users/cltbld', 06:13:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:55 INFO - 'LOGNAME': 'cltbld', 06:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:55 INFO - 'MOZ_NO_REMOTE': '1', 06:13:55 INFO - 'NO_EM_RESTART': '1', 06:13:55 INFO - 'PAGER': '/bin/cat', 06:13:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:55 INFO - 'PWD': '/builds/slave/test', 06:13:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:55 INFO - 'SHELL': '/bin/bash', 06:13:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4WTDsZEJKt/Listeners', 06:13:55 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 06:13:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:55 INFO - 'USER': 'cltbld', 06:13:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:55 INFO - 'XPC_FLAGS': '0x0', 06:13:55 INFO - 'XPC_SERVICE_NAME': '0', 06:13:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:55 INFO - Downloading/unpacking blobuploader==1.2.4 06:13:55 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 06:13:55 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 06:13:55 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 06:13:55 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 06:13:55 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 06:13:55 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 06:13:58 INFO - Downloading blobuploader-1.2.4.tar.gz 06:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:13:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:13:58 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 06:13:58 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 06:13:58 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 06:13:58 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 06:13:58 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 06:13:58 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 06:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:13:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:13: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 06:13: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 06:13: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 06:13: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 06:13: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 06:13: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 06:13:59 INFO - Downloading docopt-0.6.1.tar.gz 06:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:13:59 INFO - Installing collected packages: blobuploader, requests, docopt 06:13:59 INFO - Running setup.py install for blobuploader 06:13:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:13:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:13:59 INFO - Running setup.py install for requests 06:14:00 INFO - Running setup.py install for docopt 06:14:00 INFO - Successfully installed blobuploader requests docopt 06:14:00 INFO - Cleaning up... 06:14:00 INFO - Return code: 0 06:14:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:00 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')]} 06:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:00 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')]} 06:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:00 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 0x107261a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd14259d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c5d30>, '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 0x106f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071bdb20>, '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.MDIHrNvfkE/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.4WTDsZEJKt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 06:14:00 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 06:14:00 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 06:14:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MDIHrNvfkE/Render', 06:14:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:00 INFO - 'HOME': '/Users/cltbld', 06:14:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:00 INFO - 'LOGNAME': 'cltbld', 06:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:00 INFO - 'MOZ_NO_REMOTE': '1', 06:14:00 INFO - 'NO_EM_RESTART': '1', 06:14:00 INFO - 'PAGER': '/bin/cat', 06:14:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:00 INFO - 'PWD': '/builds/slave/test', 06:14:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:00 INFO - 'SHELL': '/bin/bash', 06:14:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4WTDsZEJKt/Listeners', 06:14:00 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 06:14:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:00 INFO - 'USER': 'cltbld', 06:14:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:00 INFO - 'XPC_FLAGS': '0x0', 06:14:00 INFO - 'XPC_SERVICE_NAME': '0', 06:14:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:00 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-cmLKSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:00 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-JSqDsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:01 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-e5C0S1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:01 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-UT3tMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:01 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-2DpIW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:01 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-uyB_a7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:01 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-eZBE8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:01 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-i67Djs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:01 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-pjUzLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:01 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-yCgoyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:01 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-qVGhmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:02 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-bcL4eJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:02 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-Vxw1qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:02 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-G8bNIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:02 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-FOVoTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:02 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-xpOgmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:02 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-isx2Hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:14:02 INFO - Running setup.py install for manifestparser 06:14:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:14:02 INFO - Running setup.py install for mozcrash 06:14:02 INFO - Running setup.py install for mozdebug 06:14:03 INFO - Running setup.py install for mozdevice 06:14:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:14:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:14:03 INFO - Running setup.py install for mozfile 06:14:03 INFO - Running setup.py install for mozhttpd 06:14:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:14:03 INFO - Running setup.py install for mozinfo 06:14:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:14:03 INFO - Running setup.py install for mozInstall 06:14:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:14:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:14:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:14:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:14:03 INFO - Running setup.py install for mozleak 06:14:03 INFO - Running setup.py install for mozlog 06:14:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:14:04 INFO - Running setup.py install for moznetwork 06:14:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:14:04 INFO - Running setup.py install for mozprocess 06:14:04 INFO - Running setup.py install for mozprofile 06:14:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:14:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:14:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:14:04 INFO - Running setup.py install for mozrunner 06:14:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:14:04 INFO - Running setup.py install for mozscreenshot 06:14:04 INFO - Running setup.py install for moztest 06:14:05 INFO - Running setup.py install for mozversion 06:14:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:14:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:14:05 INFO - Cleaning up... 06:14:05 INFO - Return code: 0 06:14:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:05 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 0x107261a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd14259d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c5d30>, '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 0x106f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071bdb20>, '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.MDIHrNvfkE/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.4WTDsZEJKt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 06:14:05 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 06:14:05 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 06:14:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MDIHrNvfkE/Render', 06:14:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:05 INFO - 'HOME': '/Users/cltbld', 06:14:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:05 INFO - 'LOGNAME': 'cltbld', 06:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:05 INFO - 'MOZ_NO_REMOTE': '1', 06:14:05 INFO - 'NO_EM_RESTART': '1', 06:14:05 INFO - 'PAGER': '/bin/cat', 06:14:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:05 INFO - 'PWD': '/builds/slave/test', 06:14:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:05 INFO - 'SHELL': '/bin/bash', 06:14:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4WTDsZEJKt/Listeners', 06:14:05 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 06:14:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:05 INFO - 'USER': 'cltbld', 06:14:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:05 INFO - 'XPC_FLAGS': '0x0', 06:14:05 INFO - 'XPC_SERVICE_NAME': '0', 06:14:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:05 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-BayT5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:05 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)) 06:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:05 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-hzY6DF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:05 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)) 06:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:05 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-ZyCYot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:05 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)) 06:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:05 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-Ma6s6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:05 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)) 06:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:05 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-tanLdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:06 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)) 06:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:06 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-kAEoiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:06 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)) 06:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:06 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-C2LXgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:06 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)) 06:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:06 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-9DbVOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:06 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)) 06:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:06 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-V3TtHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:06 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)) 06:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:06 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-AoiOVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:06 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)) 06:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:06 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-aLeOjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:06 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)) 06:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:06 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-CJ1xOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:06 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)) 06:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:06 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-wk5xWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:06 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)) 06:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:06 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-KDEDzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:06 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)) 06:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:06 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-Ot9_29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:07 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)) 06:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:07 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-G6nyVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:07 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)) 06:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:07 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-GTODyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:07 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)) 06:14:07 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)) 06:14:07 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)) 06:14:07 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)) 06:14:07 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)) 06:14:07 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)) 06:14:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:14:07 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 06:14:07 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 06:14:07 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 06:14:07 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 06:14:07 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 06:14:07 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 06:14:14 INFO - Downloading blessings-1.6.tar.gz 06:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:14:14 INFO - Installing collected packages: blessings 06:14:14 INFO - Running setup.py install for blessings 06:14:14 INFO - Successfully installed blessings 06:14:14 INFO - Cleaning up... 06:14:14 INFO - Return code: 0 06:14:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:14:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:14:15 INFO - Reading from file tmpfile_stdout 06:14:15 INFO - Current package versions: 06:14:15 INFO - blessings == 1.6 06:14:15 INFO - blobuploader == 1.2.4 06:14:15 INFO - docopt == 0.6.1 06:14:15 INFO - functools32 == 3.2.3-2 06:14:15 INFO - jsonschema == 2.5.1 06:14:15 INFO - manifestparser == 1.1 06:14:15 INFO - mozInstall == 1.12 06:14:15 INFO - mozcrash == 0.17 06:14:15 INFO - mozdebug == 0.1 06:14:15 INFO - mozdevice == 0.48 06:14:15 INFO - mozfile == 1.2 06:14:15 INFO - mozhttpd == 0.7 06:14:15 INFO - mozinfo == 0.9 06:14:15 INFO - mozleak == 0.1 06:14:15 INFO - mozlog == 3.2 06:14:15 INFO - moznetwork == 0.27 06:14:15 INFO - mozprocess == 0.23 06:14:15 INFO - mozprofile == 0.28 06:14:15 INFO - mozrunner == 6.12 06:14:15 INFO - mozscreenshot == 0.1 06:14:15 INFO - mozsystemmonitor == 0.3 06:14:15 INFO - moztest == 0.7 06:14:15 INFO - mozversion == 1.4 06:14:15 INFO - psutil == 3.1.1 06:14:15 INFO - requests == 1.2.3 06:14:15 INFO - wsgiref == 0.1.2 06:14:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:15 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 0x107261a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd14259d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c5d30>, '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 0x106f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071bdb20>, '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.MDIHrNvfkE/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.4WTDsZEJKt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 06:14:15 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 06:14:15 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 06:14:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MDIHrNvfkE/Render', 06:14:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:15 INFO - 'HOME': '/Users/cltbld', 06:14:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:15 INFO - 'LOGNAME': 'cltbld', 06:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:15 INFO - 'MOZ_NO_REMOTE': '1', 06:14:15 INFO - 'NO_EM_RESTART': '1', 06:14:15 INFO - 'PAGER': '/bin/cat', 06:14:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:15 INFO - 'PWD': '/builds/slave/test', 06:14:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:15 INFO - 'SHELL': '/bin/bash', 06:14:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4WTDsZEJKt/Listeners', 06:14:15 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 06:14:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:15 INFO - 'USER': 'cltbld', 06:14:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:15 INFO - 'XPC_FLAGS': '0x0', 06:14:15 INFO - 'XPC_SERVICE_NAME': '0', 06:14:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:15 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)) 06:14:15 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)) 06:14:15 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)) 06:14:15 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)) 06:14:15 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)) 06:14:15 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)) 06:14:15 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)) 06:14:15 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)) 06:14:15 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)) 06:14:15 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)) 06:14:15 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)) 06:14:15 INFO - Cleaning up... 06:14:15 INFO - Return code: 0 06:14:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107261a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd14259d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c5d30>, '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 0x106f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071bdb20>, '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.MDIHrNvfkE/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.4WTDsZEJKt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 06:14:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:14:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MDIHrNvfkE/Render', 06:14:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:15 INFO - 'HOME': '/Users/cltbld', 06:14:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:15 INFO - 'LOGNAME': 'cltbld', 06:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:15 INFO - 'MOZ_NO_REMOTE': '1', 06:14:15 INFO - 'NO_EM_RESTART': '1', 06:14:15 INFO - 'PAGER': '/bin/cat', 06:14:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:15 INFO - 'PWD': '/builds/slave/test', 06:14:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:15 INFO - 'SHELL': '/bin/bash', 06:14:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4WTDsZEJKt/Listeners', 06:14:15 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 06:14:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:15 INFO - 'USER': 'cltbld', 06:14:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:15 INFO - 'XPC_FLAGS': '0x0', 06:14:15 INFO - 'XPC_SERVICE_NAME': '0', 06:14:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:14:16 INFO - Cleaning up... 06:14:16 INFO - Return code: 0 06:14:16 INFO - Running post-action listener: _resource_record_post_action 06:14:16 INFO - Running post-action listener: _start_resource_monitoring 06:14:16 INFO - Starting resource monitoring. 06:14:16 INFO - ##### 06:14:16 INFO - ##### Finished create-virtualenv step (success) 06:14:16 INFO - ##### 06:14:16 INFO - ##### 06:14:16 INFO - ##### Running install step. 06:14:16 INFO - ##### 06:14:16 INFO - Running pre-action listener: _resource_record_pre_action 06:14:16 INFO - Running main action method: install 06:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:14:16 INFO - Reading from file tmpfile_stdout 06:14:16 INFO - Detecting whether we're running mozinstall >=1.0... 06:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:14:16 INFO - Reading from file tmpfile_stdout 06:14:16 INFO - Output received: 06:14:16 INFO - Usage: mozinstall [options] installer 06:14:16 INFO - Options: 06:14:16 INFO - -h, --help show this help message and exit 06:14:16 INFO - -d DEST, --destination=DEST 06:14:16 INFO - Directory to install application into. [default: 06:14:16 INFO - "/builds/slave/test"] 06:14:16 INFO - --app=APP Application being installed. [default: firefox] 06:14:16 INFO - mkdir: /builds/slave/test/build/application 06:14:16 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'] 06:14:16 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 06:14:51 INFO - Reading from file tmpfile_stdout 06:14:51 INFO - Output received: 06:14:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:14:51 INFO - Running post-action listener: _resource_record_post_action 06:14:51 INFO - ##### 06:14:51 INFO - ##### Finished install step (success) 06:14:51 INFO - ##### 06:14:51 INFO - ##### 06:14:51 INFO - ##### Running run-tests step. 06:14:51 INFO - ##### 06:14:51 INFO - Running pre-action listener: _resource_record_pre_action 06:14:51 INFO - Running main action method: run_tests 06:14:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:14:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:14:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:14:51 INFO - 2016-07-11 06:14:51.017 screenresolution[1642:7670] starting screenresolution argv=screenresolution get 06:14:51 INFO - 2016-07-11 06:14:51.019 screenresolution[1642:7670] Display 0: 1600x1200x32@60 06:14:51 INFO - 2016-07-11 06:14:51.026 screenresolution[1643:7672] starting screenresolution argv=screenresolution list 06:14:51 INFO - Available Modes on Display 0 06:14:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:14:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:14:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:14:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:14:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:14:51 INFO - Intel Iris: 06:14:51 INFO - Chipset Model: Intel Iris 06:14:51 INFO - Type: GPU 06:14:51 INFO - Bus: Built-In 06:14:51 INFO - VRAM (Dynamic, Max): 1536 MB 06:14:51 INFO - Vendor: Intel (0x8086) 06:14:51 INFO - Device ID: 0x0a2e 06:14:51 INFO - Revision ID: 0x0009 06:14:51 INFO - Displays: 06:14:51 INFO - Display: 06:14:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:14:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:14:51 INFO - Display Serial Number: 1600x1200 60 06:14:51 INFO - Main Display: Yes 06:14:51 INFO - Mirror: Off 06:14:51 INFO - Online: Yes 06:14:51 INFO - Rotation: Supported 06:14:51 INFO - Return code: 0 06:14:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:14:51 INFO - Python 2.7.3 06:14:51 INFO - Return code: 0 06:14:51 INFO - grabbing minidump binary from tooltool 06:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:14:51 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 0x1071c5d30>, '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 0x106f2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071bdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:14:51 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 06:14:51 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 06:14:51 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 06:14:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:14:51 INFO - Return code: 0 06:14:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:14:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:14:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:14:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:14:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:14:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0348', '--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 06:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0348 --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 06:14:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MDIHrNvfkE/Render', 06:14:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:51 INFO - 'HOME': '/Users/cltbld', 06:14:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:51 INFO - 'LOGNAME': 'cltbld', 06:14:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:14:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:51 INFO - 'MOZ_NO_REMOTE': '1', 06:14:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:14:51 INFO - 'NO_EM_RESTART': '1', 06:14:51 INFO - 'PAGER': '/bin/cat', 06:14:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:51 INFO - 'PWD': '/builds/slave/test', 06:14:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:14:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:51 INFO - 'SHELL': '/bin/bash', 06:14:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4WTDsZEJKt/Listeners', 06:14:51 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 06:14:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:51 INFO - 'USER': 'cltbld', 06:14:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:51 INFO - 'XPC_FLAGS': '0x0', 06:14:51 INFO - 'XPC_SERVICE_NAME': '0', 06:14:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0348', '--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 06:14:51 INFO - mozversion application_buildid: 20160711043826 06:14:51 INFO - mozversion application_changeset: 8f80e6e64a015c1b112765bd39a208c962f46824 06:14:51 INFO - mozversion application_display_name: Nightly 06:14:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:14:51 INFO - mozversion application_name: Firefox 06:14:51 INFO - mozversion application_remotingname: firefox 06:14:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:14:51 INFO - mozversion application_vendor: Mozilla 06:14:51 INFO - mozversion application_version: 50.0a1 06:14:51 INFO - mozversion platform_buildid: 20160711043826 06:14:51 INFO - mozversion platform_changeset: 8f80e6e64a015c1b112765bd39a208c962f46824 06:14:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:14:51 INFO - mozversion platform_version: 50.0a1 06:14:51 INFO - using testdate: 1468242891 06:14:51 INFO - actual date: 1468242891 06:14:51 INFO - starting webserver on 'localhost:49273' 06:14:51 INFO - SUITE-START | Running 2 tests 06:14:51 INFO - TEST-START | dromaeo_css 06:14:51 INFO - operating with platform_type : mac_ 06:14:51 INFO - Initialising browser for dromaeo_css test... 06:14:51 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/tmpjKfOft/profile http://localhost:49273/getInfo.html) 06:14:53 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 06:14:53 INFO - PROCESS | 1653 | colorDepth:24 06:14:53 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 06:14:53 INFO - PROCESS | 1653 | __metrics 06:14:53 INFO - PROCESS | 1653 | 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" 06:14:53 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:14:54 INFO - TEST-INFO | 1653: exit 0 06:14:54 INFO - Browser initialized. 06:14:54 INFO - Running cycle 1/1 for dromaeo_css test... 06:14:54 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/tmpjKfOft/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:15:06 INFO - PROCESS | 1655 | RSS: Main: 243515392 06:15:06 INFO - PROCESS | 1655 | 06:15:57 INFO - PROCESS | 1655 | 1468242957987 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] 06:18:07 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 06:18:08 INFO - PROCESS | 1655 | RSS: Main: 334987264 06:18:08 INFO - PROCESS | 1655 | 06:21:11 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 06:21:12 INFO - PROCESS | 1655 | RSS: Main: 371634176 06:21:12 INFO - PROCESS | 1655 | 06:24:14 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 06:24:15 INFO - PROCESS | 1655 | RSS: Main: 371826688 06:24:15 INFO - PROCESS | 1655 | 06:27:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 06:27:18 INFO - PROCESS | 1655 | RSS: Main: 370671616 06:27:18 INFO - PROCESS | 1655 | 06:30:21 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 06:30:22 INFO - PROCESS | 1655 | RSS: Main: 336691200 06:30:22 INFO - PROCESS | 1655 | 06:33:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 06:33:25 INFO - PROCESS | 1655 | RSS: Main: 419917824 06:33:25 INFO - PROCESS | 1655 | 06:33:25 INFO - PROCESS | 1655 | __start_tp_report 06:33:25 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 06:33:25 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 06:33:25 INFO - PROCESS | 1655 | |i|pagename|runs| 06:33:25 INFO - PROCESS | 1655 | |0;dojo.html;3308.6029676438825;3320.302736425352;3346.514755360472;3350.229447227139;3381.966180338196;5589.524890384312;5658.971705141474;5680.233168522248;5784.074548072309;5798.9999999999945;5226.398964119127;5259.763955470471;5775.2203452533895;5806.622569532978;5868.943590153781;5127.820526281562;5185.299984502091;5218.452062533436;5230.973845130769;5252.789888404459;4336.739795612258;5141.640085194038;5232.45059268777;5247.2653828464045;5302.787888484456;140.18384888874579;5207.6354655174155;5227.503387178212;5234.555062819665;5235.502627250406;5080.212567052113;5146.944876300387;5153.072446959546;5156.767945442464;5205.687658740488;5137.383513978347;5164.2770012198325;5165.896682066375;5168.173092305213;5211;5551.77792888284;5567.2762540869835;5737.282839645044;5851.444112809277;5854.736536855809;6131.570790044699;6138.938610613882;6158.907616385758;6183.196184495987;6194.721237544321;5102.948970510284;6143.754249830002;6151.446369826737;6153.876922461525;6169.96915015422;5630.0991841305195;5675.4892059714;5713.228714123582;5773.162891380726;5794.101914203306;6111.257501106225;6169.598976066542;6187;6208.937910620836;6214.751409943642;6133.28268084928;6150.446459818638;6161.075838624242;6167.691615419211;6173.351798061229;5778.046622307356;5893.705314734246;6121.571489995747;6132.877342453126;6171.228596425447;6107.643995706967;6113.050656958994;6152.692365381713;6222.62664240147;6232.781852635136;6216.627002379872;6230.065490176419;6237.064440333896;6250.031245157008;6251.187345645037;4831.806727730851;4841.540053694894;4897.926531102036;4939.987302602958;4949.950500495021;4389.034412429261;4410.69125161242;4433.889152771207;4450.154470650631;4454.153710794939;5708.971455142698;5714.9714251429305;5728.341240757366;5729.226554415184;5740.339860915965;5983.102534619842;5986.161937328778;6054.8183554493435;6066.423689749467;6181.320054793969;5499.697516636544;5505.779768809283;5509.311336082989;5527.198556209408;5527.944720552823;5182.844514664566;5202.66182698131;5218.657147984913;5224.242484839677;5278.340207474066;6128.105930682418;6148.415900489446;6192.535559833031;6203.596766210182;6222.471089957314;6100.969495152496;6137.723802428991;6158.846028849135;6167.691615419121;6187.381261873777;5243.449437808975;6109.009944784197;6145.985912324416;6216.502679785697;6229.345918678474;6132.601380910227;6218.9378106218355;6219.222597175353;6237.906431403623;6241.563090583615;6168.876622467616;6193.969030154821;6202.627842329474;6203.2245969253845;6209.689515524296;5956.166136740773;5984.9401505986125;6035.1249068885645;6111.5110791137495;6112.2970858351855;6060.212172417558;6070.0591408331775;6077.726502307319;6086.026235802427;6098.26820781509;5884.558658100746;5933.673647949404;5936.228290322403;5939.138824870456;5942.702864856654;5807.970960145172;5923.170756094064;6016.037434010537;6036.9698151508965;6096.451319381277;5921.259842519685;5924;5927.525797936069;5928.555358348055;5947.316058653138 06:33:25 INFO - PROCESS | 1655 | |1;ext.html;501.7081016382814;503.959683225342;527.3065918317412;531.5083547718363;556.4102051825063;30222;31002.2249443764;34210.8289458553;43079;43187.13625727483;44115.55884441155;44390.556094439045;44418.33372499407;44572.3314150288;44651.88370290744;9638.662646807346;9805.901940980606;9809.21526277896;9831.803363932717;9866;8728;8911.242544383735;8941.552922353889;9086.318526110535;9088.454692718426;11910;12104.213226140273;12126.211796233216;12353.197042192274;12355.938220308886;12029.097817663667;12141.514339426412;12158.209716368408;12170.513179472811;12180.903718665319;8613.48319100856;11640.825387619192;11890.167688261825;12001.279923204636;12001.819972700416;41401.75794726163;41882.555267815296;41914.79042604767;41944.370834437505;41984.580154198375;3481.686648201674;3807.3908174691915;4208.473940757405;4235.851745188935;4363.978180109079;31828.522572161437;32323.7070517179;32822.6717732822;32903;33054.50418243728;3218.1471909943884;3319.668033196685;3381.746369022333;3383.610884748261;3396.847141878621;483230;489418;489869;491231;491268;62081;62250.37749622446;62304.688476558236;62399.6880015597;62406.63153579296;65502.34497655058;65574.34425655777;65685;65722;65773;16176.029438233743;16860.988340699598;16867.662646746998;16873.831261687472;16963.321467141424;12997;13064.477420903057;13069.215847049207;13078.738425231442;13099.345032748324;14753.704925901422;15084.321205545777;15104.848951510565;15431.38274469031;17086.97478151315;4897.210424518007;5491.807786727445;6284.340144284875;6363.459105975951;6401.55189136756;880.8766772651834;963.94216347018;977.2262497698651;1014;1110.539126262592;29706.554401683992;31083.844580776953;31787.055555278494;31877.521837172462;32181.678183218337;1064.8988346107108;1128.210252823027;1161.7560312334335;1170.5142365918218;1190.0717440396504;15520.534383968274;16007.597910574452;16272;16500.92743971638;16775.161241938098;673619;673919;678505.6074719594;679091.2545247301;680479;53136.468635313155;60360.69819650961;61346.77306453935;62446.68776656088;62464;1401.7546929287334;1416.7874818777059;1428.8642578954982;1429.4425174182286;1430.6924011337612;31883.20291992719;32510.187245319055;32637.673623263465;32661.020169394957;33545;53706.46293537171;54238.45761542492;54258;54309.185362220385;54389.72805135949;598329;663970;670269;671081;678904;26771.063012794457;28754.856225719574;28783.856080719463;40978.79510602428;41367.1726565473;50438.24342634937;51255.74372128116;52336.47663523316;52742.73628631832;53570;40540.594594053684;41144.17711645691;42792.78603606962;42806.78596606997;43203.78398107989;40752.79623601863;41103.58896410998;41332;41426.96432589209;42219.7889010553;39858;40524;40672;40766.59233407628;40774.57288994871;29364.853175733984;30830.075097746205;35545;36383.636163638024;36538.63461365352;23970.520589587763;25647.487050258518;26383.868080659475;26492;26740.732592673823 06:33:25 INFO - PROCESS | 1655 | |2;jquery.html;356.52047995446117;377.7261485423069;387.53882879373543;390.4163275902526;409.377745826344;15624.140672263022;15860.286287117078;20673.689894651594;21192.788072119274;21243.787562124373;21145.365639030853;21549.24577639783;21828.672569911425;22368.440788980242;22392;5214.530692237698;5914.822555323347;6032.758689652409;6040.939590604082;6058.1518587397795;6014.578979471439;6058.757649694029;6059.545534084961;6091.329953705089;6102.969485152568;5709.914351284734;5974.283086029683;5979.073243647242;5980.342162362137;5988.461038506533;5801.88396232073;5959.0763431668165;6019.458248757611;6020.488258498033;6040.305364883029;5982.700864956778;6016.458518733291;6031;6038.667873266969;6053.636781793107;13468.39392227352;18056;25792.097276595417;26307.473850523074;27237.455250894873;1967.5376286572643;2108.9156433742633;2411.8794060296914;2467.5558399488086;3016.2308611304197;9732.854007189897;9809;10088.293819432643;10373.273870829045;10490.00344967227;1864.6457173137196;1913.100842603974;1914.15777058094;1961.892095934723;2034.440528854562;106911;109708.4514577422;112231.87768122296;113074;114189.99999999917;9600.183984361267;11477.311361318347;11494.42527873603;11556.479958401893;11573.594924177612;14547.054441461483;14648.926755366156;14681.045732027598;14695;14708.043977141451;8444.113368096385;8610.6986255482;8643.265322447662;8737.257333126629;8754.47473151613;8585.31317494599;8586.270167035747;8588.22705956467;8730.126987301219;8739.475631462132;4489.910201795946;4577.0159415725775;4600.5629465200755;4641.628669706415;4644.256918892961;1909.8281154696144;1929.8456123510086;1938.331275709878;1949.6588097082954;1955.8044195580328;681.8056853796644;716.9997852995043;781.1797612506958;838.9244967952914;922.1654402765508;20462.79537204639;21128.366149015554;22136.889315553643;22200.88899555524;22319.888400557895;917.3395155488038;931.8043210925646;952.2049089010753;952.9714108576753;975.5219942228257;8910;9854.655087071918;10692.358458492516;11595.652130435932;11637;450452;506539;515410;606493;617288;142267.86598201035;144326;147387;150852;153287;941.75985123793;967.5017366056486;984.3995162950595;987.1757082835769;1003.1974420463746;14978.550643480714;18995.90502047481;19325.130369133705;19558.804411955698;19636.607267854848;28260.576091359057;46709.766451167525;52866;55556;56454.7177264111;75907.62046189734;80244.59877700808;84911.5754421224;86156.56921715352;91757.62363564418;5569.415211402745;6076.787312444043;6921.688524016331;7902.604869756604;8581.313494920267;11735.061195104541;11919.46362413676;12790.232586044867;13175.407106680414;13479.123856949267;10610.575576977144;11562.826557601475;11755.529778809094;11814.704632384259;11834.644960651194;11488;11555.653330400102;11559.364234967157;11686.357250351311;11811.409429528661;11646.76706465849;11669.941650291694;11685.298882067103;11938.820917686415;12107.939460302641;8173.060098088796;8282.792930176794;8343;8367.66529338844;8507.234348908629;10190.43952582615;10523.526441310312;11537.48081336325;11790.528378864748;11790.997765189712 06:33:25 INFO - PROCESS | 1655 | |3;mootools.html;1442.0626592714736;1526.488626310186;1711.2983676692559;1715.4339068107527;1964.9782113301092;8490.53302068386;8709.564521773902;8889.466632002084;8899.288056955436;8909.376343655947;7785.143634200248;8012.238837310446;8014.7194848180325;8115.39134564907;8659.826803463928;2081.594089152612;2121.713568668233;2274.7725227477204;2337.1118974789642;2343.320437073247;2297.597920363938;2317.6639387288833;2319.095552734435;2324.2213858357472;2328.2316835444262;2309.3880121767743;2360.0677732295735;2365.195833416638;2367.490989437271;2367.8105751539833;2076.1799089359693;2144.8069673729437;2145.5923374558784;2146.35609317205;2287.2680742162515;2330.7436182019965;2371.6205407134776;2371.6916800815784;2372.1697405907967;2381.3213234228333;8839.77900552485;8923.955380223122;8942.552872356422;8943;8961.193492585699;5196.2465442511;5342.2253773202665;5343.305370301875;5367.463253674601;5393.379761327458;3549.893503194908;3563.198280386918;3618.9095272618397;3674.2835147146316;3679.19057807282;1080.0495563903794;1083.7453198498347;1086.9673909782719;1102.7188067042932;1104.2491106047885;11689.532418703157;11706;11750;11755.294682319089;11756.412179391082;4487.977560112178;4613.492515823256;4673.275642275453;4687.460941991646;4739.786709598076;9868.358556693793;9869.555869985868;9880.258980576486;9886.901130988743;9921.00789921002;5179.507946745053;5240.4759524047295;5295.576353891679;5300.681959082467;5331.866703332447;4711.764411779397;4887.926681099786;4894.437139728977;4899.240617704261;4935.654504184673;3502.176988407722;3628.292482965849;3723.94414083789;3827.559830619459;3832.9616703833162;1038.5222797513077;1154.122866621357;1154.2670404293167;1159.7042754097652;1176.16492290473;865.1867244789877;885.7652722028668;921.6175287255847;925.4956048953337;948.0330063335359;5570.080936645408;5909.881802363929;6069.0592958091565;6126.969365153146;6322.652254126067;796.9960150199212;912.7216199059218;914.4147745442922;968.4506284467489;982.7002764156858;3481.9129521762156;3827.655511004023;4003.8999025024023;4011.2150093208825;4096.877093687194;10474.68575942723;10615.52230149645;10708.73228169302;10783.245172837826;10786.676399708022;9081.863772043425;9767.974362691815;10134.898651013396;10744.14046876248;10765.892341076646;8199.098099209083;8302.70940517079;8319.542425166554;8323.458975166595;8341.290990265896;5774.855628609318;5844.327902291121;5954.4938680210935;6035.6076855004285;6055.818325450244;9348.813023739624;9962.750931226778;10128.34165779222;10136.797264054825;10149;9584.952075239578;10347;10424.374537527772;10430.165586753194;10442.843357349493;7560.659770310239;7702.460827742004;7705.730299439717;7709.845803084019;7720.266574675396;7384.889226661497;7410.62946852666;8424.28393586552;8485.618147183515;8497.87253191215;7409.546187697849;7453.850922981618;7499.212582678741;7532.661030253542;7628.199039100815;7284.745033923788;7330.376917962033;7332.0834895638045;7425;7475.36459400957;6811.523193376416;7046.859062818612;7060.7881763547175;7061.364477197077;7064.152301723826;4837.371141751691;4922.7538623067985;5034.496550344937;5118.539331460038;5175.301334319969;5021.246812978083;5051.570616497639;5152.742362881916;5241.737913104405;5260.10578201699 06:33:25 INFO - PROCESS | 1655 | |4;prototype.html;303.21164971075194;303.8936372269706;312.5187211693992;317.16743548186014;319.672335855748;5382.38102618199;5434.184872269162;5439.864003399917;5439.891202175954;5495.313085864272;5052.787331040551;5071.579957611865;5199.012187684338;5339.2914267434435;5347.652402593829;4026.939595906064;4029.2344454553686;4046.514418269812;4055.3916912463073;4083.8979025524304;3252.804831710105;3549.396602577568;3943.783091929957;4007.8998025049314;4119.40268661044;3744.8876533704033;3890.5100735529286;3922.705797065217;4005.9599404006026;4052.2503336882623;3252.430824605708;4005.679545636342;4017.6986725995666;4068.552459229468;4075.205334959669;3476.2699833035094;3521.6126226115107;3536.416491278936;3536.717062634983;3541.5041894134843;4449.933251001237;4577.450705915278;4896.779644915988;5148.974255128738;5236.538826751421;4216.304309788881;4589.770511474447;4614.284785858197;4668.786115609932;4715.986062996472;4662.552160115933;5376.11294136467;5569.470900264469;5608.457674139644;5621.325440947072;3570.321638888629;3884.9223015539533;3902.2975864344407;3911.3546264866263;3921.156951255465;4910.582600478963;5153.845384638467;5270.761371077832;5556.972215138899;5790.478856902899;3653.89900807037;3911.1786524829536;3928.6660633845872;4036.2936486114813;4052.49343832021;3158.2578094147857;3811.237752449466;4093.85671501496;4098.7950602470355;4124.08230172965;3973.463582416337;4264.211120942636;4511.894585826493;4688.203005489075;4708.576228139484;5059.924101138486;5496.811849127496;5547.417521160301;5560.638558493685;5624.521915637217;1364.1542243808901;1381.6407733989033;1400.1948879394388;1401.6124037203097;1406.6202125426078;789.9848694427633;894.4543828264754;914.7118657622827;918.6587582130031;969.9854502182473;5133.6919784813035;5177.404598471148;5178;5200.349956255468;5238.337879287437;4860.756962151878;5342;5710.314762228476;5758.099827057061;5768.682722450306;4844.32179494871;4866.513348665176;5148.382194136652;5172.922406163911;5179.22311653255;2511.3344963584664;2781.554951207797;2981.0907673159895;2984.65676447207;3032.3783624357393;5534.819664278136;5927.84407040623;5944.821655350346;5946.1972633693895;5968.8806223876145;4686.461056978423;5669.747689233075;5840.503557197686;5854.121881717776;5863.061910094364;5388.380336261223;5745.224394706661;5855.130985816919;5893.381194974551;5913.231279933581;4803.711777293373;5244.5279924806955;5435.728213589384;5497.8075767347955;5562.666240025612;4533.773311334354;4962.578180854668;5534.252875861707;5586.497215250647;5617.7191140442;4958;5387.676739395649;5513.173024046425;5678.943210567842;5830.271216097988;3763.228538149618;3922.9607703922597;3986.720929534905;3991.880243592697;4019.1760689059256;4763.785629646605;4893.461719210955;4953.572749352719;5639.943600563942;5664.688442135722;5545.195946587803;5546.670398432588;5548.389677135431;5552.916706249491;5556.833295001156;5047.268146118866;5342.7061511615675;5595.608307418442;5647.209390685225;5649.6327738696855;5299.867503312294;5492.423295554069;5502.8349149525575;5529.170624406372;5538.280023596906;5019.422766381913;5586.301712285965;5617.882075448002;5622.7750889963945;5649.672327003069;4658.37111989877;5324.9467505326;5473.808416705556;5491.7254137292175;5498.917516237179 06:33:25 INFO - PROCESS | 1655 | |5;yui.html;710.2116650517925;730.1967835381079;748.0387701803184;764.8317370178562;795.284244180238;15545.989510681798;16614.25235864386;16617.169141542905;16639.833601663995;17630.294788208488;16590.336386544524;17456.301747930098;17465.214065367058;17493.82506174938;17776.200070996805;699.552286536617;720.3157000849188;720.3480849830885;866.8396346675869;885.6280362247871;707.4800021983838;711.7829062136072;713.1798431803442;861.5950503263456;874.3180319350885;918.4626993208981;923.529000209891;925.2505470568827;925.3430064654103;926.8609708543738;922.7185708358948;924.5192499900048;925.6297481007583;927.0405130689771;929.2333824594737;546.4781134017044;562.9894339660319;682.2529330383272;688.3082502085372;693.8993845892368;15558.222088895624;15607.141607211599;15609.843901561066;15618.297176627078;15631.296591653288;13668.248246346448;14051.43794248229;14098.85901140996;14134.717305653932;14136.434542618283;13307.733845323039;13319.408981207163;13363.799543006862;13667.726645467135;13890.23603701796;4582.381378513891;4598.333241679971;4605.286180642006;4627.444706635191;4653.464851542082;120459;121406;121854;122759.38620306931;122844;11125.221234513507;11166.218364714392;11169.106471482262;11287.717807054725;11309.377984210783;21742.13031478723;21864.12543498274;21883.562328753334;21929.12283508674;21943.561128777335;7812.218778122142;7929.405294602928;8007.519548827089;8009.959950200212;8232.753017409488;4442.400275962704;4481.551844815493;4498.482674492409;4521.706089104264;4682.297655351656;3475.3918064339146;3543.6633519815578;3577.6422357764013;3579.427291633326;3580.03339098442;584.2871696530226;596.5853731656457;602.4006113916594;610.7587502936316;620.2742790934617;582.4379473807796;588.7792077970761;616.5714828194451;627.4259052966485;635.1171871099176;8915.28677705782;9124.81750364989;9262.120098590623;9270.563062725289;9402.576884040234;531.8457647282322;562.8770602647662;626.8009387160981;628.2586547873461;632.5635311635049;4302.096559722493;4314.180305741899;4346.9347959780625;4366.825326986948;4600.4479462464715;94176.52911735397;141862;146075.06145206754;149774;152147;119803;120482.3975880115;120534;127185;127660;105065;107669;111363;117300;118552;7125.893111603434;7219.566825990458;8786.209241168326;8957.507337096522;8963.462411850127;58468.70765646145;65177.67411162914;66667.3333266661;68377.65811170913;68505.49756991562;81606;101280.49359753155;102260;102423.46364804385;103997.96002039882;11547.480363383836;11571.247868888495;11606.187566870238;11662.475188616701;12178.512859485876;13487.797683034958;15047.021943573633;15429;15445.922770386076;16120.113393763455;14501;14554.27228638585;14656.633584160481;15177.772333415229;15233.771493427828;14069.296535173406;14222.217778022308;14490.275486225435;14920.62698432548;15030.849691503383;13059.21644701321;13329.933350333185;14299.428022878968;14725.705485890008;14785.92607036958;11516.193866429605;11626.302421854716;11667.183297169116;11815.40922953866;12459.439325230205;10559.947200263949;10908.61819836302;10964.56141754321;11622.82565761531;11962.575740168293 06:33:25 INFO - PROCESS | 1655 | __end_tp_report 06:33:25 INFO - PROCESS | 1655 | __start_cc_report 06:33:25 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1292 06:33:25 INFO - PROCESS | 1655 | __end_cc_report 06:33:25 INFO - PROCESS | 1655 | __startTimestamp1468244005434__endTimestamp 06:33:25 INFO - PROCESS | 1655 | 06:33:25 INFO - PROCESS | 1655 | ------- Summary: start ------- 06:33:25 INFO - PROCESS | 1655 | Number of tests: 6 06:33:25 INFO - PROCESS | 1655 | 06:33:25 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5642.92 Median:5923.17 stddev:763.92 (12.9%) stddev-sans-first:743.98 06:33:25 INFO - PROCESS | 1655 | Values: 3308.6 3320.3 3346.5 3350.2 3382.0 5589.5 5659.0 5680.2 5784.1 5799.0 5226.4 5259.8 5775.2 5806.6 5868.9 5127.8 5185.3 5218.5 5231.0 5252.8 4336.7 5141.6 5232.5 5247.3 5302.8 140.2 5207.6 5227.5 5234.6 5235.5 5080.2 5146.9 5153.1 5156.8 5205.7 5137.4 5164.3 5165.9 5168.2 5211.0 5551.8 5567.3 5737.3 5851.4 5854.7 6131.6 6138.9 6158.9 6183.2 6194.7 5102.9 6143.8 6151.4 6153.9 6170.0 5630.1 5675.5 5713.2 5773.2 5794.1 6111.3 6169.6 6187.0 6208.9 6214.8 6133.3 6150.4 6161.1 6167.7 6173.4 5778.0 5893.7 6121.6 6132.9 6171.2 6107.6 6113.1 6152.7 6222.6 6232.8 6216.6 6230.1 6237.1 6250.0 6251.2 4831.8 4841.5 4897.9 4940.0 4950.0 4389.0 4410.7 4433.9 4450.2 4454.2 5709.0 5715.0 5728.3 5729.2 5740.3 5983.1 5986.2 6054.8 6066.4 6181.3 5499.7 5505.8 5509.3 5527.2 5527.9 5182.8 5202.7 5218.7 5224.2 5278.3 6128.1 6148.4 6192.5 6203.6 6222.5 6101.0 6137.7 6158.8 6167.7 6187.4 5243.4 6109.0 6146.0 6216.5 6229.3 6132.6 6218.9 6219.2 6237.9 6241.6 6168.9 6194.0 6202.6 6203.2 6209.7 5956.2 5984.9 6035.1 6111.5 6112.3 6060.2 6070.1 6077.7 6086.0 6098.3 5884.6 5933.7 5936.2 5939.1 5942.7 5808.0 5923.2 6016.0 6037.0 6096.5 5921.3 5924.0 5927.5 5928.6 5947.3 06:33:25 INFO - PROCESS | 1655 | 06:33:25 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:74609.64 Median:40876.68 stddev:164134.89 (401.5%) stddev-sans-first:164501.02 06:33:25 INFO - PROCESS | 1655 | Values: 501.7 504.0 527.3 531.5 556.4 30222.0 31002.2 34210.8 43079.0 43187.1 44115.6 44390.6 44418.3 44572.3 44651.9 9638.7 9805.9 9809.2 9831.8 9866.0 8728.0 8911.2 8941.6 9086.3 9088.5 11910.0 12104.2 12126.2 12353.2 12355.9 12029.1 12141.5 12158.2 12170.5 12180.9 8613.5 11640.8 11890.2 12001.3 12001.8 41401.8 41882.6 41914.8 41944.4 41984.6 3481.7 3807.4 4208.5 4235.9 4364.0 31828.5 32323.7 32822.7 32903.0 33054.5 3218.1 3319.7 3381.7 3383.6 3396.8 483230.0 489418.0 489869.0 491231.0 491268.0 62081.0 62250.4 62304.7 62399.7 62406.6 65502.3 65574.3 65685.0 65722.0 65773.0 16176.0 16861.0 16867.7 16873.8 16963.3 12997.0 13064.5 13069.2 13078.7 13099.3 14753.7 15084.3 15104.8 15431.4 17087.0 4897.2 5491.8 6284.3 6363.5 6401.6 880.9 963.9 977.2 1014.0 1110.5 29706.6 31083.8 31787.1 31877.5 32181.7 1064.9 1128.2 1161.8 1170.5 1190.1 15520.5 16007.6 16272.0 16500.9 16775.2 673619.0 673919.0 678505.6 679091.3 680479.0 53136.5 60360.7 61346.8 62446.7 62464.0 1401.8 1416.8 1428.9 1429.4 1430.7 31883.2 32510.2 32637.7 32661.0 33545.0 53706.5 54238.5 54258.0 54309.2 54389.7 598329.0 663970.0 670269.0 671081.0 678904.0 26771.1 28754.9 28783.9 40978.8 41367.2 50438.2 51255.7 52336.5 52742.7 53570.0 40540.6 41144.2 42792.8 42806.8 43203.8 40752.8 41103.6 41332.0 41427.0 42219.8 39858.0 40524.0 40672.0 40766.6 40774.6 29364.9 30830.1 35545.0 36383.6 36538.6 23970.5 25647.5 26383.9 26492.0 26740.7 06:33:25 INFO - PROCESS | 1655 | 06:33:25 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:33736.97 Median:15638.40 stddev:91752.72 (586.7%) stddev-sans-first:91975.88 06:33:25 INFO - PROCESS | 1655 | Values: 356.5 377.7 387.5 390.4 409.4 15624.1 15860.3 20673.7 21192.8 21243.8 21145.4 21549.2 21828.7 22368.4 22392.0 5214.5 5914.8 6032.8 6040.9 6058.2 6014.6 6058.8 6059.5 6091.3 6103.0 5709.9 5974.3 5979.1 5980.3 5988.5 5801.9 5959.1 6019.5 6020.5 6040.3 5982.7 6016.5 6031.0 6038.7 6053.6 13468.4 18056.0 25792.1 26307.5 27237.5 1967.5 2108.9 2411.9 2467.6 3016.2 9732.9 9809.0 10088.3 10373.3 10490.0 1864.6 1913.1 1914.2 1961.9 2034.4 106911.0 109708.5 112231.9 113074.0 114190.0 9600.2 11477.3 11494.4 11556.5 11573.6 14547.1 14648.9 14681.0 14695.0 14708.0 8444.1 8610.7 8643.3 8737.3 8754.5 8585.3 8586.3 8588.2 8730.1 8739.5 4489.9 4577.0 4600.6 4641.6 4644.3 1909.8 1929.8 1938.3 1949.7 1955.8 681.8 717.0 781.2 838.9 922.2 20462.8 21128.4 22136.9 22200.9 22319.9 917.3 931.8 952.2 953.0 975.5 8910.0 9854.7 10692.4 11595.7 11637.0 450452.0 506539.0 515410.0 606493.0 617288.0 142267.9 144326.0 147387.0 150852.0 153287.0 941.8 967.5 984.4 987.2 1003.2 14978.6 18995.9 19325.1 19558.8 19636.6 28260.6 46709.8 52866.0 55556.0 56454.7 75907.6 80244.6 84911.6 86156.6 91757.6 5569.4 6076.8 6921.7 7902.6 8581.3 11735.1 11919.5 12790.2 13175.4 13479.1 10610.6 11562.8 11755.5 11814.7 11834.6 11488.0 11555.7 11559.4 11686.4 11811.4 11646.8 11669.9 11685.3 11938.8 12107.9 8173.1 8282.8 8343.0 8367.7 8507.2 10190.4 10523.5 11537.5 11790.5 11791.0 06:33:25 INFO - PROCESS | 1655 | 06:33:25 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5690.50 Median:5135.64 stddev:3191.71 (62.1%) stddev-sans-first:3184.69 06:33:25 INFO - PROCESS | 1655 | Values: 1442.1 1526.5 1711.3 1715.4 1965.0 8490.5 8709.6 8889.5 8899.3 8909.4 7785.1 8012.2 8014.7 8115.4 8659.8 2081.6 2121.7 2274.8 2337.1 2343.3 2297.6 2317.7 2319.1 2324.2 2328.2 2309.4 2360.1 2365.2 2367.5 2367.8 2076.2 2144.8 2145.6 2146.4 2287.3 2330.7 2371.6 2371.7 2372.2 2381.3 8839.8 8924.0 8942.6 8943.0 8961.2 5196.2 5342.2 5343.3 5367.5 5393.4 3549.9 3563.2 3618.9 3674.3 3679.2 1080.0 1083.7 1087.0 1102.7 1104.2 11689.5 11706.0 11750.0 11755.3 11756.4 4488.0 4613.5 4673.3 4687.5 4739.8 9868.4 9869.6 9880.3 9886.9 9921.0 5179.5 5240.5 5295.6 5300.7 5331.9 4711.8 4887.9 4894.4 4899.2 4935.7 3502.2 3628.3 3723.9 3827.6 3833.0 1038.5 1154.1 1154.3 1159.7 1176.2 865.2 885.8 921.6 925.5 948.0 5570.1 5909.9 6069.1 6127.0 6322.7 797.0 912.7 914.4 968.5 982.7 3481.9 3827.7 4003.9 4011.2 4096.9 10474.7 10615.5 10708.7 10783.2 10786.7 9081.9 9768.0 10134.9 10744.1 10765.9 8199.1 8302.7 8319.5 8323.5 8341.3 5774.9 5844.3 5954.5 6035.6 6055.8 9348.8 9962.8 10128.3 10136.8 10149.0 9585.0 10347.0 10424.4 10430.2 10442.8 7560.7 7702.5 7705.7 7709.8 7720.3 7384.9 7410.6 8424.3 8485.6 8497.9 7409.5 7453.9 7499.2 7532.7 7628.2 7284.7 7330.4 7332.1 7425.0 7475.4 6811.5 7046.9 7060.8 7061.4 7064.2 4837.4 4922.8 5034.5 5118.5 5175.3 5021.2 5051.6 5152.7 5241.7 5260.1 06:33:25 INFO - PROCESS | 1655 | 06:33:25 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4506.01 Median:5065.75 stddev:1361.05 (26.9%) stddev-sans-first:1327.81 06:33:25 INFO - PROCESS | 1655 | Values: 303.2 303.9 312.5 317.2 319.7 5382.4 5434.2 5439.9 5439.9 5495.3 5052.8 5071.6 5199.0 5339.3 5347.7 4026.9 4029.2 4046.5 4055.4 4083.9 3252.8 3549.4 3943.8 4007.9 4119.4 3744.9 3890.5 3922.7 4006.0 4052.3 3252.4 4005.7 4017.7 4068.6 4075.2 3476.3 3521.6 3536.4 3536.7 3541.5 4449.9 4577.5 4896.8 5149.0 5236.5 4216.3 4589.8 4614.3 4668.8 4716.0 4662.6 5376.1 5569.5 5608.5 5621.3 3570.3 3884.9 3902.3 3911.4 3921.2 4910.6 5153.8 5270.8 5557.0 5790.5 3653.9 3911.2 3928.7 4036.3 4052.5 3158.3 3811.2 4093.9 4098.8 4124.1 3973.5 4264.2 4511.9 4688.2 4708.6 5059.9 5496.8 5547.4 5560.6 5624.5 1364.2 1381.6 1400.2 1401.6 1406.6 790.0 894.5 914.7 918.7 970.0 5133.7 5177.4 5178.0 5200.3 5238.3 4860.8 5342.0 5710.3 5758.1 5768.7 4844.3 4866.5 5148.4 5172.9 5179.2 2511.3 2781.6 2981.1 2984.7 3032.4 5534.8 5927.8 5944.8 5946.2 5968.9 4686.5 5669.7 5840.5 5854.1 5863.1 5388.4 5745.2 5855.1 5893.4 5913.2 4803.7 5244.5 5435.7 5497.8 5562.7 4533.8 4962.6 5534.3 5586.5 5617.7 4958.0 5387.7 5513.2 5678.9 5830.3 3763.2 3923.0 3986.7 3991.9 4019.2 4763.8 4893.5 4953.6 5639.9 5664.7 5545.2 5546.7 5548.4 5552.9 5556.8 5047.3 5342.7 5595.6 5647.2 5649.6 5299.9 5492.4 5502.8 5529.2 5538.3 5019.4 5586.3 5617.9 5622.8 5649.7 4658.4 5324.9 5473.8 5491.7 5498.9 06:33:25 INFO - PROCESS | 1655 | 06:33:25 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:25279.35 Median:21906.34 stddev:39608.76 (180.8%) stddev-sans-first:39676.91 06:33:25 INFO - PROCESS | 1655 | Values: 710.2 730.2 748.0 764.8 795.3 15546.0 16614.3 16617.2 16639.8 17630.3 16590.3 17456.3 17465.2 17493.8 17776.2 699.6 720.3 720.3 866.8 885.6 707.5 711.8 713.2 861.6 874.3 918.5 923.5 925.3 925.3 926.9 922.7 924.5 925.6 927.0 929.2 546.5 563.0 682.3 688.3 693.9 15558.2 15607.1 15609.8 15618.3 15631.3 13668.2 14051.4 14098.9 14134.7 14136.4 13307.7 13319.4 13363.8 13667.7 13890.2 4582.4 4598.3 4605.3 4627.4 4653.5 120459.0 121406.0 121854.0 122759.4 122844.0 11125.2 11166.2 11169.1 11287.7 11309.4 21742.1 21864.1 21883.6 21929.1 21943.6 7812.2 7929.4 8007.5 8010.0 8232.8 4442.4 4481.6 4498.5 4521.7 4682.3 3475.4 3543.7 3577.6 3579.4 3580.0 584.3 596.6 602.4 610.8 620.3 582.4 588.8 616.6 627.4 635.1 8915.3 9124.8 9262.1 9270.6 9402.6 531.8 562.9 626.8 628.3 632.6 4302.1 4314.2 4346.9 4366.8 4600.4 94176.5 141862.0 146075.1 149774.0 152147.0 119803.0 120482.4 120534.0 127185.0 127660.0 105065.0 107669.0 111363.0 117300.0 118552.0 7125.9 7219.6 8786.2 8957.5 8963.5 58468.7 65177.7 66667.3 68377.7 68505.5 81606.0 101280.5 102260.0 102423.5 103998.0 11547.5 11571.2 11606.2 11662.5 12178.5 13487.8 15047.0 15429.0 15445.9 16120.1 14501.0 14554.3 14656.6 15177.8 15233.8 14069.3 14222.2 14490.3 14920.6 15030.8 13059.2 13329.9 14299.4 14725.7 14785.9 11516.2 11626.3 11667.2 11815.4 12459.4 10559.9 10908.6 10964.6 11622.8 11962.6 06:33:25 INFO - PROCESS | 1655 | -------- Summary: end -------- 06:33:25 INFO - PROCESS | 1655 | 06:33:26 INFO - TEST-INFO | 1655: exit 0 06:33:26 INFO - TEST-OK | dromaeo_css | took 1114438ms 06:33:26 INFO - TEST-START | kraken 06:33:26 INFO - operating with platform_type : mac_ 06:33:26 INFO - Initialising browser for kraken test... 06:33:26 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/tmpQlPjlf/profile http://localhost:49273/getInfo.html) 06:33:28 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 06:33:28 INFO - PROCESS | 1662 | colorDepth:24 06:33:28 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 06:33:28 INFO - PROCESS | 1662 | __metrics 06:33:28 INFO - PROCESS | 1662 | 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" 06:33:28 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:33:29 INFO - TEST-INFO | 1662: exit 0 06:33:29 INFO - Browser initialized. 06:33:29 INFO - Running cycle 1/1 for kraken test... 06:33:29 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/tmpQlPjlf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:33:41 INFO - PROCESS | 1663 | RSS: Main: 243408896 06:33:41 INFO - PROCESS | 1663 | 06:33:43 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 06:33:44 INFO - PROCESS | 1663 | RSS: Main: 293744640 06:33:44 INFO - PROCESS | 1663 | 06:33:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 06:33:47 INFO - PROCESS | 1663 | RSS: Main: 303915008 06:33:47 INFO - PROCESS | 1663 | 06:33:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 06:33:51 INFO - PROCESS | 1663 | RSS: Main: 389926912 06:33:51 INFO - PROCESS | 1663 | 06:33:53 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 06:33:54 INFO - PROCESS | 1663 | RSS: Main: 290803712 06:33:54 INFO - PROCESS | 1663 | 06:33:56 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:33:57 INFO - PROCESS | 1663 | RSS: Main: 294907904 06:33:57 INFO - PROCESS | 1663 | 06:33:59 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 06:34:00 INFO - PROCESS | 1663 | RSS: Main: 329482240 06:34:00 INFO - PROCESS | 1663 | 06:34:03 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 06:34:04 INFO - PROCESS | 1663 | RSS: Main: 331968512 06:34:04 INFO - PROCESS | 1663 | 06:34:07 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 06:34:07 INFO - PROCESS | 1663 | RSS: Main: 331440128 06:34:07 INFO - PROCESS | 1663 | 06:34:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:34:09 INFO - PROCESS | 1663 | RSS: Main: 311279616 06:34:09 INFO - PROCESS | 1663 | 06:34:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:34:12 INFO - PROCESS | 1663 | RSS: Main: 318263296 06:34:12 INFO - PROCESS | 1663 | 06:34:14 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:34:15 INFO - PROCESS | 1663 | RSS: Main: 315711488 06:34:15 INFO - PROCESS | 1663 | 06:34:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:34:18 INFO - PROCESS | 1663 | RSS: Main: 326316032 06:34:18 INFO - PROCESS | 1663 | 06:34:21 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:34:22 INFO - PROCESS | 1663 | RSS: Main: 327684096 06:34:22 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 06:34:24 INFO - PROCESS | 1663 | RSS: Main: 371511296 06:34:24 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | __start_tp_report 06:34:24 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 06:34:24 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 06:34:24 INFO - PROCESS | 1663 | |i|pagename|runs| 06:34:24 INFO - PROCESS | 1663 | |0;ai-astar;101;113;111;112;112;111;113;112;112;112 06:34:24 INFO - PROCESS | 1663 | |1;audio-beat-detection;144;109;128;193;110;103;128;106;141;105 06:34:24 INFO - PROCESS | 1663 | |2;audio-dft;182;183;184;183;185;182;182;182;182;182 06:34:24 INFO - PROCESS | 1663 | |3;audio-fft;80;74;57;107;58;58;59;67;95;54 06:34:24 INFO - PROCESS | 1663 | |4;audio-oscillator;82;91;92;70;71;68;97;72;66;102 06:34:24 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;89;86;90;88;90;86;90;87;91;88 06:34:24 INFO - PROCESS | 1663 | |6;imaging-darkroom;94;95;94;95;119;145;146;96;96;95 06:34:24 INFO - PROCESS | 1663 | |7;imaging-desaturate;86;87;83;86;85;82;85;86;86;87 06:34:24 INFO - PROCESS | 1663 | |8;json-parse-financial;58;56;56;57;56;54;55;54;53;54 06:34:24 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;65;76;110;113;86;73;71;72;71;72 06:34:24 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;79;82;82;82;84;78;74;79;79;85 06:34:24 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;136;145;145;135;134;142;148;143;203;147 06:34:24 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;166;212;167;163;164;167;162;156;160;162 06:34:24 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;67;67;67;66;65;66;66;66;65;65 06:34:24 INFO - PROCESS | 1663 | __end_tp_report 06:34:24 INFO - PROCESS | 1663 | __start_cc_report 06:34:24 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2033 06:34:24 INFO - PROCESS | 1663 | __end_cc_report 06:34:24 INFO - PROCESS | 1663 | __startTimestamp1468244064274__endTimestamp 06:34:24 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | ------- Summary: start ------- 06:34:24 INFO - PROCESS | 1663 | Number of tests: 14 06:34:24 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:3.54 (3.2%) stddev-sans-first:0.71 06:34:24 INFO - PROCESS | 1663 | Values: 101.0 113.0 111.0 112.0 112.0 111.0 113.0 112.0 112.0 112.0 06:34:24 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:128.00 stddev:27.80 (21.7%) stddev-sans-first:28.77 06:34:24 INFO - PROCESS | 1663 | Values: 144.0 109.0 128.0 193.0 110.0 103.0 128.0 106.0 141.0 105.0 06:34:24 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:182.70 Median:182.50 stddev:1.06 (0.6%) stddev-sans-first:1.09 06:34:24 INFO - PROCESS | 1663 | Values: 182.0 183.0 184.0 183.0 185.0 182.0 182.0 182.0 182.0 182.0 06:34:24 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:70.90 Median:63.00 stddev:18.09 (28.7%) stddev-sans-first:18.88 06:34:24 INFO - PROCESS | 1663 | Values: 80.0 74.0 57.0 107.0 58.0 58.0 59.0 67.0 95.0 54.0 06:34:24 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:81.10 Median:77.00 stddev:13.40 (17.4%) stddev-sans-first:14.20 06:34:24 INFO - PROCESS | 1663 | Values: 82.0 91.0 92.0 70.0 71.0 68.0 97.0 72.0 66.0 102.0 06:34:24 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:89.50 stddev:1.78 (2.0%) stddev-sans-first:1.88 06:34:24 INFO - PROCESS | 1663 | Values: 89.0 86.0 90.0 88.0 90.0 86.0 90.0 87.0 91.0 88.0 06:34:24 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:107.50 Median:95.00 stddev:21.39 (22.5%) stddev-sans-first:22.12 06:34:24 INFO - PROCESS | 1663 | Values: 94.0 95.0 94.0 95.0 119.0 145.0 146.0 96.0 96.0 95.0 06:34:24 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:86.00 stddev:1.64 (1.9%) stddev-sans-first:1.72 06:34:24 INFO - PROCESS | 1663 | Values: 86.0 87.0 83.0 86.0 85.0 82.0 85.0 86.0 86.0 87.0 06:34:24 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:1.57 (2.8%) stddev-sans-first:1.32 06:34:24 INFO - PROCESS | 1663 | Values: 58.0 56.0 56.0 57.0 56.0 54.0 55.0 54.0 53.0 54.0 06:34:24 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:80.90 Median:72.00 stddev:16.99 (23.6%) stddev-sans-first:17.01 06:34:24 INFO - PROCESS | 1663 | Values: 65.0 76.0 110.0 113.0 86.0 73.0 71.0 72.0 71.0 72.0 06:34:24 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:82.00 stddev:3.24 (3.9%) stddev-sans-first:3.40 06:34:24 INFO - PROCESS | 1663 | Values: 79.0 82.0 82.0 82.0 84.0 78.0 74.0 79.0 79.0 85.0 06:34:24 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:145.00 stddev:20.04 (13.8%) stddev-sans-first:20.79 06:34:24 INFO - PROCESS | 1663 | Values: 136.0 145.0 145.0 135.0 134.0 142.0 148.0 143.0 203.0 147.0 06:34:24 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:165.00 stddev:15.86 (9.6%) stddev-sans-first:16.80 06:34:24 INFO - PROCESS | 1663 | Values: 166.0 212.0 167.0 163.0 164.0 167.0 162.0 156.0 160.0 162.0 06:34:24 INFO - PROCESS | 1663 | 06:34:24 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 06:34:24 INFO - PROCESS | 1663 | Values: 67.0 67.0 67.0 66.0 65.0 66.0 66.0 66.0 65.0 65.0 06:34:24 INFO - PROCESS | 1663 | -------- Summary: end -------- 06:34:24 INFO - PROCESS | 1663 | 06:34:25 INFO - TEST-INFO | 1663: exit 0 06:34:25 INFO - TEST-OK | kraken | took 59183ms 06:34:25 INFO - SUITE-END | took 1173s 06:34:25 INFO - Completed test suite (00:19:33) 06:34:25 INFO - javascript benchmark 06:34:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3308.6029676438825, 3320.302736425352, 3346.514755360472, 3350.229447227139, 3381.966180338196, 5589.524890384312, 5658.971705141474, 5680.233168522248, 5784.074548072309, 5798.9999999999945, 5226.398964119127, 5259.763955470471, 5775.2203452533895, 5806.622569532978, 5868.943590153781, 5127.820526281562, 5185.299984502091, 5218.452062533436, 5230.973845130769, 5252.789888404459, 4336.739795612258, 5141.640085194038, 5232.45059268777, 5247.2653828464045, 5302.787888484456, 140.18384888874579, 5207.6354655174155, 5227.503387178212, 5234.555062819665, 5235.502627250406, 5080.212567052113, 5146.944876300387, 5153.072446959546, 5156.767945442464, 5205.687658740488, 5137.383513978347, 5164.2770012198325, 5165.896682066375, 5168.173092305213, 5211.0, 5551.77792888284, 5567.2762540869835, 5737.282839645044, 5851.444112809277, 5854.736536855809, 6131.570790044699, 6138.938610613882, 6158.907616385758, 6183.196184495987, 6194.721237544321, 5102.948970510284, 6143.754249830002, 6151.446369826737, 6153.876922461525, 6169.96915015422, 5630.0991841305195, 5675.4892059714, 5713.228714123582, 5773.162891380726, 5794.101914203306, 6111.257501106225, 6169.598976066542, 6187.0, 6208.937910620836, 6214.751409943642, 6133.28268084928, 6150.446459818638, 6161.075838624242, 6167.691615419211, 6173.351798061229, 5778.046622307356, 5893.705314734246, 6121.571489995747, 6132.877342453126, 6171.228596425447, 6107.643995706967, 6113.050656958994, 6152.692365381713, 6222.62664240147, 6232.781852635136, 6216.627002379872, 6230.065490176419, 6237.064440333896, 6250.031245157008, 6251.187345645037, 4831.806727730851, 4841.540053694894, 4897.926531102036, 4939.987302602958, 4949.950500495021, 4389.034412429261, 4410.69125161242, 4433.889152771207, 4450.154470650631, 4454.153710794939, 5708.971455142698, 5714.9714251429305, 5728.341240757366, 5729.226554415184, 5740.339860915965, 5983.102534619842, 5986.161937328778, 6054.8183554493435, 6066.423689749467, 6181.320054793969, 5499.697516636544, 5505.779768809283, 5509.311336082989, 5527.198556209408, 5527.944720552823, 5182.844514664566, 5202.66182698131, 5218.657147984913, 5224.242484839677, 5278.340207474066, 6128.105930682418, 6148.415900489446, 6192.535559833031, 6203.596766210182, 6222.471089957314, 6100.969495152496, 6137.723802428991, 6158.846028849135, 6167.691615419121, 6187.381261873777, 5243.449437808975, 6109.009944784197, 6145.985912324416, 6216.502679785697, 6229.345918678474, 6132.601380910227, 6218.9378106218355, 6219.222597175353, 6237.906431403623, 6241.563090583615, 6168.876622467616, 6193.969030154821, 6202.627842329474, 6203.2245969253845, 6209.689515524296, 5956.166136740773, 5984.9401505986125, 6035.1249068885645, 6111.5110791137495, 6112.2970858351855, 6060.212172417558, 6070.0591408331775, 6077.726502307319, 6086.026235802427, 6098.26820781509, 5884.558658100746, 5933.673647949404, 5936.228290322403, 5939.138824870456, 5942.702864856654, 5807.970960145172, 5923.170756094064, 6016.037434010537, 6036.9698151508965, 6096.451319381277, 5921.259842519685, 5924.0, 5927.525797936069, 5928.555358348055, 5947.316058653138], "value": 5597.213379143572, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.7081016382814, 503.959683225342, 527.3065918317412, 531.5083547718363, 556.4102051825063, 30222.0, 31002.2249443764, 34210.8289458553, 43079.0, 43187.13625727483, 44115.55884441155, 44390.556094439045, 44418.33372499407, 44572.3314150288, 44651.88370290744, 9638.662646807346, 9805.901940980606, 9809.21526277896, 9831.803363932717, 9866.0, 8728.0, 8911.242544383735, 8941.552922353889, 9086.318526110535, 9088.454692718426, 11910.0, 12104.213226140273, 12126.211796233216, 12353.197042192274, 12355.938220308886, 12029.097817663667, 12141.514339426412, 12158.209716368408, 12170.513179472811, 12180.903718665319, 8613.48319100856, 11640.825387619192, 11890.167688261825, 12001.279923204636, 12001.819972700416, 41401.75794726163, 41882.555267815296, 41914.79042604767, 41944.370834437505, 41984.580154198375, 3481.686648201674, 3807.3908174691915, 4208.473940757405, 4235.851745188935, 4363.978180109079, 31828.522572161437, 32323.7070517179, 32822.6717732822, 32903.0, 33054.50418243728, 3218.1471909943884, 3319.668033196685, 3381.746369022333, 3383.610884748261, 3396.847141878621, 483230.0, 489418.0, 489869.0, 491231.0, 491268.0, 62081.0, 62250.37749622446, 62304.688476558236, 62399.6880015597, 62406.63153579296, 65502.34497655058, 65574.34425655777, 65685.0, 65722.0, 65773.0, 16176.029438233743, 16860.988340699598, 16867.662646746998, 16873.831261687472, 16963.321467141424, 12997.0, 13064.477420903057, 13069.215847049207, 13078.738425231442, 13099.345032748324, 14753.704925901422, 15084.321205545777, 15104.848951510565, 15431.38274469031, 17086.97478151315, 4897.210424518007, 5491.807786727445, 6284.340144284875, 6363.459105975951, 6401.55189136756, 880.8766772651834, 963.94216347018, 977.2262497698651, 1014.0, 1110.539126262592, 29706.554401683992, 31083.844580776953, 31787.055555278494, 31877.521837172462, 32181.678183218337, 1064.8988346107108, 1128.210252823027, 1161.7560312334335, 1170.5142365918218, 1190.0717440396504, 15520.534383968274, 16007.597910574452, 16272.0, 16500.92743971638, 16775.161241938098, 673619.0, 673919.0, 678505.6074719594, 679091.2545247301, 680479.0, 53136.468635313155, 60360.69819650961, 61346.77306453935, 62446.68776656088, 62464.0, 1401.7546929287334, 1416.7874818777059, 1428.8642578954982, 1429.4425174182286, 1430.6924011337612, 31883.20291992719, 32510.187245319055, 32637.673623263465, 32661.020169394957, 33545.0, 53706.46293537171, 54238.45761542492, 54258.0, 54309.185362220385, 54389.72805135949, 598329.0, 663970.0, 670269.0, 671081.0, 678904.0, 26771.063012794457, 28754.856225719574, 28783.856080719463, 40978.79510602428, 41367.1726565473, 50438.24342634937, 51255.74372128116, 52336.47663523316, 52742.73628631832, 53570.0, 40540.594594053684, 41144.17711645691, 42792.78603606962, 42806.78596606997, 43203.78398107989, 40752.79623601863, 41103.58896410998, 41332.0, 41426.96432589209, 42219.7889010553, 39858.0, 40524.0, 40672.0, 40766.59233407628, 40774.57288994871, 29364.853175733984, 30830.075097746205, 35545.0, 36383.636163638024, 36538.63461365352, 23970.520589587763, 25647.487050258518, 26383.868080659475, 26492.0, 26740.732592673823], "value": 20958.83162369409, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.52047995446117, 377.7261485423069, 387.53882879373543, 390.4163275902526, 409.377745826344, 15624.140672263022, 15860.286287117078, 20673.689894651594, 21192.788072119274, 21243.787562124373, 21145.365639030853, 21549.24577639783, 21828.672569911425, 22368.440788980242, 22392.0, 5214.530692237698, 5914.822555323347, 6032.758689652409, 6040.939590604082, 6058.1518587397795, 6014.578979471439, 6058.757649694029, 6059.545534084961, 6091.329953705089, 6102.969485152568, 5709.914351284734, 5974.283086029683, 5979.073243647242, 5980.342162362137, 5988.461038506533, 5801.88396232073, 5959.0763431668165, 6019.458248757611, 6020.488258498033, 6040.305364883029, 5982.700864956778, 6016.458518733291, 6031.0, 6038.667873266969, 6053.636781793107, 13468.39392227352, 18056.0, 25792.097276595417, 26307.473850523074, 27237.455250894873, 1967.5376286572643, 2108.9156433742633, 2411.8794060296914, 2467.5558399488086, 3016.2308611304197, 9732.854007189897, 9809.0, 10088.293819432643, 10373.273870829045, 10490.00344967227, 1864.6457173137196, 1913.100842603974, 1914.15777058094, 1961.892095934723, 2034.440528854562, 106911.0, 109708.4514577422, 112231.87768122296, 113074.0, 114189.99999999917, 9600.183984361267, 11477.311361318347, 11494.42527873603, 11556.479958401893, 11573.594924177612, 14547.054441461483, 14648.926755366156, 14681.045732027598, 14695.0, 14708.043977141451, 8444.113368096385, 8610.6986255482, 8643.265322447662, 8737.257333126629, 8754.47473151613, 8585.31317494599, 8586.270167035747, 8588.22705956467, 8730.126987301219, 8739.475631462132, 4489.910201795946, 4577.0159415725775, 4600.5629465200755, 4641.628669706415, 4644.256918892961, 1909.8281154696144, 1929.8456123510086, 1938.331275709878, 1949.6588097082954, 1955.8044195580328, 681.8056853796644, 716.9997852995043, 781.1797612506958, 838.9244967952914, 922.1654402765508, 20462.79537204639, 21128.366149015554, 22136.889315553643, 22200.88899555524, 22319.888400557895, 917.3395155488038, 931.8043210925646, 952.2049089010753, 952.9714108576753, 975.5219942228257, 8910.0, 9854.655087071918, 10692.358458492516, 11595.652130435932, 11637.0, 450452.0, 506539.0, 515410.0, 606493.0, 617288.0, 142267.86598201035, 144326.0, 147387.0, 150852.0, 153287.0, 941.75985123793, 967.5017366056486, 984.3995162950595, 987.1757082835769, 1003.1974420463746, 14978.550643480714, 18995.90502047481, 19325.130369133705, 19558.804411955698, 19636.607267854848, 28260.576091359057, 46709.766451167525, 52866.0, 55556.0, 56454.7177264111, 75907.62046189734, 80244.59877700808, 84911.5754421224, 86156.56921715352, 91757.62363564418, 5569.415211402745, 6076.787312444043, 6921.688524016331, 7902.604869756604, 8581.313494920267, 11735.061195104541, 11919.46362413676, 12790.232586044867, 13175.407106680414, 13479.123856949267, 10610.575576977144, 11562.826557601475, 11755.529778809094, 11814.704632384259, 11834.644960651194, 11488.0, 11555.653330400102, 11559.364234967157, 11686.357250351311, 11811.409429528661, 11646.76706465849, 11669.941650291694, 11685.298882067103, 11938.820917686415, 12107.939460302641, 8173.060098088796, 8282.792930176794, 8343.0, 8367.66529338844, 8507.234348908629, 10190.43952582615, 10523.526441310312, 11537.48081336325, 11790.528378864748, 11790.997765189712], "value": 9554.57381133857, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.0626592714736, 1526.488626310186, 1711.2983676692559, 1715.4339068107527, 1964.9782113301092, 8490.53302068386, 8709.564521773902, 8889.466632002084, 8899.288056955436, 8909.376343655947, 7785.143634200248, 8012.238837310446, 8014.7194848180325, 8115.39134564907, 8659.826803463928, 2081.594089152612, 2121.713568668233, 2274.7725227477204, 2337.1118974789642, 2343.320437073247, 2297.597920363938, 2317.6639387288833, 2319.095552734435, 2324.2213858357472, 2328.2316835444262, 2309.3880121767743, 2360.0677732295735, 2365.195833416638, 2367.490989437271, 2367.8105751539833, 2076.1799089359693, 2144.8069673729437, 2145.5923374558784, 2146.35609317205, 2287.2680742162515, 2330.7436182019965, 2371.6205407134776, 2371.6916800815784, 2372.1697405907967, 2381.3213234228333, 8839.77900552485, 8923.955380223122, 8942.552872356422, 8943.0, 8961.193492585699, 5196.2465442511, 5342.2253773202665, 5343.305370301875, 5367.463253674601, 5393.379761327458, 3549.893503194908, 3563.198280386918, 3618.9095272618397, 3674.2835147146316, 3679.19057807282, 1080.0495563903794, 1083.7453198498347, 1086.9673909782719, 1102.7188067042932, 1104.2491106047885, 11689.532418703157, 11706.0, 11750.0, 11755.294682319089, 11756.412179391082, 4487.977560112178, 4613.492515823256, 4673.275642275453, 4687.460941991646, 4739.786709598076, 9868.358556693793, 9869.555869985868, 9880.258980576486, 9886.901130988743, 9921.00789921002, 5179.507946745053, 5240.4759524047295, 5295.576353891679, 5300.681959082467, 5331.866703332447, 4711.764411779397, 4887.926681099786, 4894.437139728977, 4899.240617704261, 4935.654504184673, 3502.176988407722, 3628.292482965849, 3723.94414083789, 3827.559830619459, 3832.9616703833162, 1038.5222797513077, 1154.122866621357, 1154.2670404293167, 1159.7042754097652, 1176.16492290473, 865.1867244789877, 885.7652722028668, 921.6175287255847, 925.4956048953337, 948.0330063335359, 5570.080936645408, 5909.881802363929, 6069.0592958091565, 6126.969365153146, 6322.652254126067, 796.9960150199212, 912.7216199059218, 914.4147745442922, 968.4506284467489, 982.7002764156858, 3481.9129521762156, 3827.655511004023, 4003.8999025024023, 4011.2150093208825, 4096.877093687194, 10474.68575942723, 10615.52230149645, 10708.73228169302, 10783.245172837826, 10786.676399708022, 9081.863772043425, 9767.974362691815, 10134.898651013396, 10744.14046876248, 10765.892341076646, 8199.098099209083, 8302.70940517079, 8319.542425166554, 8323.458975166595, 8341.290990265896, 5774.855628609318, 5844.327902291121, 5954.4938680210935, 6035.6076855004285, 6055.818325450244, 9348.813023739624, 9962.750931226778, 10128.34165779222, 10136.797264054825, 10149.0, 9584.952075239578, 10347.0, 10424.374537527772, 10430.165586753194, 10442.843357349493, 7560.659770310239, 7702.460827742004, 7705.730299439717, 7709.845803084019, 7720.266574675396, 7384.889226661497, 7410.62946852666, 8424.28393586552, 8485.618147183515, 8497.87253191215, 7409.546187697849, 7453.850922981618, 7499.212582678741, 7532.661030253542, 7628.199039100815, 7284.745033923788, 7330.376917962033, 7332.0834895638045, 7425.0, 7475.36459400957, 6811.523193376416, 7046.859062818612, 7060.7881763547175, 7061.364477197077, 7064.152301723826, 4837.371141751691, 4922.7538623067985, 5034.496550344937, 5118.539331460038, 5175.301334319969, 5021.246812978083, 5051.570616497639, 5152.742362881916, 5241.737913104405, 5260.10578201699], "value": 4559.262208147998, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.21164971075194, 303.8936372269706, 312.5187211693992, 317.16743548186014, 319.672335855748, 5382.38102618199, 5434.184872269162, 5439.864003399917, 5439.891202175954, 5495.313085864272, 5052.787331040551, 5071.579957611865, 5199.012187684338, 5339.2914267434435, 5347.652402593829, 4026.939595906064, 4029.2344454553686, 4046.514418269812, 4055.3916912463073, 4083.8979025524304, 3252.804831710105, 3549.396602577568, 3943.783091929957, 4007.8998025049314, 4119.40268661044, 3744.8876533704033, 3890.5100735529286, 3922.705797065217, 4005.9599404006026, 4052.2503336882623, 3252.430824605708, 4005.679545636342, 4017.6986725995666, 4068.552459229468, 4075.205334959669, 3476.2699833035094, 3521.6126226115107, 3536.416491278936, 3536.717062634983, 3541.5041894134843, 4449.933251001237, 4577.450705915278, 4896.779644915988, 5148.974255128738, 5236.538826751421, 4216.304309788881, 4589.770511474447, 4614.284785858197, 4668.786115609932, 4715.986062996472, 4662.552160115933, 5376.11294136467, 5569.470900264469, 5608.457674139644, 5621.325440947072, 3570.321638888629, 3884.9223015539533, 3902.2975864344407, 3911.3546264866263, 3921.156951255465, 4910.582600478963, 5153.845384638467, 5270.761371077832, 5556.972215138899, 5790.478856902899, 3653.89900807037, 3911.1786524829536, 3928.6660633845872, 4036.2936486114813, 4052.49343832021, 3158.2578094147857, 3811.237752449466, 4093.85671501496, 4098.7950602470355, 4124.08230172965, 3973.463582416337, 4264.211120942636, 4511.894585826493, 4688.203005489075, 4708.576228139484, 5059.924101138486, 5496.811849127496, 5547.417521160301, 5560.638558493685, 5624.521915637217, 1364.1542243808901, 1381.6407733989033, 1400.1948879394388, 1401.6124037203097, 1406.6202125426078, 789.9848694427633, 894.4543828264754, 914.7118657622827, 918.6587582130031, 969.9854502182473, 5133.6919784813035, 5177.404598471148, 5178.0, 5200.349956255468, 5238.337879287437, 4860.756962151878, 5342.0, 5710.314762228476, 5758.099827057061, 5768.682722450306, 4844.32179494871, 4866.513348665176, 5148.382194136652, 5172.922406163911, 5179.22311653255, 2511.3344963584664, 2781.554951207797, 2981.0907673159895, 2984.65676447207, 3032.3783624357393, 5534.819664278136, 5927.84407040623, 5944.821655350346, 5946.1972633693895, 5968.8806223876145, 4686.461056978423, 5669.747689233075, 5840.503557197686, 5854.121881717776, 5863.061910094364, 5388.380336261223, 5745.224394706661, 5855.130985816919, 5893.381194974551, 5913.231279933581, 4803.711777293373, 5244.5279924806955, 5435.728213589384, 5497.8075767347955, 5562.666240025612, 4533.773311334354, 4962.578180854668, 5534.252875861707, 5586.497215250647, 5617.7191140442, 4958.0, 5387.676739395649, 5513.173024046425, 5678.943210567842, 5830.271216097988, 3763.228538149618, 3922.9607703922597, 3986.720929534905, 3991.880243592697, 4019.1760689059256, 4763.785629646605, 4893.461719210955, 4953.572749352719, 5639.943600563942, 5664.688442135722, 5545.195946587803, 5546.670398432588, 5548.389677135431, 5552.916706249491, 5556.833295001156, 5047.268146118866, 5342.7061511615675, 5595.608307418442, 5647.209390685225, 5649.6327738696855, 5299.867503312294, 5492.423295554069, 5502.8349149525575, 5529.170624406372, 5538.280023596906, 5019.422766381913, 5586.301712285965, 5617.882075448002, 5622.7750889963945, 5649.672327003069, 4658.37111989877, 5324.9467505326, 5473.808416705556, 5491.7254137292175, 5498.917516237179], "value": 4076.520979005499, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.2116650517925, 730.1967835381079, 748.0387701803184, 764.8317370178562, 795.284244180238, 15545.989510681798, 16614.25235864386, 16617.169141542905, 16639.833601663995, 17630.294788208488, 16590.336386544524, 17456.301747930098, 17465.214065367058, 17493.82506174938, 17776.200070996805, 699.552286536617, 720.3157000849188, 720.3480849830885, 866.8396346675869, 885.6280362247871, 707.4800021983838, 711.7829062136072, 713.1798431803442, 861.5950503263456, 874.3180319350885, 918.4626993208981, 923.529000209891, 925.2505470568827, 925.3430064654103, 926.8609708543738, 922.7185708358948, 924.5192499900048, 925.6297481007583, 927.0405130689771, 929.2333824594737, 546.4781134017044, 562.9894339660319, 682.2529330383272, 688.3082502085372, 693.8993845892368, 15558.222088895624, 15607.141607211599, 15609.843901561066, 15618.297176627078, 15631.296591653288, 13668.248246346448, 14051.43794248229, 14098.85901140996, 14134.717305653932, 14136.434542618283, 13307.733845323039, 13319.408981207163, 13363.799543006862, 13667.726645467135, 13890.23603701796, 4582.381378513891, 4598.333241679971, 4605.286180642006, 4627.444706635191, 4653.464851542082, 120459.0, 121406.0, 121854.0, 122759.38620306931, 122844.0, 11125.221234513507, 11166.218364714392, 11169.106471482262, 11287.717807054725, 11309.377984210783, 21742.13031478723, 21864.12543498274, 21883.562328753334, 21929.12283508674, 21943.561128777335, 7812.218778122142, 7929.405294602928, 8007.519548827089, 8009.959950200212, 8232.753017409488, 4442.400275962704, 4481.551844815493, 4498.482674492409, 4521.706089104264, 4682.297655351656, 3475.3918064339146, 3543.6633519815578, 3577.6422357764013, 3579.427291633326, 3580.03339098442, 584.2871696530226, 596.5853731656457, 602.4006113916594, 610.7587502936316, 620.2742790934617, 582.4379473807796, 588.7792077970761, 616.5714828194451, 627.4259052966485, 635.1171871099176, 8915.28677705782, 9124.81750364989, 9262.120098590623, 9270.563062725289, 9402.576884040234, 531.8457647282322, 562.8770602647662, 626.8009387160981, 628.2586547873461, 632.5635311635049, 4302.096559722493, 4314.180305741899, 4346.9347959780625, 4366.825326986948, 4600.4479462464715, 94176.52911735397, 141862.0, 146075.06145206754, 149774.0, 152147.0, 119803.0, 120482.3975880115, 120534.0, 127185.0, 127660.0, 105065.0, 107669.0, 111363.0, 117300.0, 118552.0, 7125.893111603434, 7219.566825990458, 8786.209241168326, 8957.507337096522, 8963.462411850127, 58468.70765646145, 65177.67411162914, 66667.3333266661, 68377.65811170913, 68505.49756991562, 81606.0, 101280.49359753155, 102260.0, 102423.46364804385, 103997.96002039882, 11547.480363383836, 11571.247868888495, 11606.187566870238, 11662.475188616701, 12178.512859485876, 13487.797683034958, 15047.021943573633, 15429.0, 15445.922770386076, 16120.113393763455, 14501.0, 14554.27228638585, 14656.633584160481, 15177.772333415229, 15233.771493427828, 14069.296535173406, 14222.217778022308, 14490.275486225435, 14920.62698432548, 15030.849691503383, 13059.21644701321, 13329.933350333185, 14299.428022878968, 14725.705485890008, 14785.92607036958, 11516.193866429605, 11626.302421854716, 11667.183297169116, 11815.40922953866, 12459.439325230205, 10559.947200263949, 10908.61819836302, 10964.56141754321, 11622.82565761531, 11962.575740168293], "value": 7927.568849289974, "unit": "score"}], "name": "dromaeo_css", "value": 7407.196128837276, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 111.0, 112.0, 112.0, 111.0, 113.0, 112.0, 112.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 109.0, 128.0, 193.0, 110.0, 103.0, 128.0, 106.0, 141.0, 105.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 184.0, 183.0, 185.0, 182.0, 182.0, 182.0, 182.0, 182.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 74.0, 57.0, 107.0, 58.0, 58.0, 59.0, 67.0, 95.0, 54.0], "value": 70.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 91.0, 92.0, 70.0, 71.0, 68.0, 97.0, 72.0, 66.0, 102.0], "value": 81.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 88.0, 90.0, 86.0, 90.0, 87.0, 91.0, 88.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 119.0, 145.0, 146.0, 96.0, 96.0, 95.0], "value": 107.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 83.0, 86.0, 85.0, 82.0, 85.0, 86.0, 86.0, 87.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 57.0, 56.0, 54.0, 55.0, 54.0, 53.0, 54.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 76.0, 110.0, 113.0, 86.0, 73.0, 71.0, 72.0, 71.0, 72.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 82.0, 82.0, 84.0, 78.0, 74.0, 79.0, 79.0, 85.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 145.0, 145.0, 135.0, 134.0, 142.0, 148.0, 143.0, 203.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 212.0, 167.0, 163.0, 164.0, 167.0, 162.0, 156.0, 160.0, 162.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1451.9, "alertThreshold": 2.0}]} 06:34:25 INFO - Return code: 0 06:34:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:34:25 INFO - # TBPL SUCCESS # 06:34:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:34:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:34:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:34:25 INFO - 2016-07-11 06:34:25.598 screenresolution[1667:9726] starting screenresolution argv=screenresolution get 06:34:25 INFO - 2016-07-11 06:34:25.601 screenresolution[1667:9726] Display 0: 1600x1200x32@60 06:34:25 INFO - 2016-07-11 06:34:25.607 screenresolution[1668:9729] starting screenresolution argv=screenresolution list 06:34:25 INFO - Available Modes on Display 0 06:34:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:34:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:34:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:34:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:34:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:34:25 INFO - Intel Iris: 06:34:25 INFO - Chipset Model: Intel Iris 06:34:25 INFO - Type: GPU 06:34:25 INFO - Bus: Built-In 06:34:25 INFO - VRAM (Dynamic, Max): 1536 MB 06:34:25 INFO - Vendor: Intel (0x8086) 06:34:25 INFO - Device ID: 0x0a2e 06:34:25 INFO - Revision ID: 0x0009 06:34:25 INFO - Displays: 06:34:25 INFO - Display: 06:34:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:34:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:34:25 INFO - Display Serial Number: 1600x1200 60 06:34:25 INFO - Main Display: Yes 06:34:25 INFO - Mirror: Off 06:34:25 INFO - Online: Yes 06:34:25 INFO - Rotation: Supported 06:34:25 INFO - Return code: 0 06:34:25 INFO - Running post-action listener: _resource_record_post_action 06:34:25 INFO - ##### 06:34:25 INFO - ##### Finished run-tests step (success) 06:34:25 INFO - ##### 06:34:25 INFO - Running post-run listener: _resource_record_post_run 06:34:25 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 36836864; Write bytes: 704205312; Read time: 241; Write time: 1951 06:34:25 INFO - TinderboxPrint: CPU usage
53.7% 06:34:25 INFO - TinderboxPrint: I/O read bytes / time
36,836,864 / 241 06:34:25 INFO - TinderboxPrint: I/O write bytes / time
704,205,312 / 1,951 06:34:25 INFO - TinderboxPrint: CPU idle
2,240.4 (46.3%) 06:34:25 INFO - TinderboxPrint: CPU system
968.4 (20.0%) 06:34:25 INFO - TinderboxPrint: CPU user
1,628.8 (33.7%) 06:34:25 INFO - TinderboxPrint: Swap in / out
442,634,240 / 0 06:34:25 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 391864832; Write bytes: 384562688; Read time: 29008; Write time: 834 06:34:25 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 30891520; Write bytes: 294497280; Read time: 187; Write time: 1066 06:34:26 INFO - Running post-run listener: _upload_blobber_files 06:34:26 INFO - Blob upload gear active. 06:34:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:34:26 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 06:34:26 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:34:26 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:34:26 INFO - (blobuploader) - INFO - Open directory for files ... 06:34:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:34:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:34:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:27 INFO - (blobuploader) - INFO - Done attempting. 06:34:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:34:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:34:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:28 INFO - (blobuploader) - INFO - Done attempting. 06:34:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:34:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:34:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:30 INFO - (blobuploader) - INFO - Done attempting. 06:34:30 INFO - (blobuploader) - INFO - Iteration through files over. 06:34:30 INFO - Return code: 0 06:34:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:34:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:34:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e587e56feb7c7ab434bc362a3e958eae75e3b8b8448912632ed73d70de6f857a791aa6a8d67863a1314ac285dee582954a9500f79a12ae706c2b504ae334b1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5129618af1f62b266fd844be7eda739d90e196f506c373db23e20a15ec8ea59ee433fe5b30212b56db14ad704e1bc8e33caa0add8fa7258275b153b055c63cd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f96b6b34eb179275d001d33c5d6aea01612246c64cd742625275e444213811f2fca2c84a503799d8c33eb4092be567247bc27de88636c13e009fc7beb8380691"} 06:34:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:34:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:34:30 INFO - Contents: 06:34:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e587e56feb7c7ab434bc362a3e958eae75e3b8b8448912632ed73d70de6f857a791aa6a8d67863a1314ac285dee582954a9500f79a12ae706c2b504ae334b1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5129618af1f62b266fd844be7eda739d90e196f506c373db23e20a15ec8ea59ee433fe5b30212b56db14ad704e1bc8e33caa0add8fa7258275b153b055c63cd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f96b6b34eb179275d001d33c5d6aea01612246c64cd742625275e444213811f2fca2c84a503799d8c33eb4092be567247bc27de88636c13e009fc7beb8380691"} 06:34:30 INFO - Running post-run listener: copy_logs_to_upload_dir 06:34:30 INFO - Copying logs to upload dir... 06:34:30 INFO - mkdir: /builds/slave/test/build/upload/logs 06:34:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.583209 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-11 06:34:30.707562) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 06:34:30.711503) ========= 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.MDIHrNvfkE/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.4WTDsZEJKt/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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/Fx-Team/sha512/6e587e56feb7c7ab434bc362a3e958eae75e3b8b8448912632ed73d70de6f857a791aa6a8d67863a1314ac285dee582954a9500f79a12ae706c2b504ae334b1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5129618af1f62b266fd844be7eda739d90e196f506c373db23e20a15ec8ea59ee433fe5b30212b56db14ad704e1bc8e33caa0add8fa7258275b153b055c63cd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f96b6b34eb179275d001d33c5d6aea01612246c64cd742625275e444213811f2fca2c84a503799d8c33eb4092be567247bc27de88636c13e009fc7beb8380691"} build_url:https://queue.taskcluster.net/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011093 build_url: 'https://queue.taskcluster.net/v1/task/cvpt4K8xSNS5m7Y0yZyAHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e587e56feb7c7ab434bc362a3e958eae75e3b8b8448912632ed73d70de6f857a791aa6a8d67863a1314ac285dee582954a9500f79a12ae706c2b504ae334b1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5129618af1f62b266fd844be7eda739d90e196f506c373db23e20a15ec8ea59ee433fe5b30212b56db14ad704e1bc8e33caa0add8fa7258275b153b055c63cd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f96b6b34eb179275d001d33c5d6aea01612246c64cd742625275e444213811f2fca2c84a503799d8c33eb4092be567247bc27de88636c13e009fc7beb8380691"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 06:34:30.743871) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:34:30.744220) ========= 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.MDIHrNvfkE/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.4WTDsZEJKt/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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.005209 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:34:30.792855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 06:34:30.793177) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 06:34:30.793517) ========= ========= Total master_lag: 0.18 =========