builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0107 starttime: 1461593797.42 results: success (0) buildid: 20160425062348 builduid: abe90fc74b164da98c10377025c22763 revision: 8551b253f4061db31e4be7829c2f70c2610caf42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 07:16:37.423046) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 07:16:37.423517) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 07:16:37.423789) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 07:16:37.833962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 07:16:37.834280) ========= 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.q8yXeL8ZlS/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.c7FkgiDSq2/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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-04-25 07:16:37-- 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% 136M=0s 2016-04-25 07:16:37 (136 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145319 ========= master_lag: 1.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 07:16:39.191831) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:16:39.192176) ========= 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.q8yXeL8ZlS/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.c7FkgiDSq2/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.034921 ========= master_lag: 0.15 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:16:39.380062) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-25 07:16:39.380417) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8551b253f4061db31e4be7829c2f70c2610caf42 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8551b253f4061db31e4be7829c2f70c2610caf42 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.q8yXeL8ZlS/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.c7FkgiDSq2/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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-04-25 07:16:39,463 truncating revision to first 12 chars 2016-04-25 07:16:39,463 Setting DEBUG logging. 2016-04-25 07:16:39,463 attempt 1/10 2016-04-25 07:16:39,463 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8551b253f406?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 07:16:40,145 unpacking tar archive at: mozilla-aurora-8551b253f406/testing/mozharness/ program finished with exit code 0 elapsedTime=0.913442 ========= master_lag: 2.37 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-25 07:16:42.659691) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 07:16:42.660031) ========= script_repo_revision: 8551b253f4061db31e4be7829c2f70c2610caf42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 07:16:42.660510) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 07:16:42.660789) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 07:16:42.804591) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-04-25 07:16:42.805138) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.q8yXeL8ZlS/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.c7FkgiDSq2/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:16:42 INFO - MultiFileLogger online at 20160425 07:16:42 in /builds/slave/test 07:16:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:16:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:16:42 INFO - {'append_to_log': False, 07:16:42 INFO - 'base_work_dir': '/builds/slave/test', 07:16:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:16:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:16:42 INFO - 'branch': 'Mozilla-Aurora', 07:16:42 INFO - 'buildbot_json_path': 'buildprops.json', 07:16:42 INFO - 'config_files': ('talos/mac_config.py',), 07:16:42 INFO - 'default_actions': ('clobber', 07:16:42 INFO - 'read-buildbot-config', 07:16:42 INFO - 'download-and-extract', 07:16:42 INFO - 'populate-webroot', 07:16:42 INFO - 'create-virtualenv', 07:16:42 INFO - 'install', 07:16:42 INFO - 'run-tests'), 07:16:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:16:42 INFO - 'download_minidump_stackwalk': True, 07:16:42 INFO - 'download_symbols': 'ondemand', 07:16:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:16:42 INFO - 'tooltool.py': '/tools/tooltool.py', 07:16:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:16:42 INFO - '/tools/misc-python/virtualenv.py')}, 07:16:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:16:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:16:42 INFO - 'installer_path': 'installer.exe', 07:16:42 INFO - 'log_level': 'info', 07:16:42 INFO - 'log_name': 'talos', 07:16:42 INFO - 'log_to_console': True, 07:16:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:16:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:16:42 INFO - 'opt_config_files': (), 07:16:42 INFO - 'pip_index': False, 07:16:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:16:42 INFO - 'cmd': ('bash', 07:16:42 INFO - '-c', 07:16:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:16:42 INFO - 'enabled': True, 07:16:42 INFO - 'halt_on_failure': False, 07:16:42 INFO - 'name': 'check_screen_resolution'},), 07:16:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:16:42 INFO - 'cmd': ('bash', 07:16:42 INFO - '-c', 07:16:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:16:42 INFO - 'enabled': True, 07:16:42 INFO - 'halt_on_failure': False, 07:16:42 INFO - 'name': 'check_screen_resolution'},), 07:16:42 INFO - 'run_cmd_checks_enabled': True, 07:16:42 INFO - 'sps_profile': False, 07:16:42 INFO - 'sps_profile_interval': 0, 07:16:42 INFO - 'suite': 'dromaeojs', 07:16:42 INFO - 'system_bits': '32', 07:16:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:16:42 INFO - 'title': 't-yosemite-r7-0107', 07:16:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:16:42 INFO - 'use_talos_json': True, 07:16:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:16:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:16:42 INFO - 'work_dir': 'build'} 07:16:43 INFO - ##### 07:16:43 INFO - ##### Running clobber step. 07:16:43 INFO - ##### 07:16:43 INFO - Running pre-action listener: _resource_record_pre_action 07:16:43 INFO - Running main action method: clobber 07:16:43 INFO - rmtree: /builds/slave/test/build 07:16:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:16:44 INFO - Running post-action listener: _resource_record_post_action 07:16:44 INFO - ##### 07:16:44 INFO - ##### Running read-buildbot-config step. 07:16:44 INFO - ##### 07:16:44 INFO - Running pre-action listener: _resource_record_pre_action 07:16:44 INFO - Running main action method: read_buildbot_config 07:16:44 INFO - Using buildbot properties: 07:16:44 INFO - { 07:16:44 INFO - "project": "", 07:16:44 INFO - "product": "firefox", 07:16:44 INFO - "script_repo_revision": "production", 07:16:44 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:16:44 INFO - "repository": "", 07:16:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:16:44 INFO - "buildid": "20160425062348", 07:16:44 INFO - "pgo_build": "False", 07:16:44 INFO - "basedir": "/builds/slave/test", 07:16:44 INFO - "buildnumber": 197, 07:16:44 INFO - "slavename": "t-yosemite-r7-0107", 07:16:44 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:16:44 INFO - "platform": "yosemite_r7", 07:16:44 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:16:44 INFO - "branch": "mozilla-aurora", 07:16:44 INFO - "repo_path": "releases/mozilla-aurora", 07:16:44 INFO - "revision": "8551b253f4061db31e4be7829c2f70c2610caf42", 07:16:44 INFO - "stage_platform": "macosx64", 07:16:44 INFO - "builduid": "abe90fc74b164da98c10377025c22763", 07:16:44 INFO - "slavebuilddir": "test" 07:16:44 INFO - } 07:16:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 07:16:44 INFO - Running post-action listener: _resource_record_post_action 07:16:44 INFO - ##### 07:16:44 INFO - ##### Running download-and-extract step. 07:16:44 INFO - ##### 07:16:44 INFO - Running pre-action listener: _resource_record_pre_action 07:16:44 INFO - Running main action method: download_and_extract 07:16:44 INFO - mkdir: /builds/slave/test/build/tests 07:16: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')]} 07:16:44 INFO - https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:16:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 07:16:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 07:16:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 07:16:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 07:16:48 INFO - Downloaded 1277 bytes. 07:16:48 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 07:16:48 INFO - Using the following test package requirements: 07:16:48 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 07:16:48 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 07:16:48 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 07:16:48 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 07:16:48 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 07:16:48 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 07:16:48 INFO - u'jsshell-mac.zip'], 07:16:48 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 07:16:48 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 07:16:48 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 07:16:48 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 07:16:48 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 07:16:48 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 07:16:48 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 07:16:48 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 07:16:48 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 07:16:48 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 07:16:48 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 07:16:48 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 07:16:48 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:16: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')]} 07:16:48 INFO - https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:16:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 07:16:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 07:16:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 07:16:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:16:50 INFO - Downloaded 17919011 bytes. 07:16:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:16:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:16:53 INFO - Return code: 0 07:16:53 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:53 INFO - https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:16:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 07:16:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 07:16:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 07:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:16:58 INFO - Downloaded 17919011 bytes. 07:16:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:16:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:17:02 INFO - Return code: 0 07:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:02 INFO - https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:17:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 07:17:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 07:17:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 07:17:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:17:03 INFO - Downloaded 10845194 bytes. 07:17:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:17:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:17:04 INFO - Return code: 0 07:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:17:04 INFO - https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 07:17:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 07:17:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 07:17:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 07:17:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 07:17:07 INFO - Downloaded 115767664 bytes. 07:17:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 07:17:07 INFO - mkdir: /builds/slave/test/properties 07:17:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:17:07 INFO - Writing to file /builds/slave/test/properties/build_url 07:17:07 INFO - Contents: 07:17:07 INFO - build_url:https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 07:17:07 INFO - Running post-action listener: _resource_record_post_action 07:17:07 INFO - Running post-action listener: set_extra_try_arguments 07:17:07 INFO - ##### 07:17:07 INFO - ##### Running populate-webroot step. 07:17:07 INFO - ##### 07:17:07 INFO - Running pre-action listener: _resource_record_pre_action 07:17:07 INFO - Running main action method: populate_webroot 07:17:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:17:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:17:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:17:07 INFO - '--tppagecycles', 07:17:07 INFO - '7'], 07:17:07 INFO - 'tests': ['tsvgm']}}, 07:17:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:17:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:17:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:17:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:17:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:17:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:17:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:07 INFO - 'talos_options': ['--e10s'], 07:17:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:07 INFO - 'tests': ['damp', 'tps']}, 07:17:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:07 INFO - 'talos_options': ['--e10s'], 07:17:07 INFO - 'tests': ['damp', 'tps']}, 07:17:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:17:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:17:07 INFO - 'other': {'tests': ['a11yr', 07:17:07 INFO - 'ts_paint', 07:17:07 INFO - 'tpaint', 07:17:07 INFO - 'sessionrestore', 07:17:07 INFO - 'sessionrestore_no_auto_restore', 07:17:07 INFO - 'tabpaint']}, 07:17:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:17:07 INFO - 'tests': ['a11yr', 07:17:07 INFO - 'ts_paint', 07:17:07 INFO - 'tpaint', 07:17:07 INFO - 'sessionrestore', 07:17:07 INFO - 'sessionrestore_no_auto_restore', 07:17:07 INFO - 'tabpaint']}, 07:17:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:17:07 INFO - 'tests': ['a11yr', 07:17:07 INFO - 'ts_paint', 07:17:07 INFO - 'tpaint', 07:17:07 INFO - 'sessionrestore', 07:17:07 INFO - 'sessionrestore_no_auto_restore', 07:17:07 INFO - 'tabpaint']}, 07:17:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:17:07 INFO - 'tests': ['a11yr', 07:17:07 INFO - 'ts_paint', 07:17:07 INFO - 'tpaint', 07:17:07 INFO - 'sessionrestore', 07:17:07 INFO - 'sessionrestore_no_auto_restore', 07:17:07 INFO - 'tabpaint']}, 07:17:07 INFO - 'other_l64': {'tests': ['a11yr', 07:17:07 INFO - 'ts_paint', 07:17:07 INFO - 'tpaint', 07:17:07 INFO - 'sessionrestore', 07:17:07 INFO - 'sessionrestore_no_auto_restore', 07:17:07 INFO - 'tabpaint']}, 07:17:07 INFO - 'other_nol64': {'tests': ['a11yr', 07:17:07 INFO - 'ts_paint', 07:17:07 INFO - 'tpaint', 07:17:07 INFO - 'sessionrestore', 07:17:07 INFO - 'sessionrestore_no_auto_restore', 07:17:07 INFO - 'tabpaint']}, 07:17:07 INFO - 'svgr': {'tests': ['tsvgx', 07:17:07 INFO - 'tsvgr_opacity', 07:17:07 INFO - 'tart', 07:17:07 INFO - 'tscrollx', 07:17:07 INFO - 'cart']}, 07:17:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:17:07 INFO - 'tests': ['tsvgx', 07:17:07 INFO - 'tsvgr_opacity', 07:17:07 INFO - 'tart', 07:17:07 INFO - 'tscrollx', 07:17:07 INFO - 'cart']}, 07:17:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:07 INFO - 'tests': ['tp5o']}, 07:17:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:07 INFO - 'talos_options': ['--e10s'], 07:17:07 INFO - 'tests': ['tp5o']}, 07:17:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:07 INFO - 'talos_options': ['--xperf_path', 07:17:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:07 INFO - 'tests': ['tp5n']}, 07:17:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:07 INFO - 'talos_options': ['--e10s', 07:17:07 INFO - '--xperf_path', 07:17:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:07 INFO - 'tests': ['tp5n']}}, 07:17:07 INFO - 'talos.zip': {'path': '', 07:17:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:17:07 INFO - Running post-action listener: _resource_record_post_action 07:17:07 INFO - ##### 07:17:07 INFO - ##### Running create-virtualenv step. 07:17:07 INFO - ##### 07:17:07 INFO - Running pre-action listener: _resource_record_pre_action 07:17:07 INFO - Running main action method: create_virtualenv 07:17:07 INFO - Creating virtualenv /builds/slave/test/build/venv 07:17:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:17:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:17:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:17:07 INFO - Using real prefix '/tools/python27' 07:17:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:17:08 INFO - Installing distribute.............................................................................................................................................................................................done. 07:17:11 INFO - Installing pip.................done. 07:17:11 INFO - Return code: 0 07:17:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:17:11 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')]} 07:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:11 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')]} 07:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:11 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 0x101e8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf3248a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d31d30>, '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 0x101b95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d28b20>, '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.q8yXeL8ZlS/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.c7FkgiDSq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:17:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q8yXeL8ZlS/Render', 07:17:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:11 INFO - 'HOME': '/Users/cltbld', 07:17:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:11 INFO - 'LOGNAME': 'cltbld', 07:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:11 INFO - 'MOZ_NO_REMOTE': '1', 07:17:11 INFO - 'NO_EM_RESTART': '1', 07:17:11 INFO - 'PAGER': '/bin/cat', 07:17:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:11 INFO - 'PWD': '/builds/slave/test', 07:17:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:11 INFO - 'SHELL': '/bin/bash', 07:17:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c7FkgiDSq2/Listeners', 07:17:11 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 07:17:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:11 INFO - 'USER': 'cltbld', 07:17:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:11 INFO - 'XPC_FLAGS': '0x0', 07:17:11 INFO - 'XPC_SERVICE_NAME': '0', 07:17:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:17:11 INFO - Cleaning up... 07:17:11 INFO - Return code: 0 07:17:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:17:11 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')]} 07:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:11 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')]} 07:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:11 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf3248a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d31d30>, '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 0x101b95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d28b20>, '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.q8yXeL8ZlS/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.c7FkgiDSq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:11 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>=0.7.1'] in /builds/slave/test/build 07:17:11 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>=0.7.1 07:17:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q8yXeL8ZlS/Render', 07:17:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:11 INFO - 'HOME': '/Users/cltbld', 07:17:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:11 INFO - 'LOGNAME': 'cltbld', 07:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:11 INFO - 'MOZ_NO_REMOTE': '1', 07:17:11 INFO - 'NO_EM_RESTART': '1', 07:17:11 INFO - 'PAGER': '/bin/cat', 07:17:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:11 INFO - 'PWD': '/builds/slave/test', 07:17:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:11 INFO - 'SHELL': '/bin/bash', 07:17:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c7FkgiDSq2/Listeners', 07:17:11 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 07:17:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:11 INFO - 'USER': 'cltbld', 07:17:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:11 INFO - 'XPC_FLAGS': '0x0', 07:17:11 INFO - 'XPC_SERVICE_NAME': '0', 07:17:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:12 INFO - Downloading/unpacking psutil>=0.7.1 07:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:17:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:17:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:17:14 INFO - Installing collected packages: psutil 07:17:14 INFO - Running setup.py install for psutil 07:17:15 INFO - building 'psutil._psutil_osx' extension 07:17:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:17:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:17:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:17:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:17:15 INFO - building 'psutil._psutil_posix' extension 07:17:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:17:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:17:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:17:15 INFO - ^ 07:17:16 INFO - 1 warning generated. 07:17:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:17:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:17:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:17:16 INFO - Successfully installed psutil 07:17:16 INFO - Cleaning up... 07:17:16 INFO - Return code: 0 07:17:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf3248a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d31d30>, '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 0x101b95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d28b20>, '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.q8yXeL8ZlS/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.c7FkgiDSq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:17:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q8yXeL8ZlS/Render', 07:17:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:16 INFO - 'HOME': '/Users/cltbld', 07:17:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:16 INFO - 'LOGNAME': 'cltbld', 07:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:16 INFO - 'MOZ_NO_REMOTE': '1', 07:17:16 INFO - 'NO_EM_RESTART': '1', 07:17:16 INFO - 'PAGER': '/bin/cat', 07:17:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:16 INFO - 'PWD': '/builds/slave/test', 07:17:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:16 INFO - 'SHELL': '/bin/bash', 07:17:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c7FkgiDSq2/Listeners', 07:17:16 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 07:17:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:16 INFO - 'USER': 'cltbld', 07:17:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:16 INFO - 'XPC_FLAGS': '0x0', 07:17:16 INFO - 'XPC_SERVICE_NAME': '0', 07:17:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:17:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:17:19 INFO - Installing collected packages: mozsystemmonitor 07:17:19 INFO - Running setup.py install for mozsystemmonitor 07:17:19 INFO - Successfully installed mozsystemmonitor 07:17:19 INFO - Cleaning up... 07:17:19 INFO - Return code: 0 07:17:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:17:19 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')]} 07:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:19 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')]} 07:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:19 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 0x101e8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf3248a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d31d30>, '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 0x101b95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d28b20>, '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.q8yXeL8ZlS/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.c7FkgiDSq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:17:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q8yXeL8ZlS/Render', 07:17:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:19 INFO - 'HOME': '/Users/cltbld', 07:17:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:19 INFO - 'LOGNAME': 'cltbld', 07:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:19 INFO - 'MOZ_NO_REMOTE': '1', 07:17:19 INFO - 'NO_EM_RESTART': '1', 07:17:19 INFO - 'PAGER': '/bin/cat', 07:17:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:19 INFO - 'PWD': '/builds/slave/test', 07:17:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:19 INFO - 'SHELL': '/bin/bash', 07:17:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c7FkgiDSq2/Listeners', 07:17:19 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 07:17:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:19 INFO - 'USER': 'cltbld', 07:17:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:19 INFO - 'XPC_FLAGS': '0x0', 07:17:19 INFO - 'XPC_SERVICE_NAME': '0', 07:17:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:19 INFO - Downloading/unpacking blobuploader==1.2.4 07:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:21 INFO - Downloading blobuploader-1.2.4.tar.gz 07:17:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:17:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:17:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:23 INFO - Downloading docopt-0.6.1.tar.gz 07:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:17:23 INFO - Installing collected packages: blobuploader, requests, docopt 07:17:23 INFO - Running setup.py install for blobuploader 07:17:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:17:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:17:23 INFO - Running setup.py install for requests 07:17:23 INFO - Running setup.py install for docopt 07:17:23 INFO - Successfully installed blobuploader requests docopt 07:17:23 INFO - Cleaning up... 07:17:24 INFO - Return code: 0 07:17:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17: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')]} 07:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17: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')]} 07:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:24 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 0x101e8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf3248a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d31d30>, '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 0x101b95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d28b20>, '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.q8yXeL8ZlS/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.c7FkgiDSq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:17:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q8yXeL8ZlS/Render', 07:17:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:24 INFO - 'HOME': '/Users/cltbld', 07:17:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:24 INFO - 'LOGNAME': 'cltbld', 07:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:24 INFO - 'MOZ_NO_REMOTE': '1', 07:17:24 INFO - 'NO_EM_RESTART': '1', 07:17:24 INFO - 'PAGER': '/bin/cat', 07:17:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:24 INFO - 'PWD': '/builds/slave/test', 07:17:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:24 INFO - 'SHELL': '/bin/bash', 07:17:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c7FkgiDSq2/Listeners', 07:17:24 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 07:17:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:24 INFO - 'USER': 'cltbld', 07:17:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:24 INFO - 'XPC_FLAGS': '0x0', 07:17:24 INFO - 'XPC_SERVICE_NAME': '0', 07:17:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:17:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-6jrIpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:17:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-D9jr7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:17:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-stTuZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:17:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-9HZUZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:17:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-qJYKfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:17:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-z2dhky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:17:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-qJ0lqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:17:25 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-3hSHa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:17:25 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-wp7rkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:17:25 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-S6EFvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:17:25 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-rWAWXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:17:25 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-sEhLQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:17:25 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-496fe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:17:25 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-7Xz4gQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:25 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-XMwDNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:17:25 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-zx9TEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:17:25 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-uyrxEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:17:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:17:26 INFO - Running setup.py install for manifestparser 07:17:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:17:26 INFO - Running setup.py install for mozcrash 07:17:26 INFO - Running setup.py install for mozdebug 07:17:26 INFO - Running setup.py install for mozdevice 07:17:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:17:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:17:26 INFO - Running setup.py install for mozfile 07:17:26 INFO - Running setup.py install for mozhttpd 07:17:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:17:26 INFO - Running setup.py install for mozinfo 07:17:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:17:27 INFO - Running setup.py install for mozInstall 07:17:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:17:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:17:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:17:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:17:27 INFO - Running setup.py install for mozleak 07:17:27 INFO - Running setup.py install for mozlog 07:17:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:17:27 INFO - Running setup.py install for moznetwork 07:17:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:17:27 INFO - Running setup.py install for mozprocess 07:17:27 INFO - Running setup.py install for mozprofile 07:17:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:17:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:17:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:17:28 INFO - Running setup.py install for mozrunner 07:17:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:17:28 INFO - Running setup.py install for mozscreenshot 07:17:28 INFO - Running setup.py install for moztest 07:17:28 INFO - Running setup.py install for mozversion 07:17:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:17:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:17:28 INFO - Cleaning up... 07:17:28 INFO - Return code: 0 07:17:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:28 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 0x101e8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf3248a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d31d30>, '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 0x101b95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d28b20>, '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.q8yXeL8ZlS/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.c7FkgiDSq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q8yXeL8ZlS/Render', 07:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:28 INFO - 'HOME': '/Users/cltbld', 07:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:28 INFO - 'LOGNAME': 'cltbld', 07:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:28 INFO - 'MOZ_NO_REMOTE': '1', 07:17:28 INFO - 'NO_EM_RESTART': '1', 07:17:28 INFO - 'PAGER': '/bin/cat', 07:17:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:28 INFO - 'PWD': '/builds/slave/test', 07:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:28 INFO - 'SHELL': '/bin/bash', 07:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c7FkgiDSq2/Listeners', 07:17:28 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 07:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:28 INFO - 'USER': 'cltbld', 07:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:28 INFO - 'XPC_FLAGS': '0x0', 07:17:28 INFO - 'XPC_SERVICE_NAME': '0', 07:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:17:28 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-2eM99g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:17:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-kMkKDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:17:29 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)) 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:17:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-H07BCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:17:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Vy4koY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:17:29 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)) 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:17:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-zUe8O3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:17:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-DH6Rui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:17:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-hzYpgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:17:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-hnXJid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:17:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-GEtACo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:17:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-nv1HuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:17:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-dRsW5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:17:30 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-uvhaVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:17:30 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-zHL7qA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:17:30 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-E7XnH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:30 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-oBaqP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:17:30 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-lOqA1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:17:30 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)) 07:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:17:30 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-YsXO4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:17:30 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)) 07:17:30 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)) 07:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:17:30 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)) 07:17:30 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)) 07:17:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:33 INFO - Downloading blessings-1.6.tar.gz 07:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:17:33 INFO - Installing collected packages: blessings 07:17:33 INFO - Running setup.py install for blessings 07:17:33 INFO - Successfully installed blessings 07:17:33 INFO - Cleaning up... 07:17:33 INFO - Return code: 0 07:17:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:17:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:17:33 INFO - Reading from file tmpfile_stdout 07:17:33 INFO - Current package versions: 07:17:33 INFO - blessings == 1.6 07:17:33 INFO - blobuploader == 1.2.4 07:17:33 INFO - docopt == 0.6.1 07:17:33 INFO - manifestparser == 1.1 07:17:33 INFO - mozInstall == 1.12 07:17:33 INFO - mozcrash == 0.17 07:17:33 INFO - mozdebug == 0.1 07:17:33 INFO - mozdevice == 0.48 07:17:33 INFO - mozfile == 1.2 07:17:33 INFO - mozhttpd == 0.7 07:17:33 INFO - mozinfo == 0.9 07:17:33 INFO - mozleak == 0.1 07:17:33 INFO - mozlog == 3.1 07:17:33 INFO - moznetwork == 0.27 07:17:33 INFO - mozprocess == 0.22 07:17:33 INFO - mozprofile == 0.28 07:17:33 INFO - mozrunner == 6.11 07:17:33 INFO - mozscreenshot == 0.1 07:17:33 INFO - mozsystemmonitor == 0.0 07:17:33 INFO - moztest == 0.7 07:17:33 INFO - mozversion == 1.4 07:17:33 INFO - psutil == 3.1.1 07:17:33 INFO - requests == 1.2.3 07:17:33 INFO - wsgiref == 0.1.2 07:17:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:33 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 0x101e8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf3248a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d31d30>, '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 0x101b95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d28b20>, '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.q8yXeL8ZlS/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.c7FkgiDSq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:17:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q8yXeL8ZlS/Render', 07:17:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:33 INFO - 'HOME': '/Users/cltbld', 07:17:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:33 INFO - 'LOGNAME': 'cltbld', 07:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:33 INFO - 'MOZ_NO_REMOTE': '1', 07:17:33 INFO - 'NO_EM_RESTART': '1', 07:17:33 INFO - 'PAGER': '/bin/cat', 07:17:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:33 INFO - 'PWD': '/builds/slave/test', 07:17:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:33 INFO - 'SHELL': '/bin/bash', 07:17:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c7FkgiDSq2/Listeners', 07:17:33 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 07:17:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:33 INFO - 'USER': 'cltbld', 07:17:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:33 INFO - 'XPC_FLAGS': '0x0', 07:17:33 INFO - 'XPC_SERVICE_NAME': '0', 07:17:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:17:34 INFO - Cleaning up... 07:17:34 INFO - Return code: 0 07:17:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:17: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')]} 07:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17: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')]} 07:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:34 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 0x101e8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf3248a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d31d30>, '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 0x101b95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d28b20>, '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.q8yXeL8ZlS/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.c7FkgiDSq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:17:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q8yXeL8ZlS/Render', 07:17:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:34 INFO - 'HOME': '/Users/cltbld', 07:17:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:34 INFO - 'LOGNAME': 'cltbld', 07:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:34 INFO - 'MOZ_NO_REMOTE': '1', 07:17:34 INFO - 'NO_EM_RESTART': '1', 07:17:34 INFO - 'PAGER': '/bin/cat', 07:17:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:34 INFO - 'PWD': '/builds/slave/test', 07:17:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:34 INFO - 'SHELL': '/bin/bash', 07:17:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c7FkgiDSq2/Listeners', 07:17:34 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 07:17:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:34 INFO - 'USER': 'cltbld', 07:17:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:34 INFO - 'XPC_FLAGS': '0x0', 07:17:34 INFO - 'XPC_SERVICE_NAME': '0', 07:17:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:34 INFO - Downloading/unpacking jsonschema 07:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:17:36 INFO - Downloading/unpacking functools32 (from jsonschema) 07:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:37 INFO - Downloading functools32-3.2.3-2.tar.gz 07:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:17:37 INFO - warning: no files found matching '*.txt' 07:17:37 INFO - no previously-included directories found matching 'build' 07:17:37 INFO - no previously-included directories found matching 'dist' 07:17:37 INFO - no previously-included directories found matching '.git*' 07:17:37 INFO - Installing collected packages: jsonschema, functools32 07:17:37 INFO - Running setup.py install for functools32 07:17:37 INFO - warning: no files found matching '*.txt' 07:17:37 INFO - no previously-included directories found matching 'build' 07:17:37 INFO - no previously-included directories found matching 'dist' 07:17:37 INFO - no previously-included directories found matching '.git*' 07:17:37 INFO - Successfully installed jsonschema functools32 07:17:37 INFO - Cleaning up... 07:17:37 INFO - Return code: 0 07:17:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf3248a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d31d30>, '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 0x101b95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d28b20>, '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.q8yXeL8ZlS/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.c7FkgiDSq2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:17:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q8yXeL8ZlS/Render', 07:17:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:37 INFO - 'HOME': '/Users/cltbld', 07:17:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:37 INFO - 'LOGNAME': 'cltbld', 07:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:37 INFO - 'MOZ_NO_REMOTE': '1', 07:17:37 INFO - 'NO_EM_RESTART': '1', 07:17:37 INFO - 'PAGER': '/bin/cat', 07:17:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:37 INFO - 'PWD': '/builds/slave/test', 07:17:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:37 INFO - 'SHELL': '/bin/bash', 07:17:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c7FkgiDSq2/Listeners', 07:17:37 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 07:17:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:37 INFO - 'USER': 'cltbld', 07:17:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:37 INFO - 'XPC_FLAGS': '0x0', 07:17:37 INFO - 'XPC_SERVICE_NAME': '0', 07:17:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:37 INFO - Downloading/unpacking flake8 07:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:17:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:17:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:17:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:17:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:17:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:17:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:17:41 INFO - no previously-included directories found matching 'docs/_build' 07:17:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:17:41 INFO - Running setup.py install for pep8 07:17:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:17:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:17:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:17:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:17:41 INFO - no previously-included directories found matching 'docs/_build' 07:17:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:17:41 INFO - Cleaning up... 07:17:41 INFO - Return code: 0 07:17:41 INFO - Running post-action listener: _resource_record_post_action 07:17:41 INFO - Running post-action listener: _start_resource_monitoring 07:17:41 INFO - Starting resource monitoring. 07:17:41 INFO - ##### 07:17:41 INFO - ##### Running install step. 07:17:41 INFO - ##### 07:17:41 INFO - Running pre-action listener: _resource_record_pre_action 07:17:41 INFO - Running main action method: install 07:17:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:17:42 INFO - Reading from file tmpfile_stdout 07:17:42 INFO - Detecting whether we're running mozinstall >=1.0... 07:17:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:17:42 INFO - Reading from file tmpfile_stdout 07:17:42 INFO - Output received: 07:17:42 INFO - Usage: mozinstall [options] installer 07:17:42 INFO - Options: 07:17:42 INFO - -h, --help show this help message and exit 07:17:42 INFO - -d DEST, --destination=DEST 07:17:42 INFO - Directory to install application into. [default: 07:17:42 INFO - "/builds/slave/test"] 07:17:42 INFO - --app=APP Application being installed. [default: firefox] 07:17:42 INFO - mkdir: /builds/slave/test/build/application 07:17:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:18:14 INFO - Reading from file tmpfile_stdout 07:18:14 INFO - Output received: 07:18:14 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:18:14 INFO - Running post-action listener: _resource_record_post_action 07:18:14 INFO - ##### 07:18:14 INFO - ##### Running run-tests step. 07:18:14 INFO - ##### 07:18:14 INFO - Running pre-action listener: _resource_record_pre_action 07:18:14 INFO - Running main action method: run_tests 07:18:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:18:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:18:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:18:15 INFO - 2016-04-25 07:18:15.002 screenresolution[1643:7583] starting screenresolution argv=screenresolution get 07:18:15 INFO - 2016-04-25 07:18:15.005 screenresolution[1643:7583] Display 0: 1600x1200x32@60 07:18:15 INFO - 2016-04-25 07:18:15.011 screenresolution[1644:7585] starting screenresolution argv=screenresolution list 07:18:15 INFO - Available Modes on Display 0 07:18:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:18:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:18:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:18:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:18:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:18:15 INFO - Intel Iris: 07:18:15 INFO - Chipset Model: Intel Iris 07:18:15 INFO - Type: GPU 07:18:15 INFO - Bus: Built-In 07:18:15 INFO - VRAM (Dynamic, Max): 1536 MB 07:18:15 INFO - Vendor: Intel (0x8086) 07:18:15 INFO - Device ID: 0x0a2e 07:18:15 INFO - Revision ID: 0x0009 07:18:15 INFO - Displays: 07:18:15 INFO - Display: 07:18:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:18:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:18:15 INFO - Display Serial Number: 1600x1200 60 07:18:15 INFO - Main Display: Yes 07:18:15 INFO - Mirror: Off 07:18:15 INFO - Online: Yes 07:18:15 INFO - Rotation: Supported 07:18:15 INFO - Return code: 0 07:18:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:18:15 INFO - Python 2.7.3 07:18:15 INFO - Return code: 0 07:18:15 INFO - grabbing minidump binary from tooltool 07:18: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')]} 07:18:15 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d31d30>, '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 0x101b95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d28b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:18:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:18:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:18:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:18:15 INFO - Return code: 0 07:18:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:18:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:18:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:18:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:18:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:18:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:18:16 INFO - Return code: 0 07:18:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0107', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:18:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0107 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:18:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q8yXeL8ZlS/Render', 07:18:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:18:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:18:16 INFO - 'HOME': '/Users/cltbld', 07:18:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:18:16 INFO - 'LOGNAME': 'cltbld', 07:18:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:18:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:18:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:16 INFO - 'MOZ_NO_REMOTE': '1', 07:18:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:18:16 INFO - 'NO_EM_RESTART': '1', 07:18:16 INFO - 'PAGER': '/bin/cat', 07:18:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:18:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:16 INFO - 'PWD': '/builds/slave/test', 07:18:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:18:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:18:16 INFO - 'SHELL': '/bin/bash', 07:18:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c7FkgiDSq2/Listeners', 07:18:16 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 07:18:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:18:16 INFO - 'USER': 'cltbld', 07:18:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:18:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:18:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:16 INFO - 'XPC_FLAGS': '0x0', 07:18:16 INFO - 'XPC_SERVICE_NAME': '0', 07:18:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:18:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0107', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:18:16 INFO - mozversion application_buildid: 20160425062348 07:18:16 INFO - mozversion application_changeset: 8551b253f4061db31e4be7829c2f70c2610caf42 07:18:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:18:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:18:16 INFO - mozversion application_name: Firefox 07:18:16 INFO - mozversion application_remotingname: firefox-dev 07:18:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:18:16 INFO - mozversion application_vendor: Mozilla 07:18:16 INFO - mozversion application_version: 47.0a2 07:18:16 INFO - mozversion platform_buildid: 20160425062348 07:18:16 INFO - mozversion platform_changeset: 8551b253f4061db31e4be7829c2f70c2610caf42 07:18:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:18:16 INFO - mozversion platform_version: 47.0a2 07:18:16 INFO - using testdate: 1461593896 07:18:16 INFO - actual date: 1461593896 07:18:16 INFO - starting webserver on 'localhost:49270' 07:18:16 INFO - SUITE-START | Running 2 tests 07:18:16 INFO - TEST-START | dromaeo_css 07:18:16 INFO - operating with platform_type : mac_ 07:18:16 INFO - Initialising browser for dromaeo_css test... 07:18:16 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpDgVEyd/profile http://localhost:49270/getInfo.html) 07:18:19 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 07:18:19 INFO - PROCESS | 1662 | colorDepth:24 07:18:19 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 07:18:19 INFO - PROCESS | 1662 | __metrics 07:18:19 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" 07:18:19 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:18:19 INFO - TEST-INFO | 1662: exit 0 07:18:19 INFO - Browser initialized. 07:18:19 INFO - Running cycle 1/1 for dromaeo_css test... 07:18:19 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpDgVEyd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:18:31 INFO - PROCESS | 1664 | RSS: Main: 207540224 07:18:31 INFO - PROCESS | 1664 | 07:19:22 INFO - PROCESS | 1664 | 1461593962741 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] 07:21:32 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 07:21:34 INFO - PROCESS | 1664 | RSS: Main: 337039360 07:21:34 INFO - PROCESS | 1664 | 07:24:36 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 07:24:37 INFO - PROCESS | 1664 | RSS: Main: 346288128 07:24:37 INFO - PROCESS | 1664 | 07:27:39 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 07:27:39 INFO - PROCESS | 1664 | RSS: Main: 349265920 07:27:39 INFO - PROCESS | 1664 | 07:30:41 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 07:30:42 INFO - PROCESS | 1664 | RSS: Main: 311009280 07:30:42 INFO - PROCESS | 1664 | 07:33:45 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 07:33:45 INFO - PROCESS | 1664 | RSS: Main: 308834304 07:33:45 INFO - PROCESS | 1664 | 07:36:48 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 07:36:48 INFO - PROCESS | 1664 | RSS: Main: 358944768 07:36:48 INFO - PROCESS | 1664 | 07:36:48 INFO - PROCESS | 1664 | __start_tp_report 07:36:48 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 07:36:48 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 07:36:48 INFO - PROCESS | 1664 | |i|pagename|runs| 07:36:48 INFO - PROCESS | 1664 | |0;dojo.html;3442.483627455882;3502.334556434279;3517.3429384489878;3531.7880927144383;3577.141486043349;5736.971315143418;5749.626274292168;5761.107028410598;5782.219400380947;5806;5207.557357624606;5417.916416716653;5763.164341170528;5797.710114494269;5798.043322851735;5113.514216149479;5170.63805533611;5177.068127736997;5226.320578324812;5244.134717771563;5252.763625636836;5260.947390526103;5261.763220655061;5265.86835329116;5267.209918512215;5166.302549155854;5215.6349055566125;5222.817201397952;5231.921521177166;5248.002879452911;5233.162693968966;5265.315508983807;5271;5278.261043453919;5316.282301889234;5039.697618142924;5210.6613070150315;5238.449962753894;5241.135212689902;5248.343957005374;5633.15502674598;5651.265335506399;5677.744501497443;5699.202111704365;5731.226284451629;6113.419225173646;6305.0857625644485;6310.747570097191;6328.240611126648;6336.841578960517;6271.529635277327;6273.1844860167885;6308.621482711052;6318.87362252757;6348.904766428507;5839;5877.177195192677;5885.823425297205;5913.911291330591;5920.970395148083;6215.658138802319;6278.372162783685;6328.050792381087;6332.778352757631;6335.239771227482;6068.819818832331;6087.338336260567;6104.626459046679;6127.403330890726;6222.688865556704;6295.370462953668;6341.651209183539;6353.396427339396;6363.713632886531;6366.586171898812;6236.407541283571;6265.561410701298;6278;6305.70732999734;6310.810675679737;6050.273967123973;6120.44915957566;6137.693115344304;6244.094606282064;6335.3981371769605;4892.2661600760175;4925.310456536088;4929.901401971941;4930.087933732271;4935.358403407534;4397.868063958086;4439.800208990603;4454.57681520255;4481.327800829901;4484.68607197493;5694.60137790359;5697.601167918206;5708.71456427177;5726.484616384545;5732.283464566929;4992.801727585426;6183;6236.656983865841;6328.082428047907;6332.208473940757;5645.661260324394;5668.688222147822;5679.574031947621;5697.772089116472;5697.857553561112;5360.973195133999;5366.597505187126;5388.622796404293;5400.729963501888;5412.972935135299;6284.24589049317;6311.990081586924;6342.999999999908;6384.744610215539;6401.487880969511;6172.166757487861;6179.783707570214;6208.317085120723;6211.16149319836;6235.469985051322;6348.650824204713;6367.681615919279;6369.394907483782;6373.8725225496155;6383.425491705769;6102.938970610237;6132.233470816148;6206.131141640084;6210.441060304594;6214.564980451506;6032.034874420072;6223.657698826608;6225.159603453476;6237.376262373727;6247.843803904757;6108.144859719554;6124.38756124384;6140.478059365004;6143.354947730602;6144.8771024580155;4949.406071271471;6101.938980610137;6104.481119104926;6110.437255175017;6154.78458253959;5016.473270306566;6009.188759517584;6022.337542870193;6037.728302226323;6052.636841789506;6081.878362432638;6121.1170067009725;6137.41694539018;6140.078988151813;6143.877122457615;5847.8245652630485;5965.075413310944;6005.879882402415;6050.2437195350585;6081.057436097412 07:36:48 INFO - PROCESS | 1664 | |1;ext.html;496.2135015999645;588.3175516400976;592.7700022453411;649.7530938243467;659.5218466611707;39775.801120994394;40272.19455610893;40324.798376008155;40373.18320675569;40425.79787101064;43111;43758;43768.562314376846;43934;43946.12107757843;9698.466584337859;9891.30760846741;9902.455364954925;9917.851232231522;9924.404535727843;9810.852837207447;9969.40183588987;9973.650922217725;9974.00259974004;9995.500224988722;9887.802243955117;9969.700908972705;9973.052560006789;9973.152282056033;9980.351277166961;9882.752931176743;9961.352512086763;9970.102690757794;9975.800483990279;10029.899701003005;9800.90199098014;9951.25365597583;9956.95021524895;9957.103860652503;9965.103140717298;33038.83480582582;42056.78971605153;42404.78797606023;42453.93865153365;42462.57537424617;3265.591801024872;3425.2293234022395;3459.2562599041325;3698.519192504984;3877.7673339599714;28608.284792880346;29354.853225733947;29420.558691619644;29608.40783184346;30074.54888176679;2463.802895768334;2805.4809860175933;2806.1862060002577;2858.085412667947;2918.270432391902;388865;394278;394809;394838;394966;47380.289295660594;48048.759756201;70459.9431008525;71660;71961.64019179976;47183.76408118006;47257.527424726;47369.052618947426;47409.762951185025;47487.76256118697;16600.584985375222;16694.749578756328;16730.74903876443;16747.91626041862;16789.6642067158;13256.933715331554;13277.136986095873;13308.534201302908;13328.333583320795;13351.265680387478;15058.247087645574;15432.84567154314;15471;15495.845041549666;15590.532284031497;6448.226212854393;6545.541812073109;6572.737090516326;6616.559389117632;6637.23671777742;960.9903900960901;966.8356379415517;988.6292640259902;1122.960696375623;1137.8577677790277;30679.8466007673;30740.924067657972;30868.408043422827;31073.223169420944;31453.8427307862;982.9655962041294;1158.3455347728507;1194.6475789641902;1219.408586835384;1220.1458978714936;15200.847991519944;15545.37818487248;15556.066636001877;15561.844381556266;15825.52523424299;510022;514114;515282;515555;515912;59221.70389148027;60628.69685651632;60649.69675151596;60791.696041519506;61101.38898610957;1440.3806363263898;1494.4844028810044;1516.9317380717894;1525.83978682239;1558.8986715863432;28916.132516024554;29468.410631787672;29499.557506637848;30121.09636710902;30151.698483015767;46921.53078469171;47247.52752472431;47447.52552474431;47482.76258618685;47498.762506187246;352733;363732;364119;364491;364577;29966.85016574903;31692.683073168973;33492;33925.151871203416;34482.48276275908;43094.78452607842;43377;43626.12747744964;43734.56265437305;43825;34863.47704784379;35713.1071723209;36486.817565912;37546.06134846651;38189.618103818604;36823.89528314155;36887.26225475529;37086.07284817793;37159.29331583792;37584.812075939444;36886.26227475489;37283.25433491369;38407.03982400463;38419.80790096032;38443.42334864923;32193.517097243093;32972.50541241931;33095.33809323848;33138.83430582831;33166.33667326592;24778.380540485912;25146.874265628554;25173.49653006893;25695.357616059002;25718 07:36:48 INFO - PROCESS | 1664 | |2;jquery.html;376.2531375220188;379.9430085487177;383.04812540836036;386.76600656602756;389.1031173145898;15911;20399.592008159827;20641.07115179817;21327.25354612585;21412.678809817844;19983.20067197314;20535.897320513377;20738.89630551845;20804.271850485235;20825.479363015933;5871.647701137946;6066.605670631395;6070.817875463721;6104.08438734189;6119.724612392453;5855.648661080328;5946.821595352147;6061.363556826536;6062;6077.3314935357075;5997.550183736215;6003.549733769963;6006.0390337546005;6008.579399442041;6008.819735407923;5765.625234359774;6043.7884674036195;6047.395260473917;6048.062550304688;6067;5203.323567936182;5221.295125158131;5228.686278823283;5237.371515418136;5237.580993520509;13546.390412431465;18395.54011149732;18486.260549578135;23937.52124957491;23955.880220598785;2249.921252756162;2298.4139044543704;2333.36999010268;2373.655819906104;2802.3974845408334;9919.206463482904;14021.948353873398;14749.926250368786;15009.949303548756;15135.243237838064;1757.4200513830406;1770.4777090758257;1835.311758090716;1854.6754317994296;1871.990640046791;60536;62015;96738.51630741802;106138;107159.92840071577;9389.530523473799;11460.598879039193;11623.59317423886;11654.708632284091;11698.47356868926;14320.713585728226;14397.64005899861;14419.711605768036;14421.206833624252;14427;7931.762047138595;8233.79415514605;8465.95767021161;8812.911870881337;8991.010988791228;8897.243734282529;8972.41679290844;8975.596098175598;9014.23379012778;9018.684346047858;4429.734215947054;4506.3916371290115;4532.320151977164;4580.702254353457;4582.885427864263;1592.4506045414546;1921.404364646936;1927.60484100759;1946.2604210399957;1974.6050789842088;882.3250213586612;988.5353883674661;1073.130764081097;1088.1186239146316;1088.8911108889047;20235.59528809445;20855;20919.58160836775;20937.79062209389;21071.894640526698;984.9901500985042;1016.4104819204844;1062.39443517196;1068.9946550267198;1083.2038451737967;11125.94437027826;11189.697242666203;12159.088068394905;12245;12362.505499779909;529707;593810;615557;617245;622566;115377;118105.99999999828;119261;123869.76130238762;127735;1075.596651255779;1091.6561283195767;1094.2285688589525;1116.268843907242;1123.3540714089431;18352;18744.906275468536;18988.95560744117;19074.855508669523;19153.425397238105;53362;53754.46245537651;54329.18506222331;54985.450145498035;55291;76760.0809979755;77941.61029194818;78080;78710;79407;7646.617669116411;8097.352211822922;8220.58897055133;8255.25702686737;8459.111793261618;9901.752456188653;12797.29614871191;12919.806202906775;13140.948724101858;13298.933505332412;11133.554657813596;11297.71755706114;11481.866528049728;11520;11561.075113991028;10834.02493775564;11099.278546894426;11239.269447485887;11298.0396666281;11513.481893314653;10604.363738175734;10735.677929662123;11498.54005839757;11618.128640351839;11839.76320473603;7924.960375198087;7995.800104997422;8163.83672326562;8164.918350816416;8169.2647661710735;8421.4947103174;10386.844197337197;11367.261128026652;11694.649160525198;11795.823062653895 07:36:48 INFO - PROCESS | 1664 | |3;mootools.html;1511.4029958166532;1650.6203573178168;1680.9747853782196;1967.6261510313038;2042.2239548971397;8210.876836847445;8779.956100219499;8936.195742383185;8968.73093807186;8980.416272942253;8677.91322086779;8929.73210803677;8944.776380590489;8945.194932456077;8951.507667078307;2249.49386388063;2306.8385213035094;2530.6204069389555;2559.987200063997;2563;2319.7796209360085;2449.436629575199;2507.3104896153523;2509.134348649713;2512.434702192001;2439.841410308324;2475.8390704604235;2481.3176376496426;2483.3419143926785;2523.7223905370392;2486.428121532058;2525.065725681491;2532.8606926619027;2537.961930571043;2542.250036239314;2302.873341966191;2304.5045315257134;2311.2257393773107;2314.409825494505;2322.6399908014287;8912.24245939096;8982.595783189772;8992.955035224848;8999.550022498914;9016.008239093695;5469.015577196104;5619.6066275360745;5620.718964051781;5684.54523638108;5684.7157642118145;3524.859005639771;3536.257385948954;3665.78005319679;3669.1377526281303;3682.797446140461;1060.946952652372;1064.9946750266276;1081.1512962324616;1081.5025088459317;1089.8256278995402;12248.693782655415;12248.755024899452;12281.01751859858;12306.323152226623;12309.507619695201;4869.975650121727;4920.704757714477;4985.925211121836;4996.875078123076;5016.899662006813;8581.871271930926;10234.232432567587;10340.172786177087;10356;10366.585336586451;5656.8868622627315;5659.122835960433;5668.149777533403;5670.631408958405;5681.829545113653;4552.931706024412;4598.0803839232285;5075.97462012695;5093.770780314895;5134.717590532557;3336.882144481577;3775.565809931893;3812.989557767194;3822.2355528893777;3822.2737679840743;1279.3858947705153;1345.1525538910423;1348.083303353729;1358.9184648921096;1363.4886917405972;1047.664747280863;1143.9428028598536;1164.016406136813;1165.8834116588273;1222.730999180179;8264.462809917337;8317.792055198548;8405.95797021011;8407.159284071544;8425.452345597516;449.16231228758784;522.9958479718948;527.6570229350876;529.3198240261246;543.4266848474817;6248.937510624835;6280.905786413207;6320.810375688737;6321;6335.809925702236;10619.469026548642;10975.780484390267;11114.555417783198;11147.888521114684;11159.832602510969;10618.522166502526;10765.30025548337;10859.076978456762;10867.347959122479;10876.72808179786;8509.659613615386;8511.59558672812;8514.872276915852;8539.146085391536;8555.529445880411;8036.598170091589;8044.396670249872;8074;8094.109647938604;8130.918690813016;9376.95311523438;9657.71026869195;9683.273754468584;9923.801523969625;9941.900580994386;9691.854622180532;10105.787305523385;10109;10127;10137.847932280874;6441.549091563733;6699.29657385987;7477.364424024019;7592.8481430369975;7668.693252269847;8311.709090181814;8363.20549547792;8388.119247479171;8395.202455766692;8400.075991641037;7240;7249.0213821135585;7284.927150728425;7390.300230946805;7489.850202996018;7241.855162896818;7268.818279543054;7299.452541059548;7386.298301661549;7401.370883474965;7719.768406947801;7868.331191848757;7886.84226315459;7912.129665736879;7915.564643944638;7145.64271786419;7149.249328820399;7213.891791623025;7217;7223.927760722536;7162.498625096402;7264.382527485223;7302.160251571137;7303.488755787044;7306.452016098708 07:36:48 INFO - PROCESS | 1664 | |4;prototype.html;303.3689924956092;332.42988275108183;340.1733786897839;343.0411998464292;346.46817135696693;6462.353764623541;6493.675316234193;6524.967375163129;6537.346265373466;6556.18047744032;6445.806625801221;6458.709358078886;6469.320721324264;6472.51456140789;6481.092647029408;4558.589726924576;4654.674172807905;4665.370175026362;4806.4232292125;4832.178529649959;4742.288656701505;4789.568938795508;4812.711237325754;4814.277858321245;4816.87957801056;4724.4094488188975;4726.314684370765;4744.478107408199;4751.928721069186;4752.90494190116;4518.570735780112;4603.941093548486;4732.95267047332;4739.644526660514;4783.449903261135;3287.3589650018257;3997.860609726243;4082.877513674565;4090.529589097262;4115.670746340285;5475.685835399515;5608.691521966291;6177.073438984188;6184.938150618526;6194.783182588588;5581.330240371181;5582.051051321285;5590.468905453975;5597.804076857331;5601.747921343549;6829.521933464659;6832.419244364235;6832.760853370109;6833.760818371333;6834.179898412172;4282.828686852522;4466.57567531084;4473.239549276631;4478.753668548228;4491.7304961702075;7057.611831349273;7223.602701851396;7228.277172282782;7239.20368759436;7273.45449091315;4542.364069030338;4549.158405694957;4565.315202719552;4570.360149579062;4571.794269257892;3849.5188101487315;4624.421947256593;4633.2818413146015;4641.559051890065;4647.140279048387;4507.774611269489;4604.654650901196;5299.019681358961;5424.321959755031;5457.61796674229;6667.066610674509;6798.252192258848;6812.182538095361;6872;6918.342757438036;1584.5484037049616;1586.571625661088;1603.559021269137;1604.254021879808;1605.6868910562562;966.6230170233614;988.6984469736799;1016.0753714120116;1020.0564477857952;1041.234692501011;6226.875462490725;6398.360163983564;6412.7114279857515;6422.03669449577;6424.421802037839;7164.498485105993;7168.964155179295;7169.924511323343;7174.3184397482155;7196.136463624294;6391.169148010822;6397.968010160012;6401.199850018747;6405.423511883952;6411.647359395185;3730.869419570302;3775.7356985010783;3776.8489260429824;3787.450819631138;3793.867214647474;7225.385842203366;7523.210062943422;7539.246075392417;7542.245775422414;7566.432517561205;6252.812415627538;7222.422206223489;7394.667239974106;7429.814254643569;7434.3309102181065;5987.281526216795;7472.738454154187;7502.3622992046285;7538.547687138789;7541.283578060075;5575.637583557056;7186.820329491596;7187.532810367309;7196.208417074223;7201;7017.929820701727;7026.086608740831;7026.824329391601;7029.156501219886;7069.22238553769;7405.074365704287;7483.289087536676;7506.1743208248145;7533.020707308015;7534.095908491016;4579.816807327669;4583.839565615188;4591.3801636779945;4593.885152871071;4597.494275629745;7143.571385716666;7147.821304467222;7151.964240178766;7160.176579693402;7173.92391141333;6624.455916084871;6887;6905.1713794345;6910;6917.550359226634;6841.692123854339;6868.450523958171;6878.484113691593;6892.346446618189;6912.688928998307;6750.122484077038;6755.459563235027;6759.493038022069;6762.7294908205085;6776.932230677828;6661.766838160641;6875.140607424072;6882.4149947253045;6882.793516194522;6900;6420.101185833893;6607.2071351438135;6666;6724.831879203059;6785.185777706707 07:36:48 INFO - PROCESS | 1664 | |5;yui.html;722.8951801988711;754.5359603843638;764.5833021003552;771.2788542712568;790.9802254943622;15324.693506129885;15522.22388880557;15535.689286214283;15540.766888496682;15547.611309717262;14235.501757438491;14377.496787612436;14386.064905781117;14392.280385980712;14398;785.1716439156687;793.175097898188;945.9905400946005;974.5711886769834;976.2873102635081;969.5346233807777;983.1299300119374;983.5033308179395;984.1929617713478;989.9554520046615;841.4614646626164;1037.5071840875598;1039.0596510158318;1039.828428309328;1040.1730624153815;1000.6297669862162;1027.917766578672;1028.1158203944601;1029.1201023125195;1029.5469993203005;766.7431410477496;771.5563550958221;771.8533478639097;772.4129661457276;773.5320131320526;15313.61715957099;15331.616709582238;15364;15369.308381122764;15387.307571159325;12932.806007909889;13038.217706937614;13280.800787988188;13444.596662100055;13544.932275338659;10283.691489255334;10308.278420510493;10464.162866970624;10540.9986051325;10866.185036122244;3547.2018795771005;3550.804705741183;3617.1680513482047;3694.07648087978;3699.075231192202;86586.83532911664;87525.12474875234;87550;87636.05637746317;88133;9739.759855233337;9898.752531186634;10055.245856560787;10332.225083118796;10748.462576871125;23684.644730328713;23685.526289474114;23698.881505592708;23720.64419033716;23786.167484138317;7666.693332266758;7725.768226953201;7746;7830.491018083806;7961.1242763295995;4150.294449943517;4163.83344666216;4259.212045771542;4313.439252897166;4418.138462999748;3729.9067523312133;3775.811209439517;3782.678472329828;3784.280986612535;3784.8296826642318;647.7085311609794;660.3033799341645;670.9060731497594;674.0092064665033;680.2041611314773;587.5563949218313;609.1624016976657;613.3896772711181;626.192212046455;641.7176442365344;8154.2253485918745;8504.659813607386;8521.233089022018;8609.655613775503;8615.267702245254;589.631480324797;604.4559896093551;604.7157835817159;607.9331273559905;629.9370062993664;3904.6095390461296;3928.253631809947;3950.4074388841905;4056.533498647634;4080.9795951020646;96360.51819740997;96564;97906;98659.50670246602;98662;81145.90672643084;82351.58824205841;84248.57875710705;85450.57274713587;85507.14492855116;72222;72464.63767681128;72790;73995.63002184955;74137.62931185309;7916.08964969036;8111.310538604284;8162.224588664068;8195.303399211134;8213.83572328562;43868.78065609652;52523.474765251856;52838.679033024484;53540.46459535355;53701;66180.66909665421;68136;68806.65596671985;70353.59292814217;73353;10342.276040677081;10404.843927341248;10519.89480105189;10522.736931576772;11175.832362514406;9043.728688139367;11366.829497557708;11508.309501429942;11547;11589.304641721523;10583.62957296491;10666.986636269541;10702.785944281226;10918.508667110158;10951.288166269167;8722.607482663168;9258.675946342115;10408.687739367831;10722.73193170177;10899.56401743953;10223.948880255552;10490.895091049297;10690.62582809598;10743.946280268548;10895.727606809893;8886.73339799807;9021.774455638662;9115.316351273548;9237.353385262966;9276.2578993679;9093.909060909571;9113.908860911306;9116.903112284079;9173.724788256362;9288.210502107126 07:36:48 INFO - PROCESS | 1664 | __end_tp_report 07:36:48 INFO - PROCESS | 1664 | __start_cc_report 07:36:48 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1235 07:36:48 INFO - PROCESS | 1664 | __end_cc_report 07:36:48 INFO - PROCESS | 1664 | __startTimestamp1461595008571__endTimestamp 07:36:48 INFO - PROCESS | 1664 | 07:36:48 INFO - PROCESS | 1664 | ------- Summary: start ------- 07:36:48 INFO - PROCESS | 1664 | Number of tests: 6 07:36:48 INFO - PROCESS | 1664 | 07:36:48 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5751.12 Median:6022.34 stddev:636.61 (10.6%) stddev-sans-first:612.26 07:36:48 INFO - PROCESS | 1664 | Values: 3442.5 3502.3 3517.3 3531.8 3577.1 5737.0 5749.6 5761.1 5782.2 5806.0 5207.6 5417.9 5763.2 5797.7 5798.0 5113.5 5170.6 5177.1 5226.3 5244.1 5252.8 5260.9 5261.8 5265.9 5267.2 5166.3 5215.6 5222.8 5231.9 5248.0 5233.2 5265.3 5271.0 5278.3 5316.3 5039.7 5210.7 5238.4 5241.1 5248.3 5633.2 5651.3 5677.7 5699.2 5731.2 6113.4 6305.1 6310.7 6328.2 6336.8 6271.5 6273.2 6308.6 6318.9 6348.9 5839.0 5877.2 5885.8 5913.9 5921.0 6215.7 6278.4 6328.1 6332.8 6335.2 6068.8 6087.3 6104.6 6127.4 6222.7 6295.4 6341.7 6353.4 6363.7 6366.6 6236.4 6265.6 6278.0 6305.7 6310.8 6050.3 6120.4 6137.7 6244.1 6335.4 4892.3 4925.3 4929.9 4930.1 4935.4 4397.9 4439.8 4454.6 4481.3 4484.7 5694.6 5697.6 5708.7 5726.5 5732.3 4992.8 6183.0 6236.7 6328.1 6332.2 5645.7 5668.7 5679.6 5697.8 5697.9 5361.0 5366.6 5388.6 5400.7 5413.0 6284.2 6312.0 6343.0 6384.7 6401.5 6172.2 6179.8 6208.3 6211.2 6235.5 6348.7 6367.7 6369.4 6373.9 6383.4 6102.9 6132.2 6206.1 6210.4 6214.6 6032.0 6223.7 6225.2 6237.4 6247.8 6108.1 6124.4 6140.5 6143.4 6144.9 4949.4 6101.9 6104.5 6110.4 6154.8 5016.5 6009.2 6022.3 6037.7 6052.6 6081.9 6121.1 6137.4 6140.1 6143.9 5847.8 5965.1 6005.9 6050.2 6081.1 07:36:48 INFO - PROCESS | 1664 | 07:36:48 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:57637.31 Median:38431.62 stddev:113479.77 (295.3%) stddev-sans-first:113717.02 07:36:48 INFO - PROCESS | 1664 | Values: 496.2 588.3 592.8 649.8 659.5 39775.8 40272.2 40324.8 40373.2 40425.8 43111.0 43758.0 43768.6 43934.0 43946.1 9698.5 9891.3 9902.5 9917.9 9924.4 9810.9 9969.4 9973.7 9974.0 9995.5 9887.8 9969.7 9973.1 9973.2 9980.4 9882.8 9961.4 9970.1 9975.8 10029.9 9800.9 9951.3 9957.0 9957.1 9965.1 33038.8 42056.8 42404.8 42453.9 42462.6 3265.6 3425.2 3459.3 3698.5 3877.8 28608.3 29354.9 29420.6 29608.4 30074.5 2463.8 2805.5 2806.2 2858.1 2918.3 388865.0 394278.0 394809.0 394838.0 394966.0 47380.3 48048.8 70459.9 71660.0 71961.6 47183.8 47257.5 47369.1 47409.8 47487.8 16600.6 16694.7 16730.7 16747.9 16789.7 13256.9 13277.1 13308.5 13328.3 13351.3 15058.2 15432.8 15471.0 15495.8 15590.5 6448.2 6545.5 6572.7 6616.6 6637.2 961.0 966.8 988.6 1123.0 1137.9 30679.8 30740.9 30868.4 31073.2 31453.8 983.0 1158.3 1194.6 1219.4 1220.1 15200.8 15545.4 15556.1 15561.8 15825.5 510022.0 514114.0 515282.0 515555.0 515912.0 59221.7 60628.7 60649.7 60791.7 61101.4 1440.4 1494.5 1516.9 1525.8 1558.9 28916.1 29468.4 29499.6 30121.1 30151.7 46921.5 47247.5 47447.5 47482.8 47498.8 352733.0 363732.0 364119.0 364491.0 364577.0 29966.9 31692.7 33492.0 33925.2 34482.5 43094.8 43377.0 43626.1 43734.6 43825.0 34863.5 35713.1 36486.8 37546.1 38189.6 36823.9 36887.3 37086.1 37159.3 37584.8 36886.3 37283.3 38407.0 38419.8 38443.4 32193.5 32972.5 33095.3 33138.8 33166.3 24778.4 25146.9 25173.5 25695.4 25718.0 07:36:48 INFO - PROCESS | 1664 | 07:36:48 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:33911.53 Median:21199.57 stddev:98902.82 (466.5%) stddev-sans-first:99148.21 07:36:48 INFO - PROCESS | 1664 | Values: 376.3 379.9 383.0 386.8 389.1 15911.0 20399.6 20641.1 21327.3 21412.7 19983.2 20535.9 20738.9 20804.3 20825.5 5871.6 6066.6 6070.8 6104.1 6119.7 5855.6 5946.8 6061.4 6062.0 6077.3 5997.6 6003.5 6006.0 6008.6 6008.8 5765.6 6043.8 6047.4 6048.1 6067.0 5203.3 5221.3 5228.7 5237.4 5237.6 13546.4 18395.5 18486.3 23937.5 23955.9 2249.9 2298.4 2333.4 2373.7 2802.4 9919.2 14021.9 14749.9 15009.9 15135.2 1757.4 1770.5 1835.3 1854.7 1872.0 60536.0 62015.0 96738.5 106138.0 107159.9 9389.5 11460.6 11623.6 11654.7 11698.5 14320.7 14397.6 14419.7 14421.2 14427.0 7931.8 8233.8 8466.0 8812.9 8991.0 8897.2 8972.4 8975.6 9014.2 9018.7 4429.7 4506.4 4532.3 4580.7 4582.9 1592.5 1921.4 1927.6 1946.3 1974.6 882.3 988.5 1073.1 1088.1 1088.9 20235.6 20855.0 20919.6 20937.8 21071.9 985.0 1016.4 1062.4 1069.0 1083.2 11125.9 11189.7 12159.1 12245.0 12362.5 529707.0 593810.0 615557.0 617245.0 622566.0 115377.0 118106.0 119261.0 123869.8 127735.0 1075.6 1091.7 1094.2 1116.3 1123.4 18352.0 18744.9 18989.0 19074.9 19153.4 53362.0 53754.5 54329.2 54985.5 55291.0 76760.1 77941.6 78080.0 78710.0 79407.0 7646.6 8097.4 8220.6 8255.3 8459.1 9901.8 12797.3 12919.8 13140.9 13298.9 11133.6 11297.7 11481.9 11520.0 11561.1 10834.0 11099.3 11239.3 11298.0 11513.5 10604.4 10735.7 11498.5 11618.1 11839.8 7925.0 7995.8 8163.8 8164.9 8169.3 8421.5 10386.8 11367.3 11694.6 11795.8 07:36:48 INFO - PROCESS | 1664 | 07:36:48 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:6132.37 Median:528.49 stddev:3285.60 (621.7%) stddev-sans-first:3276.46 07:36:48 INFO - PROCESS | 1664 | Values: 1511.4 1650.6 1681.0 1967.6 2042.2 8210.9 8780.0 8936.2 8968.7 8980.4 8677.9 8929.7 8944.8 8945.2 8951.5 2249.5 2306.8 2530.6 2560.0 2563.0 2319.8 2449.4 2507.3 2509.1 2512.4 2439.8 2475.8 2481.3 2483.3 2523.7 2486.4 2525.1 2532.9 2538.0 2542.3 2302.9 2304.5 2311.2 2314.4 2322.6 8912.2 8982.6 8993.0 8999.6 9016.0 5469.0 5619.6 5620.7 5684.5 5684.7 3524.9 3536.3 3665.8 3669.1 3682.8 1060.9 1065.0 1081.2 1081.5 1089.8 12248.7 12248.8 12281.0 12306.3 12309.5 4870.0 4920.7 4985.9 4996.9 5016.9 8581.9 10234.2 10340.2 10356.0 10366.6 5656.9 5659.1 5668.1 5670.6 5681.8 4552.9 4598.1 5076.0 5093.8 5134.7 3336.9 3775.6 3813.0 3822.2 3822.3 1279.4 1345.2 1348.1 1358.9 1363.5 1047.7 1143.9 1164.0 1165.9 1222.7 8264.5 8317.8 8406.0 8407.2 8425.5 449.2 523.0 527.7 529.3 543.4 6248.9 6280.9 6320.8 6321.0 6335.8 10619.5 10975.8 11114.6 11147.9 11159.8 10618.5 10765.3 10859.1 10867.3 10876.7 8509.7 8511.6 8514.9 8539.1 8555.5 8036.6 8044.4 8074.0 8094.1 8130.9 9377.0 9657.7 9683.3 9923.8 9941.9 9691.9 10105.8 10109.0 10127.0 10137.8 6441.5 6699.3 7477.4 7592.8 7668.7 8311.7 8363.2 8388.1 8395.2 8400.1 7240.0 7249.0 7284.9 7390.3 7489.9 7241.9 7268.8 7299.5 7386.3 7401.4 7719.8 7868.3 7886.8 7912.1 7915.6 7145.6 7149.2 7213.9 7217.0 7223.9 7162.5 7264.4 7302.2 7303.5 7306.5 07:36:48 INFO - PROCESS | 1664 | 07:36:48 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5620.07 Median:6423.23 stddev:1807.65 (28.1%) stddev-sans-first:1768.12 07:36:48 INFO - PROCESS | 1664 | Values: 303.4 332.4 340.2 343.0 346.5 6462.4 6493.7 6525.0 6537.3 6556.2 6445.8 6458.7 6469.3 6472.5 6481.1 4558.6 4654.7 4665.4 4806.4 4832.2 4742.3 4789.6 4812.7 4814.3 4816.9 4724.4 4726.3 4744.5 4751.9 4752.9 4518.6 4603.9 4733.0 4739.6 4783.4 3287.4 3997.9 4082.9 4090.5 4115.7 5475.7 5608.7 6177.1 6184.9 6194.8 5581.3 5582.1 5590.5 5597.8 5601.7 6829.5 6832.4 6832.8 6833.8 6834.2 4282.8 4466.6 4473.2 4478.8 4491.7 7057.6 7223.6 7228.3 7239.2 7273.5 4542.4 4549.2 4565.3 4570.4 4571.8 3849.5 4624.4 4633.3 4641.6 4647.1 4507.8 4604.7 5299.0 5424.3 5457.6 6667.1 6798.3 6812.2 6872.0 6918.3 1584.5 1586.6 1603.6 1604.3 1605.7 966.6 988.7 1016.1 1020.1 1041.2 6226.9 6398.4 6412.7 6422.0 6424.4 7164.5 7169.0 7169.9 7174.3 7196.1 6391.2 6398.0 6401.2 6405.4 6411.6 3730.9 3775.7 3776.8 3787.5 3793.9 7225.4 7523.2 7539.2 7542.2 7566.4 6252.8 7222.4 7394.7 7429.8 7434.3 5987.3 7472.7 7502.4 7538.5 7541.3 5575.6 7186.8 7187.5 7196.2 7201.0 7017.9 7026.1 7026.8 7029.2 7069.2 7405.1 7483.3 7506.2 7533.0 7534.1 4579.8 4583.8 4591.4 4593.9 4597.5 7143.6 7147.8 7152.0 7160.2 7173.9 6624.5 6887.0 6905.2 6910.0 6917.6 6841.7 6868.5 6878.5 6892.3 6912.7 6750.1 6755.5 6759.5 6762.7 6776.9 6661.8 6875.1 6882.4 6882.8 6900.0 6420.1 6607.2 6666.0 6724.8 6785.2 07:36:48 INFO - PROCESS | 1664 | 07:36:48 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:19001.32 Median:597.04 stddev:27281.12 (4569.4%) stddev-sans-first:27323.13 07:36:48 INFO - PROCESS | 1664 | Values: 722.9 754.5 764.6 771.3 791.0 15324.7 15522.2 15535.7 15540.8 15547.6 14235.5 14377.5 14386.1 14392.3 14398.0 785.2 793.2 946.0 974.6 976.3 969.5 983.1 983.5 984.2 990.0 841.5 1037.5 1039.1 1039.8 1040.2 1000.6 1027.9 1028.1 1029.1 1029.5 766.7 771.6 771.9 772.4 773.5 15313.6 15331.6 15364.0 15369.3 15387.3 12932.8 13038.2 13280.8 13444.6 13544.9 10283.7 10308.3 10464.2 10541.0 10866.2 3547.2 3550.8 3617.2 3694.1 3699.1 86586.8 87525.1 87550.0 87636.1 88133.0 9739.8 9898.8 10055.2 10332.2 10748.5 23684.6 23685.5 23698.9 23720.6 23786.2 7666.7 7725.8 7746.0 7830.5 7961.1 4150.3 4163.8 4259.2 4313.4 4418.1 3729.9 3775.8 3782.7 3784.3 3784.8 647.7 660.3 670.9 674.0 680.2 587.6 609.2 613.4 626.2 641.7 8154.2 8504.7 8521.2 8609.7 8615.3 589.6 604.5 604.7 607.9 629.9 3904.6 3928.3 3950.4 4056.5 4081.0 96360.5 96564.0 97906.0 98659.5 98662.0 81145.9 82351.6 84248.6 85450.6 85507.1 72222.0 72464.6 72790.0 73995.6 74137.6 7916.1 8111.3 8162.2 8195.3 8213.8 43868.8 52523.5 52838.7 53540.5 53701.0 66180.7 68136.0 68806.7 70353.6 73353.0 10342.3 10404.8 10519.9 10522.7 11175.8 9043.7 11366.8 11508.3 11547.0 11589.3 10583.6 10667.0 10702.8 10918.5 10951.3 8722.6 9258.7 10408.7 10722.7 10899.6 10223.9 10490.9 10690.6 10743.9 10895.7 8886.7 9021.8 9115.3 9237.4 9276.3 9093.9 9113.9 9116.9 9173.7 9288.2 07:36:48 INFO - PROCESS | 1664 | -------- Summary: end -------- 07:36:48 INFO - PROCESS | 1664 | 07:36:49 INFO - TEST-INFO | 1664: exit 0 07:36:49 INFO - TEST-OK | dromaeo_css | took 1112347ms 07:36:49 INFO - TEST-START | kraken 07:36:49 INFO - operating with platform_type : mac_ 07:36:49 INFO - Initialising browser for kraken test... 07:36:49 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpd5B6iM/profile http://localhost:49270/getInfo.html) 07:36:51 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 07:36:51 INFO - PROCESS | 1675 | colorDepth:24 07:36:51 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 07:36:51 INFO - PROCESS | 1675 | __metrics 07:36:51 INFO - PROCESS | 1675 | 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" 07:36:51 INFO - PROCESS | 1675 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:36:51 INFO - TEST-INFO | 1675: exit 0 07:36:51 INFO - Browser initialized. 07:36:51 INFO - Running cycle 1/1 for kraken test... 07:36:51 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpd5B6iM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:03 INFO - PROCESS | 1677 | RSS: Main: 207577088 07:37:03 INFO - PROCESS | 1677 | 07:37:06 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 07:37:07 INFO - PROCESS | 1677 | RSS: Main: 262963200 07:37:07 INFO - PROCESS | 1677 | 07:37:09 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 07:37:10 INFO - PROCESS | 1677 | RSS: Main: 273100800 07:37:10 INFO - PROCESS | 1677 | 07:37:13 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 07:37:14 INFO - PROCESS | 1677 | RSS: Main: 263733248 07:37:14 INFO - PROCESS | 1677 | 07:37:15 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 07:37:16 INFO - PROCESS | 1677 | RSS: Main: 265093120 07:37:16 INFO - PROCESS | 1677 | 07:37:18 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:37:19 INFO - PROCESS | 1677 | RSS: Main: 264761344 07:37:19 INFO - PROCESS | 1677 | 07:37:22 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 07:37:22 INFO - PROCESS | 1677 | RSS: Main: 265871360 07:37:22 INFO - PROCESS | 1677 | 07:37:25 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 07:37:26 INFO - PROCESS | 1677 | RSS: Main: 266035200 07:37:26 INFO - PROCESS | 1677 | 07:37:28 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 07:37:29 INFO - PROCESS | 1677 | RSS: Main: 266395648 07:37:29 INFO - PROCESS | 1677 | 07:37:30 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:37:31 INFO - PROCESS | 1677 | RSS: Main: 299810816 07:37:31 INFO - PROCESS | 1677 | 07:37:33 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:37:33 INFO - PROCESS | 1677 | RSS: Main: 300453888 07:37:33 INFO - PROCESS | 1677 | 07:37:35 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:37:36 INFO - PROCESS | 1677 | RSS: Main: 305639424 07:37:36 INFO - PROCESS | 1677 | 07:37:39 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:37:39 INFO - PROCESS | 1677 | RSS: Main: 307642368 07:37:39 INFO - PROCESS | 1677 | 07:37:42 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:37:42 INFO - PROCESS | 1677 | RSS: Main: 307609600 07:37:42 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 07:37:44 INFO - PROCESS | 1677 | RSS: Main: 370692096 07:37:44 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | __start_tp_report 07:37:44 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 07:37:44 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 07:37:44 INFO - PROCESS | 1677 | |i|pagename|runs| 07:37:44 INFO - PROCESS | 1677 | |0;ai-astar;113;109;111;109;116;165;176;110;112;110 07:37:44 INFO - PROCESS | 1677 | |1;audio-beat-detection;153;121;158;147;115;140;138;178;153;118 07:37:44 INFO - PROCESS | 1677 | |2;audio-dft;185;184;187;184;182;185;186;185;187;184 07:37:44 INFO - PROCESS | 1677 | |3;audio-fft;73;77;71;116;55;57;58;62;119;55 07:37:44 INFO - PROCESS | 1677 | |4;audio-oscillator;91;95;128;80;79;85;119;76;79;117 07:37:44 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;89;87;87;79;134;130;89;85;89;85 07:37:44 INFO - PROCESS | 1677 | |6;imaging-darkroom;93;93;93;93;94;93;93;92;93;93 07:37:44 INFO - PROCESS | 1677 | |7;imaging-desaturate;87;86;88;84;85;84;84;84;85;86 07:37:44 INFO - PROCESS | 1677 | |8;json-parse-financial;55;56;57;57;57;57;57;67;54;50 07:37:44 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;63;63;72;72;71;65;64;65;66;66 07:37:44 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;81;80;81;82;81;81;81;80;80;85 07:37:44 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;140;140;116;105;130;128;102;126;130;124 07:37:44 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;132;121;136;133;169;162;135;131;122;145 07:37:44 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;65;65;66;67;66;66;66;67;63;66 07:37:44 INFO - PROCESS | 1677 | __end_tp_report 07:37:44 INFO - PROCESS | 1677 | __start_cc_report 07:37:44 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1179 07:37:44 INFO - PROCESS | 1677 | __end_cc_report 07:37:44 INFO - PROCESS | 1677 | __startTimestamp1461595064669__endTimestamp 07:37:44 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | ------- Summary: start ------- 07:37:44 INFO - PROCESS | 1677 | Number of tests: 14 07:37:44 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:123.10 Median:112.50 stddev:25.20 (22.4%) stddev-sans-first:26.47 07:37:44 INFO - PROCESS | 1677 | Values: 113.0 109.0 111.0 109.0 116.0 165.0 176.0 110.0 112.0 110.0 07:37:44 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:150.00 stddev:19.96 (13.3%) stddev-sans-first:20.78 07:37:44 INFO - PROCESS | 1677 | Values: 153.0 121.0 158.0 147.0 115.0 140.0 138.0 178.0 153.0 118.0 07:37:44 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.00 stddev:1.52 (0.8%) stddev-sans-first:1.62 07:37:44 INFO - PROCESS | 1677 | Values: 185.0 184.0 187.0 184.0 182.0 185.0 186.0 185.0 187.0 184.0 07:37:44 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:74.30 Median:60.00 stddev:24.08 (40.1%) stddev-sans-first:25.53 07:37:44 INFO - PROCESS | 1677 | Values: 73.0 77.0 71.0 116.0 55.0 57.0 58.0 62.0 119.0 55.0 07:37:44 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:79.50 stddev:19.33 (24.3%) stddev-sans-first:20.45 07:37:44 INFO - PROCESS | 1677 | Values: 91.0 95.0 128.0 80.0 79.0 85.0 119.0 76.0 79.0 117.0 07:37:44 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:95.40 Median:87.00 stddev:19.54 (22.5%) stddev-sans-first:20.59 07:37:44 INFO - PROCESS | 1677 | Values: 89.0 87.0 87.0 79.0 134.0 130.0 89.0 85.0 89.0 85.0 07:37:44 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 07:37:44 INFO - PROCESS | 1677 | Values: 93.0 93.0 93.0 93.0 94.0 93.0 93.0 92.0 93.0 93.0 07:37:44 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.50 stddev:1.42 (1.7%) stddev-sans-first:1.36 07:37:44 INFO - PROCESS | 1677 | Values: 87.0 86.0 88.0 84.0 85.0 84.0 84.0 84.0 85.0 86.0 07:37:44 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:4.24 (7.4%) stddev-sans-first:4.46 07:37:44 INFO - PROCESS | 1677 | Values: 55.0 56.0 57.0 57.0 57.0 57.0 57.0 67.0 54.0 50.0 07:37:44 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.00 stddev:3.59 (5.4%) stddev-sans-first:3.55 07:37:44 INFO - PROCESS | 1677 | Values: 63.0 63.0 72.0 72.0 71.0 65.0 64.0 65.0 66.0 66.0 07:37:44 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:1.48 (1.8%) stddev-sans-first:1.56 07:37:44 INFO - PROCESS | 1677 | Values: 81.0 80.0 81.0 82.0 81.0 81.0 81.0 80.0 80.0 85.0 07:37:44 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:129.00 stddev:12.97 (10.1%) stddev-sans-first:12.41 07:37:44 INFO - PROCESS | 1677 | Values: 140.0 140.0 116.0 105.0 130.0 128.0 102.0 126.0 130.0 124.0 07:37:44 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.60 Median:135.50 stddev:15.81 (11.7%) stddev-sans-first:16.59 07:37:44 INFO - PROCESS | 1677 | Values: 132.0 121.0 136.0 133.0 169.0 162.0 135.0 131.0 122.0 145.0 07:37:44 INFO - PROCESS | 1677 | 07:37:44 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.16 (1.8%) stddev-sans-first:1.20 07:37:44 INFO - PROCESS | 1677 | Values: 65.0 65.0 66.0 67.0 66.0 66.0 66.0 67.0 63.0 66.0 07:37:44 INFO - PROCESS | 1677 | -------- Summary: end -------- 07:37:44 INFO - PROCESS | 1677 | 07:37:45 INFO - TEST-INFO | 1677: exit 0 07:37:45 INFO - TEST-OK | kraken | took 56278ms 07:37:45 INFO - SUITE-END | took 1168s 07:37:45 INFO - Completed test suite (00:19:29) 07:37:45 INFO - javascript benchmark 07:37:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3442.483627455882, 3502.334556434279, 3517.3429384489878, 3531.7880927144383, 3577.141486043349, 5736.971315143418, 5749.626274292168, 5761.107028410598, 5782.219400380947, 5806.0, 5207.557357624606, 5417.916416716653, 5763.164341170528, 5797.710114494269, 5798.043322851735, 5113.514216149479, 5170.63805533611, 5177.068127736997, 5226.320578324812, 5244.134717771563, 5252.763625636836, 5260.947390526103, 5261.763220655061, 5265.86835329116, 5267.209918512215, 5166.302549155854, 5215.6349055566125, 5222.817201397952, 5231.921521177166, 5248.002879452911, 5233.162693968966, 5265.315508983807, 5271.0, 5278.261043453919, 5316.282301889234, 5039.697618142924, 5210.6613070150315, 5238.449962753894, 5241.135212689902, 5248.343957005374, 5633.15502674598, 5651.265335506399, 5677.744501497443, 5699.202111704365, 5731.226284451629, 6113.419225173646, 6305.0857625644485, 6310.747570097191, 6328.240611126648, 6336.841578960517, 6271.529635277327, 6273.1844860167885, 6308.621482711052, 6318.87362252757, 6348.904766428507, 5839.0, 5877.177195192677, 5885.823425297205, 5913.911291330591, 5920.970395148083, 6215.658138802319, 6278.372162783685, 6328.050792381087, 6332.778352757631, 6335.239771227482, 6068.819818832331, 6087.338336260567, 6104.626459046679, 6127.403330890726, 6222.688865556704, 6295.370462953668, 6341.651209183539, 6353.396427339396, 6363.713632886531, 6366.586171898812, 6236.407541283571, 6265.561410701298, 6278.0, 6305.70732999734, 6310.810675679737, 6050.273967123973, 6120.44915957566, 6137.693115344304, 6244.094606282064, 6335.3981371769605, 4892.2661600760175, 4925.310456536088, 4929.901401971941, 4930.087933732271, 4935.358403407534, 4397.868063958086, 4439.800208990603, 4454.57681520255, 4481.327800829901, 4484.68607197493, 5694.60137790359, 5697.601167918206, 5708.71456427177, 5726.484616384545, 5732.283464566929, 4992.801727585426, 6183.0, 6236.656983865841, 6328.082428047907, 6332.208473940757, 5645.661260324394, 5668.688222147822, 5679.574031947621, 5697.772089116472, 5697.857553561112, 5360.973195133999, 5366.597505187126, 5388.622796404293, 5400.729963501888, 5412.972935135299, 6284.24589049317, 6311.990081586924, 6342.999999999908, 6384.744610215539, 6401.487880969511, 6172.166757487861, 6179.783707570214, 6208.317085120723, 6211.16149319836, 6235.469985051322, 6348.650824204713, 6367.681615919279, 6369.394907483782, 6373.8725225496155, 6383.425491705769, 6102.938970610237, 6132.233470816148, 6206.131141640084, 6210.441060304594, 6214.564980451506, 6032.034874420072, 6223.657698826608, 6225.159603453476, 6237.376262373727, 6247.843803904757, 6108.144859719554, 6124.38756124384, 6140.478059365004, 6143.354947730602, 6144.8771024580155, 4949.406071271471, 6101.938980610137, 6104.481119104926, 6110.437255175017, 6154.78458253959, 5016.473270306566, 6009.188759517584, 6022.337542870193, 6037.728302226323, 6052.636841789506, 6081.878362432638, 6121.1170067009725, 6137.41694539018, 6140.078988151813, 6143.877122457615, 5847.8245652630485, 5965.075413310944, 6005.879882402415, 6050.2437195350585, 6081.057436097412], "unit": "score", "name": "dojo.html", "value": 5712.637389241455}, {"lowerIsBetter": false, "replicates": [496.2135015999645, 588.3175516400976, 592.7700022453411, 649.7530938243467, 659.5218466611707, 39775.801120994394, 40272.19455610893, 40324.798376008155, 40373.18320675569, 40425.79787101064, 43111.0, 43758.0, 43768.562314376846, 43934.0, 43946.12107757843, 9698.466584337859, 9891.30760846741, 9902.455364954925, 9917.851232231522, 9924.404535727843, 9810.852837207447, 9969.40183588987, 9973.650922217725, 9974.00259974004, 9995.500224988722, 9887.802243955117, 9969.700908972705, 9973.052560006789, 9973.152282056033, 9980.351277166961, 9882.752931176743, 9961.352512086763, 9970.102690757794, 9975.800483990279, 10029.899701003005, 9800.90199098014, 9951.25365597583, 9956.95021524895, 9957.103860652503, 9965.103140717298, 33038.83480582582, 42056.78971605153, 42404.78797606023, 42453.93865153365, 42462.57537424617, 3265.591801024872, 3425.2293234022395, 3459.2562599041325, 3698.519192504984, 3877.7673339599714, 28608.284792880346, 29354.853225733947, 29420.558691619644, 29608.40783184346, 30074.54888176679, 2463.802895768334, 2805.4809860175933, 2806.1862060002577, 2858.085412667947, 2918.270432391902, 388865.0, 394278.0, 394809.0, 394838.0, 394966.0, 47380.289295660594, 48048.759756201, 70459.9431008525, 71660.0, 71961.64019179976, 47183.76408118006, 47257.527424726, 47369.052618947426, 47409.762951185025, 47487.76256118697, 16600.584985375222, 16694.749578756328, 16730.74903876443, 16747.91626041862, 16789.6642067158, 13256.933715331554, 13277.136986095873, 13308.534201302908, 13328.333583320795, 13351.265680387478, 15058.247087645574, 15432.84567154314, 15471.0, 15495.845041549666, 15590.532284031497, 6448.226212854393, 6545.541812073109, 6572.737090516326, 6616.559389117632, 6637.23671777742, 960.9903900960901, 966.8356379415517, 988.6292640259902, 1122.960696375623, 1137.8577677790277, 30679.8466007673, 30740.924067657972, 30868.408043422827, 31073.223169420944, 31453.8427307862, 982.9655962041294, 1158.3455347728507, 1194.6475789641902, 1219.408586835384, 1220.1458978714936, 15200.847991519944, 15545.37818487248, 15556.066636001877, 15561.844381556266, 15825.52523424299, 510022.0, 514114.0, 515282.0, 515555.0, 515912.0, 59221.70389148027, 60628.69685651632, 60649.69675151596, 60791.696041519506, 61101.38898610957, 1440.3806363263898, 1494.4844028810044, 1516.9317380717894, 1525.83978682239, 1558.8986715863432, 28916.132516024554, 29468.410631787672, 29499.557506637848, 30121.09636710902, 30151.698483015767, 46921.53078469171, 47247.52752472431, 47447.52552474431, 47482.76258618685, 47498.762506187246, 352733.0, 363732.0, 364119.0, 364491.0, 364577.0, 29966.85016574903, 31692.683073168973, 33492.0, 33925.151871203416, 34482.48276275908, 43094.78452607842, 43377.0, 43626.12747744964, 43734.56265437305, 43825.0, 34863.47704784379, 35713.1071723209, 36486.817565912, 37546.06134846651, 38189.618103818604, 36823.89528314155, 36887.26225475529, 37086.07284817793, 37159.29331583792, 37584.812075939444, 36886.26227475489, 37283.25433491369, 38407.03982400463, 38419.80790096032, 38443.42334864923, 32193.517097243093, 32972.50541241931, 33095.33809323848, 33138.83430582831, 33166.33667326592, 24778.380540485912, 25146.874265628554, 25173.49653006893, 25695.357616059002, 25718.0], "unit": "score", "name": "ext.html", "value": 19463.08914082167}, {"lowerIsBetter": false, "replicates": [376.2531375220188, 379.9430085487177, 383.04812540836036, 386.76600656602756, 389.1031173145898, 15911.0, 20399.592008159827, 20641.07115179817, 21327.25354612585, 21412.678809817844, 19983.20067197314, 20535.897320513377, 20738.89630551845, 20804.271850485235, 20825.479363015933, 5871.647701137946, 6066.605670631395, 6070.817875463721, 6104.08438734189, 6119.724612392453, 5855.648661080328, 5946.821595352147, 6061.363556826536, 6062.0, 6077.3314935357075, 5997.550183736215, 6003.549733769963, 6006.0390337546005, 6008.579399442041, 6008.819735407923, 5765.625234359774, 6043.7884674036195, 6047.395260473917, 6048.062550304688, 6067.0, 5203.323567936182, 5221.295125158131, 5228.686278823283, 5237.371515418136, 5237.580993520509, 13546.390412431465, 18395.54011149732, 18486.260549578135, 23937.52124957491, 23955.880220598785, 2249.921252756162, 2298.4139044543704, 2333.36999010268, 2373.655819906104, 2802.3974845408334, 9919.206463482904, 14021.948353873398, 14749.926250368786, 15009.949303548756, 15135.243237838064, 1757.4200513830406, 1770.4777090758257, 1835.311758090716, 1854.6754317994296, 1871.990640046791, 60536.0, 62015.0, 96738.51630741802, 106138.0, 107159.92840071577, 9389.530523473799, 11460.598879039193, 11623.59317423886, 11654.708632284091, 11698.47356868926, 14320.713585728226, 14397.64005899861, 14419.711605768036, 14421.206833624252, 14427.0, 7931.762047138595, 8233.79415514605, 8465.95767021161, 8812.911870881337, 8991.010988791228, 8897.243734282529, 8972.41679290844, 8975.596098175598, 9014.23379012778, 9018.684346047858, 4429.734215947054, 4506.3916371290115, 4532.320151977164, 4580.702254353457, 4582.885427864263, 1592.4506045414546, 1921.404364646936, 1927.60484100759, 1946.2604210399957, 1974.6050789842088, 882.3250213586612, 988.5353883674661, 1073.130764081097, 1088.1186239146316, 1088.8911108889047, 20235.59528809445, 20855.0, 20919.58160836775, 20937.79062209389, 21071.894640526698, 984.9901500985042, 1016.4104819204844, 1062.39443517196, 1068.9946550267198, 1083.2038451737967, 11125.94437027826, 11189.697242666203, 12159.088068394905, 12245.0, 12362.505499779909, 529707.0, 593810.0, 615557.0, 617245.0, 622566.0, 115377.0, 118105.99999999828, 119261.0, 123869.76130238762, 127735.0, 1075.596651255779, 1091.6561283195767, 1094.2285688589525, 1116.268843907242, 1123.3540714089431, 18352.0, 18744.906275468536, 18988.95560744117, 19074.855508669523, 19153.425397238105, 53362.0, 53754.46245537651, 54329.18506222331, 54985.450145498035, 55291.0, 76760.0809979755, 77941.61029194818, 78080.0, 78710.0, 79407.0, 7646.617669116411, 8097.352211822922, 8220.58897055133, 8255.25702686737, 8459.111793261618, 9901.752456188653, 12797.29614871191, 12919.806202906775, 13140.948724101858, 13298.933505332412, 11133.554657813596, 11297.71755706114, 11481.866528049728, 11520.0, 11561.075113991028, 10834.02493775564, 11099.278546894426, 11239.269447485887, 11298.0396666281, 11513.481893314653, 10604.363738175734, 10735.677929662123, 11498.54005839757, 11618.128640351839, 11839.76320473603, 7924.960375198087, 7995.800104997422, 8163.83672326562, 8164.918350816416, 8169.2647661710735, 8421.4947103174, 10386.844197337197, 11367.261128026652, 11694.649160525198, 11795.823062653895], "unit": "score", "name": "jquery.html", "value": 9612.896266382744}, {"lowerIsBetter": false, "replicates": [1511.4029958166532, 1650.6203573178168, 1680.9747853782196, 1967.6261510313038, 2042.2239548971397, 8210.876836847445, 8779.956100219499, 8936.195742383185, 8968.73093807186, 8980.416272942253, 8677.91322086779, 8929.73210803677, 8944.776380590489, 8945.194932456077, 8951.507667078307, 2249.49386388063, 2306.8385213035094, 2530.6204069389555, 2559.987200063997, 2563.0, 2319.7796209360085, 2449.436629575199, 2507.3104896153523, 2509.134348649713, 2512.434702192001, 2439.841410308324, 2475.8390704604235, 2481.3176376496426, 2483.3419143926785, 2523.7223905370392, 2486.428121532058, 2525.065725681491, 2532.8606926619027, 2537.961930571043, 2542.250036239314, 2302.873341966191, 2304.5045315257134, 2311.2257393773107, 2314.409825494505, 2322.6399908014287, 8912.24245939096, 8982.595783189772, 8992.955035224848, 8999.550022498914, 9016.008239093695, 5469.015577196104, 5619.6066275360745, 5620.718964051781, 5684.54523638108, 5684.7157642118145, 3524.859005639771, 3536.257385948954, 3665.78005319679, 3669.1377526281303, 3682.797446140461, 1060.946952652372, 1064.9946750266276, 1081.1512962324616, 1081.5025088459317, 1089.8256278995402, 12248.693782655415, 12248.755024899452, 12281.01751859858, 12306.323152226623, 12309.507619695201, 4869.975650121727, 4920.704757714477, 4985.925211121836, 4996.875078123076, 5016.899662006813, 8581.871271930926, 10234.232432567587, 10340.172786177087, 10356.0, 10366.585336586451, 5656.8868622627315, 5659.122835960433, 5668.149777533403, 5670.631408958405, 5681.829545113653, 4552.931706024412, 4598.0803839232285, 5075.97462012695, 5093.770780314895, 5134.717590532557, 3336.882144481577, 3775.565809931893, 3812.989557767194, 3822.2355528893777, 3822.2737679840743, 1279.3858947705153, 1345.1525538910423, 1348.083303353729, 1358.9184648921096, 1363.4886917405972, 1047.664747280863, 1143.9428028598536, 1164.016406136813, 1165.8834116588273, 1222.730999180179, 8264.462809917337, 8317.792055198548, 8405.95797021011, 8407.159284071544, 8425.452345597516, 449.16231228758784, 522.9958479718948, 527.6570229350876, 529.3198240261246, 543.4266848474817, 6248.937510624835, 6280.905786413207, 6320.810375688737, 6321.0, 6335.809925702236, 10619.469026548642, 10975.780484390267, 11114.555417783198, 11147.888521114684, 11159.832602510969, 10618.522166502526, 10765.30025548337, 10859.076978456762, 10867.347959122479, 10876.72808179786, 8509.659613615386, 8511.59558672812, 8514.872276915852, 8539.146085391536, 8555.529445880411, 8036.598170091589, 8044.396670249872, 8074.0, 8094.109647938604, 8130.918690813016, 9376.95311523438, 9657.71026869195, 9683.273754468584, 9923.801523969625, 9941.900580994386, 9691.854622180532, 10105.787305523385, 10109.0, 10127.0, 10137.847932280874, 6441.549091563733, 6699.29657385987, 7477.364424024019, 7592.8481430369975, 7668.693252269847, 8311.709090181814, 8363.20549547792, 8388.119247479171, 8395.202455766692, 8400.075991641037, 7240.0, 7249.0213821135585, 7284.927150728425, 7390.300230946805, 7489.850202996018, 7241.855162896818, 7268.818279543054, 7299.452541059548, 7386.298301661549, 7401.370883474965, 7719.768406947801, 7868.331191848757, 7886.84226315459, 7912.129665736879, 7915.564643944638, 7145.64271786419, 7149.249328820399, 7213.891791623025, 7217.0, 7223.927760722536, 7162.498625096402, 7264.382527485223, 7302.160251571137, 7303.488755787044, 7306.452016098708], "unit": "score", "name": "mootools.html", "value": 4889.551254697412}, {"lowerIsBetter": false, "replicates": [303.3689924956092, 332.42988275108183, 340.1733786897839, 343.0411998464292, 346.46817135696693, 6462.353764623541, 6493.675316234193, 6524.967375163129, 6537.346265373466, 6556.18047744032, 6445.806625801221, 6458.709358078886, 6469.320721324264, 6472.51456140789, 6481.092647029408, 4558.589726924576, 4654.674172807905, 4665.370175026362, 4806.4232292125, 4832.178529649959, 4742.288656701505, 4789.568938795508, 4812.711237325754, 4814.277858321245, 4816.87957801056, 4724.4094488188975, 4726.314684370765, 4744.478107408199, 4751.928721069186, 4752.90494190116, 4518.570735780112, 4603.941093548486, 4732.95267047332, 4739.644526660514, 4783.449903261135, 3287.3589650018257, 3997.860609726243, 4082.877513674565, 4090.529589097262, 4115.670746340285, 5475.685835399515, 5608.691521966291, 6177.073438984188, 6184.938150618526, 6194.783182588588, 5581.330240371181, 5582.051051321285, 5590.468905453975, 5597.804076857331, 5601.747921343549, 6829.521933464659, 6832.419244364235, 6832.760853370109, 6833.760818371333, 6834.179898412172, 4282.828686852522, 4466.57567531084, 4473.239549276631, 4478.753668548228, 4491.7304961702075, 7057.611831349273, 7223.602701851396, 7228.277172282782, 7239.20368759436, 7273.45449091315, 4542.364069030338, 4549.158405694957, 4565.315202719552, 4570.360149579062, 4571.794269257892, 3849.5188101487315, 4624.421947256593, 4633.2818413146015, 4641.559051890065, 4647.140279048387, 4507.774611269489, 4604.654650901196, 5299.019681358961, 5424.321959755031, 5457.61796674229, 6667.066610674509, 6798.252192258848, 6812.182538095361, 6872.0, 6918.342757438036, 1584.5484037049616, 1586.571625661088, 1603.559021269137, 1604.254021879808, 1605.6868910562562, 966.6230170233614, 988.6984469736799, 1016.0753714120116, 1020.0564477857952, 1041.234692501011, 6226.875462490725, 6398.360163983564, 6412.7114279857515, 6422.03669449577, 6424.421802037839, 7164.498485105993, 7168.964155179295, 7169.924511323343, 7174.3184397482155, 7196.136463624294, 6391.169148010822, 6397.968010160012, 6401.199850018747, 6405.423511883952, 6411.647359395185, 3730.869419570302, 3775.7356985010783, 3776.8489260429824, 3787.450819631138, 3793.867214647474, 7225.385842203366, 7523.210062943422, 7539.246075392417, 7542.245775422414, 7566.432517561205, 6252.812415627538, 7222.422206223489, 7394.667239974106, 7429.814254643569, 7434.3309102181065, 5987.281526216795, 7472.738454154187, 7502.3622992046285, 7538.547687138789, 7541.283578060075, 5575.637583557056, 7186.820329491596, 7187.532810367309, 7196.208417074223, 7201.0, 7017.929820701727, 7026.086608740831, 7026.824329391601, 7029.156501219886, 7069.22238553769, 7405.074365704287, 7483.289087536676, 7506.1743208248145, 7533.020707308015, 7534.095908491016, 4579.816807327669, 4583.839565615188, 4591.3801636779945, 4593.885152871071, 4597.494275629745, 7143.571385716666, 7147.821304467222, 7151.964240178766, 7160.176579693402, 7173.92391141333, 6624.455916084871, 6887.0, 6905.1713794345, 6910.0, 6917.550359226634, 6841.692123854339, 6868.450523958171, 6878.484113691593, 6892.346446618189, 6912.688928998307, 6750.122484077038, 6755.459563235027, 6759.493038022069, 6762.7294908205085, 6776.932230677828, 6661.766838160641, 6875.140607424072, 6882.4149947253045, 6882.793516194522, 6900.0, 6420.101185833893, 6607.2071351438135, 6666.0, 6724.831879203059, 6785.185777706707], "unit": "score", "name": "prototype.html", "value": 5017.7197444119465}, {"lowerIsBetter": false, "replicates": [722.8951801988711, 754.5359603843638, 764.5833021003552, 771.2788542712568, 790.9802254943622, 15324.693506129885, 15522.22388880557, 15535.689286214283, 15540.766888496682, 15547.611309717262, 14235.501757438491, 14377.496787612436, 14386.064905781117, 14392.280385980712, 14398.0, 785.1716439156687, 793.175097898188, 945.9905400946005, 974.5711886769834, 976.2873102635081, 969.5346233807777, 983.1299300119374, 983.5033308179395, 984.1929617713478, 989.9554520046615, 841.4614646626164, 1037.5071840875598, 1039.0596510158318, 1039.828428309328, 1040.1730624153815, 1000.6297669862162, 1027.917766578672, 1028.1158203944601, 1029.1201023125195, 1029.5469993203005, 766.7431410477496, 771.5563550958221, 771.8533478639097, 772.4129661457276, 773.5320131320526, 15313.61715957099, 15331.616709582238, 15364.0, 15369.308381122764, 15387.307571159325, 12932.806007909889, 13038.217706937614, 13280.800787988188, 13444.596662100055, 13544.932275338659, 10283.691489255334, 10308.278420510493, 10464.162866970624, 10540.9986051325, 10866.185036122244, 3547.2018795771005, 3550.804705741183, 3617.1680513482047, 3694.07648087978, 3699.075231192202, 86586.83532911664, 87525.12474875234, 87550.0, 87636.05637746317, 88133.0, 9739.759855233337, 9898.752531186634, 10055.245856560787, 10332.225083118796, 10748.462576871125, 23684.644730328713, 23685.526289474114, 23698.881505592708, 23720.64419033716, 23786.167484138317, 7666.693332266758, 7725.768226953201, 7746.0, 7830.491018083806, 7961.1242763295995, 4150.294449943517, 4163.83344666216, 4259.212045771542, 4313.439252897166, 4418.138462999748, 3729.9067523312133, 3775.811209439517, 3782.678472329828, 3784.280986612535, 3784.8296826642318, 647.7085311609794, 660.3033799341645, 670.9060731497594, 674.0092064665033, 680.2041611314773, 587.5563949218313, 609.1624016976657, 613.3896772711181, 626.192212046455, 641.7176442365344, 8154.2253485918745, 8504.659813607386, 8521.233089022018, 8609.655613775503, 8615.267702245254, 589.631480324797, 604.4559896093551, 604.7157835817159, 607.9331273559905, 629.9370062993664, 3904.6095390461296, 3928.253631809947, 3950.4074388841905, 4056.533498647634, 4080.9795951020646, 96360.51819740997, 96564.0, 97906.0, 98659.50670246602, 98662.0, 81145.90672643084, 82351.58824205841, 84248.57875710705, 85450.57274713587, 85507.14492855116, 72222.0, 72464.63767681128, 72790.0, 73995.63002184955, 74137.62931185309, 7916.08964969036, 8111.310538604284, 8162.224588664068, 8195.303399211134, 8213.83572328562, 43868.78065609652, 52523.474765251856, 52838.679033024484, 53540.46459535355, 53701.0, 66180.66909665421, 68136.0, 68806.65596671985, 70353.59292814217, 73353.0, 10342.276040677081, 10404.843927341248, 10519.89480105189, 10522.736931576772, 11175.832362514406, 9043.728688139367, 11366.829497557708, 11508.309501429942, 11547.0, 11589.304641721523, 10583.62957296491, 10666.986636269541, 10702.785944281226, 10918.508667110158, 10951.288166269167, 8722.607482663168, 9258.675946342115, 10408.687739367831, 10722.73193170177, 10899.56401743953, 10223.948880255552, 10490.895091049297, 10690.62582809598, 10743.946280268548, 10895.727606809893, 8886.73339799807, 9021.774455638662, 9115.316351273548, 9237.353385262966, 9276.2578993679, 9093.909060909571, 9113.908860911306, 9116.903112284079, 9173.724788256362, 9288.210502107126], "unit": "score", "name": "yui.html", "value": 7075.408355216806}], "name": "dromaeo_css", "value": 7552.269366726306}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 111.0, 109.0, 116.0, 165.0, 176.0, 110.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 123.1}, {"lowerIsBetter": true, "replicates": [153.0, 121.0, 158.0, 147.0, 115.0, 140.0, 138.0, 178.0, 153.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 142.1}, {"lowerIsBetter": true, "replicates": [185.0, 184.0, 187.0, 184.0, 182.0, 185.0, 186.0, 185.0, 187.0, 184.0], "unit": "score", "name": "audio-dft", "value": 184.9}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 71.0, 116.0, 55.0, 57.0, 58.0, 62.0, 119.0, 55.0], "unit": "score", "name": "audio-fft", "value": 74.3}, {"lowerIsBetter": true, "replicates": [91.0, 95.0, 128.0, 80.0, 79.0, 85.0, 119.0, 76.0, 79.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 94.9}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 87.0, 79.0, 134.0, 130.0, 89.0, 85.0, 89.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 95.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 93.0, 94.0, 93.0, 93.0, 92.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.0}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 88.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 85.3}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 57.0, 57.0, 57.0, 57.0, 57.0, 67.0, 54.0, 50.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 72.0, 72.0, 71.0, 65.0, 64.0, 65.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.7}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 81.0, 82.0, 81.0, 81.0, 81.0, 80.0, 80.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.2}, {"lowerIsBetter": true, "replicates": [140.0, 140.0, 116.0, 105.0, 130.0, 128.0, 102.0, 126.0, 130.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [132.0, 121.0, 136.0, 133.0, 169.0, 162.0, 135.0, 131.0, 122.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.6}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 63.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.7}], "name": "kraken", "value": 1425.9999999999998}]} 07:37:45 INFO - Return code: 0 07:37:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:37:45 INFO - # TBPL SUCCESS # 07:37:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:37:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:37:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:37:45 INFO - 2016-04-25 07:37:45.969 screenresolution[1681:10006] starting screenresolution argv=screenresolution get 07:37:45 INFO - 2016-04-25 07:37:45.972 screenresolution[1681:10006] Display 0: 1600x1200x32@60 07:37:45 INFO - 2016-04-25 07:37:45.978 screenresolution[1682:10009] starting screenresolution argv=screenresolution list 07:37:45 INFO - Available Modes on Display 0 07:37:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:37:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:37:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:37:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:37:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:37:46 INFO - Intel Iris: 07:37:46 INFO - Chipset Model: Intel Iris 07:37:46 INFO - Type: GPU 07:37:46 INFO - Bus: Built-In 07:37:46 INFO - VRAM (Dynamic, Max): 1536 MB 07:37:46 INFO - Vendor: Intel (0x8086) 07:37:46 INFO - Device ID: 0x0a2e 07:37:46 INFO - Revision ID: 0x0009 07:37:46 INFO - Displays: 07:37:46 INFO - Display: 07:37:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:37:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:37:46 INFO - Display Serial Number: 1600x1200 60 07:37:46 INFO - Main Display: Yes 07:37:46 INFO - Mirror: Off 07:37:46 INFO - Online: Yes 07:37:46 INFO - Rotation: Supported 07:37:46 INFO - Return code: 0 07:37:46 INFO - Running post-action listener: _resource_record_post_action 07:37:46 INFO - Running post-run listener: _resource_record_post_run 07:37:47 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 37852672; Write bytes: 663935488; Read time: 398; Write time: 1830 07:37:47 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 362598912; Write bytes: 363668992; Read time: 28879; Write time: 667 07:37:47 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 36066816; Write bytes: 298734592; Read time: 378; Write time: 1159 07:37:47 INFO - Running post-run listener: _upload_blobber_files 07:37:47 INFO - Blob upload gear active. 07:37:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:37:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:37:47 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:37:47 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:37:47 INFO - (blobuploader) - INFO - Open directory for files ... 07:37:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:37:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:37:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:49 INFO - (blobuploader) - INFO - Done attempting. 07:37:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:37:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:37:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:49 INFO - (blobuploader) - INFO - Done attempting. 07:37:49 INFO - (blobuploader) - INFO - Iteration through files over. 07:37:49 INFO - Return code: 0 07:37:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:37:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:37:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea520c9c564046d34931d86cba0730945c51a9ba688211e275aced30bd4a3564f5e88bc5eafeea831e76ca902412ac73441fcf7e4a66fcb4ee2cf9b74ab3ce17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00e20971b75e3fd4ef0f1239835881b735b610e014ba062da637862b868f9a0f45d07674e4df1277e254491d186c12b9265c00d7f3a8f175c7a10de9b95d75ed"} 07:37:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:37:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:37:49 INFO - Contents: 07:37:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea520c9c564046d34931d86cba0730945c51a9ba688211e275aced30bd4a3564f5e88bc5eafeea831e76ca902412ac73441fcf7e4a66fcb4ee2cf9b74ab3ce17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00e20971b75e3fd4ef0f1239835881b735b610e014ba062da637862b868f9a0f45d07674e4df1277e254491d186c12b9265c00d7f3a8f175c7a10de9b95d75ed"} 07:37:49 INFO - Running post-run listener: copy_logs_to_upload_dir 07:37:49 INFO - Copying logs to upload dir... 07:37:49 INFO - mkdir: /builds/slave/test/build/upload/logs 07:37:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.180518 ========= master_lag: 19.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-04-25 07:38:09.061599) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-04-25 07:38:09.065524) ========= 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.q8yXeL8ZlS/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.c7FkgiDSq2/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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/Mozilla-Aurora/sha512/ea520c9c564046d34931d86cba0730945c51a9ba688211e275aced30bd4a3564f5e88bc5eafeea831e76ca902412ac73441fcf7e4a66fcb4ee2cf9b74ab3ce17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00e20971b75e3fd4ef0f1239835881b735b610e014ba062da637862b868f9a0f45d07674e4df1277e254491d186c12b9265c00d7f3a8f175c7a10de9b95d75ed"} build_url:https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011060 build_url: 'https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea520c9c564046d34931d86cba0730945c51a9ba688211e275aced30bd4a3564f5e88bc5eafeea831e76ca902412ac73441fcf7e4a66fcb4ee2cf9b74ab3ce17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00e20971b75e3fd4ef0f1239835881b735b610e014ba062da637862b868f9a0f45d07674e4df1277e254491d186c12b9265c00d7f3a8f175c7a10de9b95d75ed"}' ========= master_lag: 8.94 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-04-25 07:38:18.015913) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2016-04-25 07:38:18.020277) ========= 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.q8yXeL8ZlS/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.c7FkgiDSq2/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.004989 ========= master_lag: 8.94 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2016-04-25 07:38:26.964150) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 07:38:26.964454) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 07:38:27.807562) ========= ========= Total master_lag: 40.69 =========