builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0203 starttime: 1465001649.66 results: success (0) buildid: 20160603160527 builduid: b7689d4d25354adb976fc889ee28d97a revision: ab782095ef4ab44dae4cc5f919858c5684837378 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 17:54:09.656208) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 17:54:09.656592) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 17:54:09.656878) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 17:54:09.700172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 17:54:09.700474) ========= 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.FOjKVuxJrj/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.co6xYSNczu/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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-06-03 17:54:09-- 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% 187M=0s 2016-06-03 17:54:10 (187 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.523687 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 17:54:10.244799) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 17:54:10.245079) ========= 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.FOjKVuxJrj/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.co6xYSNczu/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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.025209 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 17:54:10.293109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 17:54:10.293412) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ab782095ef4ab44dae4cc5f919858c5684837378 --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 ab782095ef4ab44dae4cc5f919858c5684837378 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FOjKVuxJrj/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.co6xYSNczu/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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-06-03 17:54:10,376 truncating revision to first 12 chars 2016-06-03 17:54:10,376 Setting DEBUG logging. 2016-06-03 17:54:10,376 attempt 1/10 2016-06-03 17:54:10,376 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ab782095ef4a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 17:54:11,436 unpacking tar archive at: mozilla-aurora-ab782095ef4a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.327526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 17:54:11.641901) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 17:54:11.642206) ========= script_repo_revision: ab782095ef4ab44dae4cc5f919858c5684837378 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 17:54:11.642590) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 17:54:11.642876) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 17:54:11.660004) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-06-03 17:54:11.660276) ========= /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.FOjKVuxJrj/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.co6xYSNczu/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:54:11 INFO - MultiFileLogger online at 20160603 17:54:11 in /builds/slave/test 17:54:11 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 17:54:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:54:11 INFO - {'append_to_log': False, 17:54:11 INFO - 'base_work_dir': '/builds/slave/test', 17:54:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:54:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:54:11 INFO - 'branch': 'Mozilla-Aurora', 17:54:11 INFO - 'buildbot_json_path': 'buildprops.json', 17:54:11 INFO - 'config_files': ('talos/mac_config.py',), 17:54:11 INFO - 'default_actions': ('clobber', 17:54:11 INFO - 'read-buildbot-config', 17:54:11 INFO - 'download-and-extract', 17:54:11 INFO - 'populate-webroot', 17:54:11 INFO - 'create-virtualenv', 17:54:11 INFO - 'install', 17:54:11 INFO - 'run-tests'), 17:54:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:54:11 INFO - 'download_minidump_stackwalk': True, 17:54:11 INFO - 'download_symbols': 'ondemand', 17:54:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:54:11 INFO - 'tooltool.py': '/tools/tooltool.py', 17:54:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:54:11 INFO - '/tools/misc-python/virtualenv.py')}, 17:54:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:54:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:54:11 INFO - 'installer_path': 'installer.exe', 17:54:11 INFO - 'log_level': 'info', 17:54:11 INFO - 'log_name': 'talos', 17:54:11 INFO - 'log_to_console': True, 17:54:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:54:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:54:11 INFO - 'opt_config_files': (), 17:54:11 INFO - 'pip_index': False, 17:54:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:54:11 INFO - 'cmd': ('bash', 17:54:11 INFO - '-c', 17:54:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:54:11 INFO - 'enabled': True, 17:54:11 INFO - 'halt_on_failure': False, 17:54:11 INFO - 'name': 'check_screen_resolution'},), 17:54:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:54:11 INFO - 'cmd': ('bash', 17:54:11 INFO - '-c', 17:54:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:54:11 INFO - 'enabled': True, 17:54:11 INFO - 'halt_on_failure': False, 17:54:11 INFO - 'name': 'check_screen_resolution'},), 17:54:11 INFO - 'run_cmd_checks_enabled': True, 17:54:11 INFO - 'sps_profile': False, 17:54:11 INFO - 'sps_profile_interval': 0, 17:54:11 INFO - 'suite': 'dromaeojs', 17:54:11 INFO - 'system_bits': '32', 17:54:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:54:11 INFO - 'title': 't-yosemite-r7-0203', 17:54:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:54:11 INFO - 'use_talos_json': True, 17:54:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:54:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:54:11 INFO - 'work_dir': 'build'} 17:54:11 INFO - ##### 17:54:11 INFO - ##### Running clobber step. 17:54:11 INFO - ##### 17:54:11 INFO - Running pre-action listener: _resource_record_pre_action 17:54:11 INFO - Running main action method: clobber 17:54:11 INFO - rmtree: /builds/slave/test/build 17:54:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:54:13 INFO - Running post-action listener: _resource_record_post_action 17:54:13 INFO - ##### 17:54:13 INFO - ##### Running read-buildbot-config step. 17:54:13 INFO - ##### 17:54:13 INFO - Running pre-action listener: _resource_record_pre_action 17:54:13 INFO - Running main action method: read_buildbot_config 17:54:13 INFO - Using buildbot properties: 17:54:13 INFO - { 17:54:13 INFO - "project": "", 17:54:13 INFO - "product": "firefox", 17:54:13 INFO - "script_repo_revision": "production", 17:54:13 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 17:54:13 INFO - "repository": "", 17:54:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 17:54:13 INFO - "buildid": "20160603160527", 17:54:13 INFO - "pgo_build": "False", 17:54:13 INFO - "basedir": "/builds/slave/test", 17:54:13 INFO - "buildnumber": 368, 17:54:13 INFO - "slavename": "t-yosemite-r7-0203", 17:54:13 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:54:13 INFO - "platform": "yosemite_r7", 17:54:13 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 17:54:13 INFO - "branch": "mozilla-aurora", 17:54:13 INFO - "repo_path": "releases/mozilla-aurora", 17:54:13 INFO - "revision": "ab782095ef4ab44dae4cc5f919858c5684837378", 17:54:13 INFO - "stage_platform": "macosx64", 17:54:13 INFO - "builduid": "b7689d4d25354adb976fc889ee28d97a", 17:54:13 INFO - "slavebuilddir": "test" 17:54:13 INFO - } 17:54:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 17:54:13 INFO - Running post-action listener: _resource_record_post_action 17:54:13 INFO - ##### 17:54:13 INFO - ##### Running download-and-extract step. 17:54:13 INFO - ##### 17:54:13 INFO - Running pre-action listener: _resource_record_pre_action 17:54:13 INFO - Running main action method: download_and_extract 17:54:13 INFO - mkdir: /builds/slave/test/build/tests 17:54:13 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')]} 17:54:13 INFO - https://queue.taskcluster.net/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:54:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 17:54:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 17:54:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 17:54:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 17:54:16 INFO - Downloaded 1199 bytes. 17:54:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 17:54:16 INFO - Using the following test package requirements: 17:54:16 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 17:54:16 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 17:54:16 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 17:54:16 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 17:54:16 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 17:54:16 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 17:54:16 INFO - u'jsshell-mac.zip'], 17:54:16 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 17:54:16 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 17:54:16 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 17:54:16 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 17:54:16 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 17:54:16 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 17:54:16 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 17:54:16 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 17:54:16 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 17:54:16 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 17:54:16 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 17:54:16 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 17:54: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')]} 17:54:16 INFO - https://queue.taskcluster.net/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:54:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 17:54:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 17:54:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 17:54:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:54:17 INFO - Downloaded 18466763 bytes. 17:54:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:54:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:54:20 INFO - Return code: 0 17:54:20 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 17:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:54:20 INFO - https://queue.taskcluster.net/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:54:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 17:54:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 17:54:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 17:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:54:45 INFO - Downloaded 18466763 bytes. 17:54:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:54:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:54:48 INFO - Return code: 0 17:54: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')]} 17:54:48 INFO - https://queue.taskcluster.net/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:54:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 17:54:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 17:54:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 17:54:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 17:54:49 INFO - Downloaded 10840145 bytes. 17:54:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:54:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:54:49 INFO - Return code: 0 17:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:54:50 INFO - https://queue.taskcluster.net/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 17:54:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 17:54:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 17:54:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 17:54:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 17:54:53 INFO - Downloaded 114163398 bytes. 17:54:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 17:54:53 INFO - mkdir: /builds/slave/test/properties 17:54:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:54:53 INFO - Writing to file /builds/slave/test/properties/build_url 17:54:53 INFO - Contents: 17:54:53 INFO - build_url:https://queue.taskcluster.net/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 17:54:54 INFO - Running post-action listener: _resource_record_post_action 17:54:54 INFO - Running post-action listener: set_extra_try_arguments 17:54:54 INFO - ##### 17:54:54 INFO - ##### Running populate-webroot step. 17:54:54 INFO - ##### 17:54:54 INFO - Running pre-action listener: _resource_record_pre_action 17:54:54 INFO - Running main action method: populate_webroot 17:54:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:54:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:54:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:54:54 INFO - '--tppagecycles', 17:54:54 INFO - '7'], 17:54:54 INFO - 'tests': ['tsvgm']}}, 17:54:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:54:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:54:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:54:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:54:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:54:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:54:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:54 INFO - 'talos_options': ['--disable-e10s'], 17:54:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:54:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:54:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:54 INFO - 'talos_options': ['--disable-e10s'], 17:54:54 INFO - 'tests': ['damp', 'tps']}, 17:54:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:54 INFO - 'tests': ['damp', 'tps']}, 17:54:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:54:54 INFO - 'tests': ['dromaeo_dom']}, 17:54:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:54:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:54:54 INFO - 'tests': ['a11yr', 17:54:54 INFO - 'ts_paint', 17:54:54 INFO - 'tpaint', 17:54:54 INFO - 'sessionrestore', 17:54:54 INFO - 'sessionrestore_no_auto_restore', 17:54:54 INFO - 'tabpaint']}, 17:54:54 INFO - 'other-e10s': {'tests': ['a11yr', 17:54:54 INFO - 'ts_paint', 17:54:54 INFO - 'tpaint', 17:54:54 INFO - 'sessionrestore', 17:54:54 INFO - 'sessionrestore_no_auto_restore', 17:54:54 INFO - 'tabpaint']}, 17:54:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:54:54 INFO - 'ts_paint', 17:54:54 INFO - 'tpaint', 17:54:54 INFO - 'sessionrestore', 17:54:54 INFO - 'sessionrestore_no_auto_restore', 17:54:54 INFO - 'tabpaint']}, 17:54:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:54:54 INFO - 'ts_paint', 17:54:54 INFO - 'tpaint', 17:54:54 INFO - 'sessionrestore', 17:54:54 INFO - 'sessionrestore_no_auto_restore', 17:54:54 INFO - 'tabpaint']}, 17:54:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:54:54 INFO - 'tests': ['a11yr', 17:54:54 INFO - 'ts_paint', 17:54:54 INFO - 'tpaint', 17:54:54 INFO - 'sessionrestore', 17:54:54 INFO - 'sessionrestore_no_auto_restore', 17:54:54 INFO - 'tabpaint']}, 17:54:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:54:54 INFO - 'tests': ['a11yr', 17:54:54 INFO - 'ts_paint', 17:54:54 INFO - 'tpaint', 17:54:54 INFO - 'sessionrestore', 17:54:54 INFO - 'sessionrestore_no_auto_restore', 17:54:54 INFO - 'tabpaint']}, 17:54:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:54:54 INFO - 'tests': ['tsvgx', 17:54:54 INFO - 'tsvgr_opacity', 17:54:54 INFO - 'tart', 17:54:54 INFO - 'tscrollx', 17:54:54 INFO - 'cart']}, 17:54:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:54:54 INFO - 'tsvgr_opacity', 17:54:54 INFO - 'tart', 17:54:54 INFO - 'tscrollx', 17:54:54 INFO - 'cart']}, 17:54:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:54 INFO - 'talos_options': ['--disable-e10s'], 17:54:54 INFO - 'tests': ['tp5o']}, 17:54:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:54 INFO - 'tests': ['tp5o']}, 17:54:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:54 INFO - 'talos_options': ['--disable-e10s', 17:54:54 INFO - '--xperf_path', 17:54:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:54:54 INFO - 'tests': ['tp5n']}, 17:54:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:54 INFO - 'talos_options': ['--xperf_path', 17:54:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:54:54 INFO - 'tests': ['tp5n']}}, 17:54:54 INFO - 'talos.zip': {'path': '', 17:54:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:54:54 INFO - Running post-action listener: _resource_record_post_action 17:54:54 INFO - ##### 17:54:54 INFO - ##### Running create-virtualenv step. 17:54:54 INFO - ##### 17:54:54 INFO - Running pre-action listener: _resource_record_pre_action 17:54:54 INFO - Running main action method: create_virtualenv 17:54:54 INFO - Creating virtualenv /builds/slave/test/build/venv 17:54:54 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 17:54:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:54:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:54:54 INFO - Using real prefix '/tools/python27' 17:54:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:54:55 INFO - Installing distribute.............................................................................................................................................................................................done. 17:54:58 INFO - Installing pip.................done. 17:54:58 INFO - Return code: 0 17:54:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:54:58 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')]} 17:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:58 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')]} 17:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:58 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 0x106586a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106596420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6a259a6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106425e00>, '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 0x10628edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106420b20>, '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.FOjKVuxJrj/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.co6xYSNczu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:54:58 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 17:54:58 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 17:54:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FOjKVuxJrj/Render', 17:54:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:54:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:54:58 INFO - 'HOME': '/Users/cltbld', 17:54:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:54:58 INFO - 'LOGNAME': 'cltbld', 17:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:58 INFO - 'MOZ_NO_REMOTE': '1', 17:54:58 INFO - 'NO_EM_RESTART': '1', 17:54:58 INFO - 'PAGER': '/bin/cat', 17:54:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:58 INFO - 'PWD': '/builds/slave/test', 17:54:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:54:58 INFO - 'SHELL': '/bin/bash', 17:54:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.co6xYSNczu/Listeners', 17:54:58 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:54:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:54:58 INFO - 'USER': 'cltbld', 17:54:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:54:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:58 INFO - 'XPC_FLAGS': '0x0', 17:54:58 INFO - 'XPC_SERVICE_NAME': '0', 17:54:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:58 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 17:54:58 INFO - Cleaning up... 17:54:58 INFO - Return code: 0 17:54:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:54:58 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')]} 17:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:58 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')]} 17:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:58 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 0x106586a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106596420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6a259a6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106425e00>, '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 0x10628edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106420b20>, '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.FOjKVuxJrj/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.co6xYSNczu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:54:58 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 17:54:58 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 17:54:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FOjKVuxJrj/Render', 17:54:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:54:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:54:58 INFO - 'HOME': '/Users/cltbld', 17:54:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:54:58 INFO - 'LOGNAME': 'cltbld', 17:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:58 INFO - 'MOZ_NO_REMOTE': '1', 17:54:58 INFO - 'NO_EM_RESTART': '1', 17:54:58 INFO - 'PAGER': '/bin/cat', 17:54:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:58 INFO - 'PWD': '/builds/slave/test', 17:54:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:54:58 INFO - 'SHELL': '/bin/bash', 17:54:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.co6xYSNczu/Listeners', 17:54:58 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:54:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:54:58 INFO - 'USER': 'cltbld', 17:54:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:54:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:58 INFO - 'XPC_FLAGS': '0x0', 17:54:58 INFO - 'XPC_SERVICE_NAME': '0', 17:54:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:58 INFO - Downloading/unpacking psutil>=0.7.1 17:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:55:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:55:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:55:01 INFO - Installing collected packages: psutil 17:55:01 INFO - Running setup.py install for psutil 17:55:01 INFO - building 'psutil._psutil_osx' extension 17:55:01 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 17:55:02 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 17:55:02 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 17:55:02 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 17:55:02 INFO - building 'psutil._psutil_posix' extension 17:55:02 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 17:55:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:55:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:55:02 INFO - ^ 17:55:02 INFO - 1 warning generated. 17:55:02 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 17:55:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:55:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:55:02 INFO - Successfully installed psutil 17:55:02 INFO - Cleaning up... 17:55:03 INFO - Return code: 0 17:55:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106586a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106596420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6a259a6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106425e00>, '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 0x10628edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106420b20>, '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.FOjKVuxJrj/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.co6xYSNczu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:55:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:55:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FOjKVuxJrj/Render', 17:55:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:03 INFO - 'HOME': '/Users/cltbld', 17:55:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:03 INFO - 'LOGNAME': 'cltbld', 17:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:03 INFO - 'MOZ_NO_REMOTE': '1', 17:55:03 INFO - 'NO_EM_RESTART': '1', 17:55:03 INFO - 'PAGER': '/bin/cat', 17:55:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:03 INFO - 'PWD': '/builds/slave/test', 17:55:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:03 INFO - 'SHELL': '/bin/bash', 17:55:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.co6xYSNczu/Listeners', 17:55:03 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:55:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:03 INFO - 'USER': 'cltbld', 17:55:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:03 INFO - 'XPC_FLAGS': '0x0', 17:55:03 INFO - 'XPC_SERVICE_NAME': '0', 17:55:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:55:03 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 17:55:03 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 17:55:03 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 17:55:03 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 17:55:03 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 17:55:03 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 17:55:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:55:06 INFO - Installing collected packages: mozsystemmonitor 17:55:06 INFO - Running setup.py install for mozsystemmonitor 17:55:06 INFO - Successfully installed mozsystemmonitor 17:55:06 INFO - Cleaning up... 17:55:06 INFO - Return code: 0 17:55:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:55:06 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')]} 17:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:06 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')]} 17:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:06 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 0x106586a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106596420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6a259a6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106425e00>, '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 0x10628edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106420b20>, '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.FOjKVuxJrj/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.co6xYSNczu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:55:06 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 17:55:06 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 17:55:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FOjKVuxJrj/Render', 17:55:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:06 INFO - 'HOME': '/Users/cltbld', 17:55:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:06 INFO - 'LOGNAME': 'cltbld', 17:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:06 INFO - 'MOZ_NO_REMOTE': '1', 17:55:06 INFO - 'NO_EM_RESTART': '1', 17:55:06 INFO - 'PAGER': '/bin/cat', 17:55:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:06 INFO - 'PWD': '/builds/slave/test', 17:55:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:06 INFO - 'SHELL': '/bin/bash', 17:55:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.co6xYSNczu/Listeners', 17:55:06 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:55:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:06 INFO - 'USER': 'cltbld', 17:55:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:06 INFO - 'XPC_FLAGS': '0x0', 17:55:06 INFO - 'XPC_SERVICE_NAME': '0', 17:55:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:06 INFO - Downloading/unpacking blobuploader==1.2.4 17:55:06 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 17:55:06 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 17:55:06 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 17:55:06 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 17:55:06 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 17:55:06 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 17:55:08 INFO - Downloading blobuploader-1.2.4.tar.gz 17:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:55:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:55:09 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 17:55:09 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 17:55:09 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 17:55:09 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 17:55:09 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 17:55:09 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 17:55:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:55:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:55:09 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 17:55:09 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 17:55:09 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 17:55:09 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 17:55:09 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 17:55:09 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 17:55:10 INFO - Downloading docopt-0.6.1.tar.gz 17:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:55:10 INFO - Installing collected packages: blobuploader, requests, docopt 17:55:10 INFO - Running setup.py install for blobuploader 17:55:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:55:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:55:10 INFO - Running setup.py install for requests 17:55:10 INFO - Running setup.py install for docopt 17:55:10 INFO - Successfully installed blobuploader requests docopt 17:55:10 INFO - Cleaning up... 17:55:11 INFO - Return code: 0 17:55:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:55: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')]} 17:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55: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')]} 17:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:11 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 0x106586a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106596420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6a259a6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106425e00>, '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 0x10628edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106420b20>, '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.FOjKVuxJrj/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.co6xYSNczu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:55:11 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 17:55:11 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 17:55:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FOjKVuxJrj/Render', 17:55:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:11 INFO - 'HOME': '/Users/cltbld', 17:55:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:11 INFO - 'LOGNAME': 'cltbld', 17:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:11 INFO - 'MOZ_NO_REMOTE': '1', 17:55:11 INFO - 'NO_EM_RESTART': '1', 17:55:11 INFO - 'PAGER': '/bin/cat', 17:55:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:11 INFO - 'PWD': '/builds/slave/test', 17:55:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:11 INFO - 'SHELL': '/bin/bash', 17:55:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.co6xYSNczu/Listeners', 17:55:11 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:55:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:11 INFO - 'USER': 'cltbld', 17:55:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:11 INFO - 'XPC_FLAGS': '0x0', 17:55:11 INFO - 'XPC_SERVICE_NAME': '0', 17:55:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:55:11 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-z2shAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:55:11 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-hmvJbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:55:11 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-fo7jBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:55:11 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-Jc7xRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:55:11 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-dUQDRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:55:11 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-48bgsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:55:11 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-SLCWdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:55:12 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-2aa0gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:55:12 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-n4TWZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:55:12 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-zM5MoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:55:12 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-Vbjowm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:55:12 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-kd8xGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:55:12 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-ONv558-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:55:12 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-MDaJCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:12 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-izKa2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:55:12 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-tIkFnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:55:12 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-XlOVyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:55:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:55:13 INFO - Running setup.py install for manifestparser 17:55:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:55:13 INFO - Running setup.py install for mozcrash 17:55:13 INFO - Running setup.py install for mozdebug 17:55:13 INFO - Running setup.py install for mozdevice 17:55:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:55:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:55:13 INFO - Running setup.py install for mozfile 17:55:13 INFO - Running setup.py install for mozhttpd 17:55:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:55:13 INFO - Running setup.py install for mozinfo 17:55:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:55:14 INFO - Running setup.py install for mozInstall 17:55:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:55:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:55:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:55:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:55:14 INFO - Running setup.py install for mozleak 17:55:14 INFO - Running setup.py install for mozlog 17:55:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:55:14 INFO - Running setup.py install for moznetwork 17:55:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:55:14 INFO - Running setup.py install for mozprocess 17:55:14 INFO - Running setup.py install for mozprofile 17:55:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:55:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:55:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:55:14 INFO - Running setup.py install for mozrunner 17:55:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:55:15 INFO - Running setup.py install for mozscreenshot 17:55:15 INFO - Running setup.py install for moztest 17:55:15 INFO - Running setup.py install for mozversion 17:55:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:55:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:55:15 INFO - Cleaning up... 17:55:15 INFO - Return code: 0 17:55:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:55: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')]} 17:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55: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')]} 17:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:15 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 0x106586a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106596420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6a259a6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106425e00>, '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 0x10628edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106420b20>, '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.FOjKVuxJrj/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.co6xYSNczu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:55:15 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 17:55:15 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 17:55:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FOjKVuxJrj/Render', 17:55:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:15 INFO - 'HOME': '/Users/cltbld', 17:55:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:15 INFO - 'LOGNAME': 'cltbld', 17:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:15 INFO - 'MOZ_NO_REMOTE': '1', 17:55:15 INFO - 'NO_EM_RESTART': '1', 17:55:15 INFO - 'PAGER': '/bin/cat', 17:55:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:15 INFO - 'PWD': '/builds/slave/test', 17:55:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:15 INFO - 'SHELL': '/bin/bash', 17:55:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.co6xYSNczu/Listeners', 17:55:15 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:55:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:15 INFO - 'USER': 'cltbld', 17:55:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:15 INFO - 'XPC_FLAGS': '0x0', 17:55:15 INFO - 'XPC_SERVICE_NAME': '0', 17:55:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:55:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-0s9Gp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:55:16 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)) 17:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:55:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-M1jLPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:55:16 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)) 17:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:55:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-CB9cIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:55:16 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)) 17:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:55:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-MvwZju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:55:16 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)) 17:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:55:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-lNeg5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:55:16 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)) 17:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:55:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-T4Nqfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:55:16 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)) 17:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:55:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-Xt8MGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:55:16 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)) 17:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:55:16 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-jVL39j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:55:17 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)) 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:55:17 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-K0Afjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:55:17 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)) 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:55:17 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-UOndcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:55:17 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)) 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:55:17 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-Os_Gn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:55:17 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)) 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:55:17 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-k819eU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:55:17 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)) 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:55:17 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-V2ZXnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:55:17 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)) 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:55:17 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-T9Ip1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:55:17 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)) 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:17 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-iGBVd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:17 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)) 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:55:17 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-orqBcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:55:17 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)) 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:55:17 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-hp1ywb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:55:18 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)) 17:55:18 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)) 17:55:18 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)) 17:55:18 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)) 17:55:18 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)) 17:55:18 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)) 17:55:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:55:18 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 17:55:18 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 17:55:18 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 17:55:18 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 17:55:18 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 17:55:18 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 17:55:20 INFO - Downloading blessings-1.6.tar.gz 17:55:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:55:20 INFO - Installing collected packages: blessings 17:55:20 INFO - Running setup.py install for blessings 17:55:20 INFO - Successfully installed blessings 17:55:20 INFO - Cleaning up... 17:55:20 INFO - Return code: 0 17:55:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:55:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:55:21 INFO - Reading from file tmpfile_stdout 17:55:21 INFO - Current package versions: 17:55:21 INFO - blessings == 1.6 17:55:21 INFO - blobuploader == 1.2.4 17:55:21 INFO - docopt == 0.6.1 17:55:21 INFO - manifestparser == 1.1 17:55:21 INFO - mozInstall == 1.12 17:55:21 INFO - mozcrash == 0.17 17:55:21 INFO - mozdebug == 0.1 17:55:21 INFO - mozdevice == 0.48 17:55:21 INFO - mozfile == 1.2 17:55:21 INFO - mozhttpd == 0.7 17:55:21 INFO - mozinfo == 0.9 17:55:21 INFO - mozleak == 0.1 17:55:21 INFO - mozlog == 3.1 17:55:21 INFO - moznetwork == 0.27 17:55:21 INFO - mozprocess == 0.22 17:55:21 INFO - mozprofile == 0.28 17:55:21 INFO - mozrunner == 6.11 17:55:21 INFO - mozscreenshot == 0.1 17:55:21 INFO - mozsystemmonitor == 0.0 17:55:21 INFO - moztest == 0.7 17:55:21 INFO - mozversion == 1.4 17:55:21 INFO - psutil == 3.1.1 17:55:21 INFO - requests == 1.2.3 17:55:21 INFO - wsgiref == 0.1.2 17:55:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:21 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 0x106586a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106596420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6a259a6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106425e00>, '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 0x10628edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106420b20>, '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.FOjKVuxJrj/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.co6xYSNczu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:55:21 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 17:55:21 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 17:55:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FOjKVuxJrj/Render', 17:55:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:21 INFO - 'HOME': '/Users/cltbld', 17:55:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:21 INFO - 'LOGNAME': 'cltbld', 17:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:21 INFO - 'MOZ_NO_REMOTE': '1', 17:55:21 INFO - 'NO_EM_RESTART': '1', 17:55:21 INFO - 'PAGER': '/bin/cat', 17:55:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:21 INFO - 'PWD': '/builds/slave/test', 17:55:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:21 INFO - 'SHELL': '/bin/bash', 17:55:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.co6xYSNczu/Listeners', 17:55:21 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:55:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:21 INFO - 'USER': 'cltbld', 17:55:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:21 INFO - 'XPC_FLAGS': '0x0', 17:55:21 INFO - 'XPC_SERVICE_NAME': '0', 17:55:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:21 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)) 17:55:21 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)) 17:55:21 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)) 17:55:21 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)) 17:55:21 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)) 17:55:21 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)) 17:55:21 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)) 17:55:21 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)) 17:55:21 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)) 17:55:21 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)) 17:55:21 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)) 17:55:21 INFO - Cleaning up... 17:55:21 INFO - Return code: 0 17:55:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106586a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106596420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6a259a6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106425e00>, '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 0x10628edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106420b20>, '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.FOjKVuxJrj/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.co6xYSNczu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:55:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FOjKVuxJrj/Render', 17:55:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:21 INFO - 'HOME': '/Users/cltbld', 17:55:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:21 INFO - 'LOGNAME': 'cltbld', 17:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:21 INFO - 'MOZ_NO_REMOTE': '1', 17:55:21 INFO - 'NO_EM_RESTART': '1', 17:55:21 INFO - 'PAGER': '/bin/cat', 17:55:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:21 INFO - 'PWD': '/builds/slave/test', 17:55:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:21 INFO - 'SHELL': '/bin/bash', 17:55:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.co6xYSNczu/Listeners', 17:55:21 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:55:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:21 INFO - 'USER': 'cltbld', 17:55:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:21 INFO - 'XPC_FLAGS': '0x0', 17:55:21 INFO - 'XPC_SERVICE_NAME': '0', 17:55:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:21 INFO - Downloading/unpacking jsonschema 17:55: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 17:55: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 17:55: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 17:55: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 17:55: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 17:55: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 17:55:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:55:23 INFO - Downloading/unpacking functools32 (from jsonschema) 17:55:23 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 17:55:23 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 17:55:23 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 17:55:23 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 17:55:23 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 17:55:23 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 17:55:24 INFO - Downloading functools32-3.2.3-2.tar.gz 17:55:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:55:24 INFO - warning: no files found matching '*.txt' 17:55:24 INFO - no previously-included directories found matching 'build' 17:55:24 INFO - no previously-included directories found matching 'dist' 17:55:24 INFO - no previously-included directories found matching '.git*' 17:55:24 INFO - Installing collected packages: jsonschema, functools32 17:55:24 INFO - Running setup.py install for functools32 17:55:24 INFO - warning: no files found matching '*.txt' 17:55:24 INFO - no previously-included directories found matching 'build' 17:55:24 INFO - no previously-included directories found matching 'dist' 17:55:24 INFO - no previously-included directories found matching '.git*' 17:55:24 INFO - Successfully installed jsonschema functools32 17:55:24 INFO - Cleaning up... 17:55:24 INFO - Return code: 0 17:55:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:55: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')]} 17:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55: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')]} 17:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106586a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106596420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6a259a6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106425e00>, '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 0x10628edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106420b20>, '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.FOjKVuxJrj/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.co6xYSNczu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 17:55:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:55:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FOjKVuxJrj/Render', 17:55:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:24 INFO - 'HOME': '/Users/cltbld', 17:55:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:24 INFO - 'LOGNAME': 'cltbld', 17:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:24 INFO - 'MOZ_NO_REMOTE': '1', 17:55:24 INFO - 'NO_EM_RESTART': '1', 17:55:24 INFO - 'PAGER': '/bin/cat', 17:55:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:24 INFO - 'PWD': '/builds/slave/test', 17:55:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:24 INFO - 'SHELL': '/bin/bash', 17:55:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.co6xYSNczu/Listeners', 17:55:24 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:55:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:24 INFO - 'USER': 'cltbld', 17:55:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:24 INFO - 'XPC_FLAGS': '0x0', 17:55:24 INFO - 'XPC_SERVICE_NAME': '0', 17:55:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:24 INFO - Downloading/unpacking flake8 17:55:24 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 17:55:24 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 17:55:24 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 17:55:24 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 17:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:55:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:55:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:55:28 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 17:55:28 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 17:55:28 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 17:55:28 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 17:55:28 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 17:55:28 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 17:55:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:55:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:55:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:55:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:55:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:55:28 INFO - no previously-included directories found matching 'docs/_build' 17:55:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:55:28 INFO - Running setup.py install for pep8 17:55:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:55:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:55:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:55:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:55:28 INFO - no previously-included directories found matching 'docs/_build' 17:55:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:55:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:55:29 INFO - Cleaning up... 17:55:29 INFO - Return code: 0 17:55:29 INFO - Running post-action listener: _resource_record_post_action 17:55:29 INFO - Running post-action listener: _start_resource_monitoring 17:55:29 INFO - Starting resource monitoring. 17:55:29 INFO - ##### 17:55:29 INFO - ##### Running install step. 17:55:29 INFO - ##### 17:55:29 INFO - Running pre-action listener: _resource_record_pre_action 17:55:29 INFO - Running main action method: install 17:55:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:55:29 INFO - Reading from file tmpfile_stdout 17:55:29 INFO - Detecting whether we're running mozinstall >=1.0... 17:55:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:55:29 INFO - Reading from file tmpfile_stdout 17:55:29 INFO - Output received: 17:55:29 INFO - Usage: mozinstall [options] installer 17:55:29 INFO - Options: 17:55:29 INFO - -h, --help show this help message and exit 17:55:29 INFO - -d DEST, --destination=DEST 17:55:29 INFO - Directory to install application into. [default: 17:55:29 INFO - "/builds/slave/test"] 17:55:29 INFO - --app=APP Application being installed. [default: firefox] 17:55:29 INFO - mkdir: /builds/slave/test/build/application 17:55:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 17:56:00 INFO - Reading from file tmpfile_stdout 17:56:00 INFO - Output received: 17:56:00 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 17:56:00 INFO - Running post-action listener: _resource_record_post_action 17:56:00 INFO - ##### 17:56:00 INFO - ##### Running run-tests step. 17:56:00 INFO - ##### 17:56:00 INFO - Running pre-action listener: _resource_record_pre_action 17:56:00 INFO - Running main action method: run_tests 17:56:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:56:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:56:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:56:00 INFO - 2016-06-03 17:56:00.982 screenresolution[1649:7869] starting screenresolution argv=screenresolution get 17:56:00 INFO - 2016-06-03 17:56:00.984 screenresolution[1649:7869] Display 0: 1600x1200x32@60 17:56:00 INFO - 2016-06-03 17:56:00.990 screenresolution[1650:7871] starting screenresolution argv=screenresolution list 17:56:00 INFO - Available Modes on Display 0 17:56:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:56:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:56:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:56:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:56:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:56:01 INFO - Intel Iris: 17:56:01 INFO - Chipset Model: Intel Iris 17:56:01 INFO - Type: GPU 17:56:01 INFO - Bus: Built-In 17:56:01 INFO - VRAM (Dynamic, Max): 1536 MB 17:56:01 INFO - Vendor: Intel (0x8086) 17:56:01 INFO - Device ID: 0x0a2e 17:56:01 INFO - Revision ID: 0x0009 17:56:01 INFO - Displays: 17:56:01 INFO - Display: 17:56:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:56:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:56:01 INFO - Display Serial Number: 1600x1200 60 17:56:01 INFO - Main Display: Yes 17:56:01 INFO - Mirror: Off 17:56:01 INFO - Online: Yes 17:56:01 INFO - Rotation: Supported 17:56:01 INFO - Return code: 0 17:56:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:56:01 INFO - Python 2.7.3 17:56:01 INFO - Return code: 0 17:56:01 INFO - grabbing minidump binary from tooltool 17:56:01 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')]} 17:56:01 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 0x106425e00>, '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 0x10628edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106420b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:56:01 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 17:56:01 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 17:56:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:56:01 INFO - Return code: 0 17:56:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:56:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:56:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:56:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:56:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:56:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:56:02 INFO - Return code: 0 17:56:02 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/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0203', '--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 17:56:02 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/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0203 --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 17:56:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FOjKVuxJrj/Render', 17:56:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:02 INFO - 'HOME': '/Users/cltbld', 17:56:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:02 INFO - 'LOGNAME': 'cltbld', 17:56:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:56:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:02 INFO - 'MOZ_NO_REMOTE': '1', 17:56:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:56:02 INFO - 'NO_EM_RESTART': '1', 17:56:02 INFO - 'PAGER': '/bin/cat', 17:56:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:02 INFO - 'PWD': '/builds/slave/test', 17:56:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:56:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:02 INFO - 'SHELL': '/bin/bash', 17:56:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.co6xYSNczu/Listeners', 17:56:02 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 17:56:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:02 INFO - 'USER': 'cltbld', 17:56:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:02 INFO - 'XPC_FLAGS': '0x0', 17:56:02 INFO - 'XPC_SERVICE_NAME': '0', 17:56:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:56:02 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/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0203', '--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 17:56:02 INFO - mozversion application_buildid: 20160603160527 17:56:02 INFO - mozversion application_changeset: ab782095ef4ab44dae4cc5f919858c5684837378 17:56:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:56:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:56:02 INFO - mozversion application_name: Firefox 17:56:02 INFO - mozversion application_remotingname: firefox-dev 17:56:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:56:02 INFO - mozversion application_vendor: Mozilla 17:56:02 INFO - mozversion application_version: 48.0a2 17:56:02 INFO - mozversion platform_buildid: 20160603160527 17:56:02 INFO - mozversion platform_changeset: ab782095ef4ab44dae4cc5f919858c5684837378 17:56:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:56:02 INFO - mozversion platform_version: 48.0a2 17:56:02 INFO - using testdate: 1465001762 17:56:02 INFO - actual date: 1465001762 17:56:02 INFO - starting webserver on 'localhost:49279' 17:56:02 INFO - SUITE-START | Running 2 tests 17:56:02 INFO - TEST-START | dromaeo_css 17:56:02 INFO - operating with platform_type : mac_ 17:56:02 INFO - Initialising browser for dromaeo_css test... 17:56:02 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpIGZfw6/profile http://localhost:49279/getInfo.html) 17:56:04 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 17:56:04 INFO - PROCESS | 1668 | colorDepth:24 17:56:04 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 17:56:04 INFO - PROCESS | 1668 | __metrics 17:56:05 INFO - PROCESS | 1668 | 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" 17:56:05 ERROR - PROCESS | 1668 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:56:05 INFO - TEST-INFO | 1668: exit 0 17:56:05 INFO - Browser initialized. 17:56:05 INFO - Running cycle 1/1 for dromaeo_css test... 17:56:05 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpIGZfw6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:17 INFO - PROCESS | 1671 | RSS: Main: 211025920 17:56:17 INFO - PROCESS | 1671 | 17:57:09 INFO - PROCESS | 1671 | 1465001829100 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] 17:59:19 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 17:59:21 INFO - PROCESS | 1671 | RSS: Main: 398860288 17:59:21 INFO - PROCESS | 1671 | 18:02:24 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 18:02:25 INFO - PROCESS | 1671 | RSS: Main: 355221504 18:02:25 INFO - PROCESS | 1671 | 18:05:27 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 18:05:27 INFO - PROCESS | 1671 | RSS: Main: 357605376 18:05:27 INFO - PROCESS | 1671 | 18:08:29 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 18:08:30 INFO - PROCESS | 1671 | RSS: Main: 355840000 18:08:30 INFO - PROCESS | 1671 | 18:11:33 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 18:11:34 INFO - PROCESS | 1671 | RSS: Main: 323088384 18:11:34 INFO - PROCESS | 1671 | 18:14:36 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 18:14:37 INFO - PROCESS | 1671 | RSS: Main: 368156672 18:14:37 INFO - PROCESS | 1671 | 18:14:37 INFO - PROCESS | 1671 | __start_tp_report 18:14:37 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 18:14:37 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 18:14:37 INFO - PROCESS | 1671 | |i|pagename|runs| 18:14:37 INFO - PROCESS | 1671 | |0;dojo.html;2842.2183899427655;3408.6591340865907;3411.897643070709;3429.7599168058246;3475.183331916999;5598;5608.4391560844;5618;5623.859403514909;5648.350439699436;5611.663300201991;5622.41425495818;5623.0721930881355;5639.915401268984;5655.802046928358;5027.296178535008;5065.7467126643705;5135.435102138762;5163.173892177234;5227.137522308814;5164.793408263665;5166.974165129169;5169.353830771153;5172.818951336704;5184.662996905208;5132.384113906336;5167.095758242312;5196.168613021917;5213.113770658978;5224.294720212761;4314.848980285675;4553.977230113861;5169.1987741899875;5205.583553315726;5242.2136679498;5016.598672106223;5066.746662666888;5090.796368145269;5124.205748109049;5160.354955630546;5470.343558772933;5474.479924407175;5500.28496295479;5505.311836020497;5515.531179849718;6145.600535965148;6172.22847144107;6180.103884936659;6184.536159788034;6186.350433204494;6043.60716553427;6106.005662907935;6119.837693858745;6203.906941395882;6232.3144454110015;5698.2592263005545;5719.771209151588;5721.885562288731;5735.741891614887;5769.365369809318;6153.876922461525;6197.101420294032;6213.596116252429;6218.347073557302;6301.7164227609865;5345.839624811262;5698.401667824819;5882.911756323659;5987.2815262168815;6089.847753806191;6173.722182501709;6190.442860142609;6193.318734939153;6200.0699895016105;6205.317415084337;6122.448979591858;6131.662758548234;6140.140380346755;6140.263168419729;6149.046897730859;6005.189299444606;6018.037114061729;6087.9650459422;6152.415520525543;6160.353162917919;4800.255960326085;4820.1805693031565;4823.252395878644;4824.6863953842885;4832.51674832521;4306.0957198987935;4327.242732521859;4332.935005974913;4373.497047839539;4400.603945644843;5645.661260324311;5663.037283661705;5672.7730890763905;5678.914816277759;5696.259486266758;6065.999110146777;6127.18952814863;6208.565400421927;6211.844703882439;6214.8135555933395;5582.860428489239;5590.077637189899;5675.517581005578;5679.091345384719;5707.543396528351;5292.2326262691695;5298.523132918056;5308.840734777963;5316.308879845596;5320.654157479751;6147.108669243024;6163.660998645118;6191.4118158774845;6228.750849966042;6244.687765611792;6158.168647232566;6202.751889924352;6207.503399727921;6211.130441738251;6218.22272215973;6231.781887633911;6240.375962403723;6248.750049998131;6252.280987686474;6255.56211065221;5847.298324201123;6015.699215039143;6038.667873266837;6117.663528505975;6132.233470816148;6051.33435322123;6060.090986352083;6084.513238940963;6092.329843717276;6093.75624974996;4963.751812409438;5870.442307980735;6051.4553690168095;6052.425019623129;6065.150878877049;5969.8806023878415;5978.790742323998;5984.31180414258;5990.940090599038;6026.126211699367;5831.1836342912875;5839.474447299764;5853.443922827325;5868.149118377726;5875.706214689163;5763.971180144073;5931.6441013539325;6004.729787159501;6005.009173486325;6065.2418447694035;5718.571107166896;5794.101914203306;5810.535157187331;5845.795397161079;5848 18:14:37 INFO - PROCESS | 1671 | |1;ext.html;517.5962749055735;518.9065968125739;532.3292651259413;545.945405459454;596.7016491754123;29004.709952900517;30576;31269.68730312696;31296.68703312969;36851;41234.381484277685;41721.58278417215;41852;42045.738627841136;42053.94865128373;9382.71851844444;9580.52097395131;9587;9592.568334424932;9595.992420795821;8473.067962524117;8678.783030424227;9356.4386136832;11436.71408214793;11765.52937882488;11424.942875285611;11514.30914145154;11515.654530364103;11529.250598711056;11554.595589154382;8470;11350.659480215607;11410.486528106256;11418.657440276764;11433.885661143366;8436.114208008194;8547.487150770912;8562.400631955765;11370.772584548346;11680.007199388063;37847.621523784685;38237.23525529474;38237.85286441411;38295;38476.42285365722;3171;3260.152360386293;3279.344131173751;3540.8760693375607;3861.2663593917064;27149.321266968287;27561.44877102447;27629.447411051668;27644.30889227765;28832.855835720897;2721.972780272192;2740.739629735172;2791.8743656535503;2800.425912687894;2801.887924483018;496874.5156274232;498768;499487;500198;501096;61612.38387616067;61911.6904415484;62054.37945620577;62098.379016210165;62203;65802;65896.67051664711;66002;66136.00795988063;66277.33722662808;17013.298670133136;17518.91240543789;17534;17558.38545650896;17615.38346157904;12372.938135309445;12617.306048167438;13702.38339274735;13712.108712933827;13769.449222031208;16265.918670406572;16411.507654770376;16449.753253701205;16486.917565412095;16638.91680541614;5894.145348924468;5960.284765828042;6284.402981716729;6432.260290066609;6476.902846457307;967.1392460709974;987.2792861211356;1034.4414016431042;1075.086176749772;1113.6881673131536;24634.319479298876;26403;27856.303592409946;29089.41821163565;29908.102756917327;1006.3861044762835;1130.0338210829786;1181.710480932177;1235.950561977511;1301.3493253373313;15005.849941500444;15092.1699306537;15135.545933622008;15452.613684657974;15496.690066198613;610699;613045;615075;615286;616604;45135;58661.70669146712;60180.699096504235;60224.49438764066;60256;1316.2826259688493;1322.7751282281843;1372.3138430784609;1514.0385854982167;1563.975595984609;28693.42613147767;28915.85542072276;29117.272068198465;29811.956581519542;29867.551986719784;48083;51798.705032372985;51943.74028129986;52242.738786305825;52381.99999999847;453706;455084;455245;455592;458365;38966.80516597399;39832.60167398289;40352.3947140799;40391;40395.79802100971;46698;46840;47700.522994769606;48052.5194748048;49235.50764492309;35471.64528354684;35564.11089722778;35717.82141089278;35995.46006809847;36436.72471463592;31564.842175788974;32945.67054329426;35084.64915350814;35784.284314313045;35915.64084359227;35080.47379289364;35313.293734125684;35664.643353566134;35860.282794343446;36336.27327453383;24517.38706532351;32337.191570210933;33017.33965320728;33227.667723322455;33317.83341083279;24389.14637987662;24534.89592968285;24572.262832115066;24661.555703220103;24979.500409992062 18:14:37 INFO - PROCESS | 1671 | |2;jquery.html;376.3695809519055;403.84250142444444;404.0968435546555;406.2524954084485;417.9728317659352;14146;15928.68142637148;19675.901620491877;20336.08487618059;20336.983150842472;20577.588448231065;20745.792542074574;21202.151913923462;21236.89381553094;21843.017064232106;5833;6075.756969721206;6094.60385074971;6098.481629061535;6105.664188469633;5847.590668653196;5920.763169473237;6013.729382177812;6028.21633187685;6056.273247210341;5974.402559744034;6009.5192384609345;6010.75956961721;6015.248093988252;6020.096985452195;5770.33641131269;5869.735861886204;5931.051031834907;5982.611130276518;6000.279966404016;5178.818741344035;5229.712365819878;5232.6860388376435;5241.109011468022;5258.842234732964;25119.37201569957;25966;26429;26552.336191595172;26564.867175664192;2244.2145249162663;2337;2517.5342561626157;2521.231024537515;2773.334399744067;13518.32408379587;14094.788578171234;14850.1832399218;14862;14922.328495217742;1690.4506035538377;1699.7138848249085;1739.1999680147148;1776.4581802550217;1816.228103056209;83237;108056.20376346725;109029;115242.8475715249;118759.4062029693;11352.262102963281;11403.258788178742;11449.542018319175;11462.083033357312;11594.826077608843;14211.78682319766;14253.64365890861;14263.857361426253;14265;14272.500462483764;7103.715851365888;8843.823123537493;8979.416337938013;8986.505742184243;9068.909310906807;8033;8622.913770862211;9136.771580710536;9151.496667683341;9256.07439256069;5550.417206193372;6859.622720750307;6867.244603093655;6876.656167191721;6886.8622627547165;1787.2404228203222;1884.689026310671;1907.1227235471838;1909.8376637985648;1912.4740696308627;818.9017317921769;964.7346979580531;982.4105536677936;1021.7854250607455;1040.8334666453482;19499.902500487406;20635.58728825415;20654.58690826175;20900.47748806292;20914;988.3773222869546;1013.8479228115841;1014.2190513304714;1021.4637315409469;1032.6334151376304;11059.778804423866;11386.430678466044;11408.372539510241;11433.542658293742;11652.067834573214;568625.156874213;607103;610292;625067;626519;112909.4354528222;116136;118638.40680796541;119054;119555;1006.8036732837027;1017.7404761785697;1019.8164330420448;1023.744063984004;1060.2578195263347;18869.6226075475;18887.15007824679;18973.810261897204;19032.71450928265;19033.895431745277;51829.22256166236;51840.22239666484;52203;53039.469605305;55198.44801551933;74419.85565500641;75433;75519.62240188764;75796;76416;7793.883091753742;8092.393070519853;8222.753317400488;8241.752747417588;8457.02744184402;11116.943890330405;12377.938110309391;12724.1729287596;12896.613101606967;13192;11021.228514004264;11204.215704900906;11260.436978151223;11333.320000799979;11429.428528573704;9202.401843880127;10846.457677115955;11021.228514003942;11124;11495.195336326711;5993.880122397441;5997.580169388276;6820.908654615436;11258.605948792081;11302.039326657326;6897.3447522485285;7565.6973721050545;7727.343175829893;8280.171982801672;8485.448445851;9833.60665573369;10242.385456872611;10499.950004999439;11158.55365785392;11317.377544235145 18:14:37 INFO - PROCESS | 1671 | |3;mootools.html;1420.0911416693311;1553.3631211203406;1581.7073841339354;1800.4778614201882;1953.8925359105244;7096.538724982879;7792.4934879232815;8652.178043085913;8659.134086591337;8727.127287271269;8250.133735957728;8491.872621910676;8500.489970601768;8533;8546.188112129354;2402.3153401280597;2441.414060625455;2446.755324467557;2448.755124487546;2454.521368333176;2385.0817435287368;2426.1387207541334;2426.708794944609;2433.9756602434013;2450.6079027355627;2406.2901444073955;2433.3551608823677;2438.878056097197;2443.621238707994;2454.9263522094366;2392.7009123859516;2423.8182136339756;2424.9393765155924;2428.550718117154;2435.4398488347692;2384.8092152627923;2415.384077060356;2426.1993542131054;2428.235105941623;2439.4511234972165;8440.83118337636;8486.490810551324;8513.872291915626;8525.104863989254;8528.6162122704;5280.867978300535;5456.154296084113;5470.890582188374;5480.972595137038;5481.835544933659;3330.8001519908885;3339.9833000835083;3364.394409006378;3407.6762707542994;3422.5208470814105;1041.1566631028816;1049.5277125293571;1065.7655315830505;1074.135321066541;1075.1130317488103;11583.305001699924;11760.000399966013;11784.941075294655;11787.233829801036;11823.054155667613;4674.439067311876;4787.305840653085;4869.853904382874;4875.146849301358;4898.755062246873;10002.549885255181;10100.747481313027;10115.342502737298;10148.543315550818;10150.340227885164;5418.431064738224;5438.075527160392;5469.863253418696;5470.617056806065;5481.397046324901;4381.3208952612395;4519.954800452019;4740.360051393087;4908.165611845995;4931.334269873521;3947.1513624570857;3996.460477835455;4085.305498065336;4089.325261331847;4100.302948498763;1169.9473523691454;1277.9105462617713;1342.2617560341773;1357.9185248885099;1357.9728405432033;675.1830285354678;823.9382046346428;830.5971603772166;878.8813510176044;954.8138113068024;5608.9439105609235;5785.30576330843;5798.855028624318;5922.644641321448;5969.074793407029;938.8450905600499;943.556528431636;961.8653388525612;981.0728861226215;982.9017098290257;3819.0452386903276;3952.9011774705864;3953.5058117735284;4038.2932986727205;4044.3933409988736;9808.803823923481;10504.737381565523;10515.263931524873;10593.629222977313;10621.5220315086;10134.037266459674;10368.533415996299;10378.636747713794;10495.00297471739;10513.632022879163;7996.9200307997335;8213.712520061888;8268.007839059232;8274.213949674771;8324.29243514296;5548.361938377138;5651.350094739158;5744.167095771173;5804.3905389935135;5879.529637628894;9037.051109633394;9204.217641500547;9224.907750922404;9320.580573874056;9342.579583918605;9232;9301.488418137067;9430.669926552539;9436.811263774549;9468.431894086378;6977.686004129928;7753.340966017951;8136.918630813616;8147.307478864363;8149.022117345957;8008.399370047387;8095.83808323842;8133.471324363897;8147.633356498854;8149.103598604267;6433.646149461824;7436.628168591657;7468.626568671653;7581.279778421042;7597.962010189914;7156.713731450684;7272.345488906024;7316.451266155166;7412.1846596875375;7505.399568034435;6968.686409111703;7024.262452442625;7033.437325014089;7036.472264580279;7041.894371584533;4735.195016847213;4783;4947.554720075211;4989.151844186569;5009.649324547247;4979.5269449403695;5003.1744762115295;5026.421961474331;5053.823116190915;5091.236314552847 18:14:37 INFO - PROCESS | 1671 | |4;prototype.html;317.8744395963594;320.85401142480174;327.6166884744848;328.66312030169064;332.6507167474152;5939.910901336483;6563.7046332915015;6575.210974683045;6575.276719560845;6577.473802095827;6543.1821022372205;6564.310747371529;6575.967120164404;6596.010598410241;6599.340065993399;4663.997240593272;4738.455077666061;4741.288806678991;4757;4830.082284365977;4776.737279449629;4823.782929768169;4829.372181616385;4846.0792449434675;4867.9269810952865;3835.5589107252604;4784.091022705692;4800.4719480857075;4823.710577365369;4824.517548245165;3443.2596991646915;4298.935515967263;4578.793954272066;4734.029523947617;4810.508742289901;4026.959730402688;4055.087605288816;4077.3068578341754;4095.385692146172;4103.384492326145;6139.6009259398;6154.323024467305;6184.19605451293;6199.814005579795;6227.906581401283;5676.858078548028;5685.943140568583;5702.77188912443;5705.74324155414;5712.742926568314;6896.620685862275;6919.965400173017;6924.792256232321;6932.688029038705;6940.548864323803;3837.9253808933545;4334.393184954078;4540.432445944257;4550.840720574764;4643.674942754009;7213.4589905757275;7331.010313607648;7332.523385979895;7333.669984850641;7346.669399877019;4592.173408786451;4596.701214421052;4605;4605.125026245003;4620.5379462053525;3843.423486476995;3879.3017256893468;4642.141203877293;4645.558671926162;4653.278741795028;5529.944700553024;5530.917036244379;5531.585131115183;5544.085225937756;5552.139418390156;6642.86714265712;6956.686949087303;6970.616616086164;6973.825654358681;6985.476089293222;1598.224860942442;1605.077080678591;1617.6279455725014;1619.5708137343613;1628.6742651469517;1013.1034034879185;1015.6343716262139;1037.1339931157568;1037.7976294622476;1038.055369613648;6335.271443783931;6500.414962653289;6502.284748677642;6506.414422701885;6528;7117.679704413314;7216.314450127229;7224.711011559479;7235.746748863765;7251.891221631679;6505.544611877218;6546.443552298108;6557.442617377576;6564.540482166202;6572.704228309737;3210.550522926792;3747.3816820224356;3846.1538461538416;3846.8845934622004;3849.2301539692176;7363.300486453778;7600.315971562586;7632.923670763333;7649.885251721229;7650.770476885702;6135.785247516315;7462.738804141829;7522.435817313614;7551.358134558624;7572.621368931532;7606.087269527692;7611.771646850492;7614.923850761532;7621;7623.085229772463;7277.526960747535;7286.599237042014;7300.014498042697;7312.268773122645;7332.743353982585;6896.27589103157;7150.67821948024;7166.462515311477;7175.964120179575;7177.820554485971;7574.734884279023;7616.504927179715;7617.885731714139;7637.770866874002;7657.195994420728;4603.240465323184;4603.3785438965315;4609.216433206296;4615.953840461552;4616.746078965689;5890.617109887844;6768.2216545097945;7119.466040046914;7242.565446073042;7262.164851042197;6702.190408589556;6996.825079373057;7009.1939426966555;7010.053642758162;7035.33164349386;6988.6505674715045;7034.296570343129;7037.366637002694;7043.823904402431;7051.717931282691;6861.828454288683;6875.3812156906115;6875.415589674733;6876.484263680344;6877.759278425231;6994.195667498303;7008.579485230903;7017;7022;7028.683709233199;6679.799606011828;6855.417289530246;6862.656867156522;6910.274421185703;6919.965400172967 18:14:37 INFO - PROCESS | 1671 | |5;yui.html;718.2853061204102;757.1973707869658;764.571839769729;768.6694721269859;812.7317985064927;15020.624484387896;15164.090154590718;15177.241137943114;15193.316300766464;15202.923985380072;12717.300548469853;12852;12860.549880754175;12862.163959342659;12867.356632168401;741.0218511564736;759.7568777991045;913.7395842184995;928.823523530527;944.5560586524357;950.9096635819586;954.2366107114316;955.350361754007;955.5699935029264;955.6082006377387;998.4009594243432;999.5152351109742;1002.1431675917095;1003.4380746781826;1004.8844382895987;760.2397602397602;966.5167416291854;987.2250283527396;992.8064027514638;997.6258902911409;744.0884915977938;744.5123444144094;745.6607243704102;746.354403441025;749.7338444852054;14715.926420367936;14796.89023323255;14805.259737013106;14818.481353152589;14873;12284.385780710929;12308.138430309882;12537;12628.747425051448;12644.241345519205;10122.240831937634;10150.644727434577;10336.121429678486;10424.583016679324;10454.163666906628;2990.2823322402683;3056.312329725816;3510.7542472026967;3549.6095429502734;3649.562052553684;73893.26106738918;75152.49695006124;75781;76656.85014724784;76732;9631.903680963242;9703.757406064764;9716.31985761004;9716.902830971741;9820.017998200123;21724.239651612435;21760.34718958434;21775.78224217769;21805.563888722136;21828.672569911465;6455.7740479083;7450.0687414073245;7560.735374261984;7649.502782319131;7918.326942209861;3428.434308339146;4045.8583949561626;4109.630133288018;4158.106007208465;4284.828606855754;3546.929061418757;3582.695470885004;3589.892303230907;3591.2278860045217;3593.748437609342;623.03118650498;649.4771708774482;658.9077529145924;659.7262136213418;667.3560014585947;521.3431076843129;571.5541877335685;603.3513972479602;604.9788257410969;619.4827319188438;7927.484713493604;7982.640781164861;8226.588670566447;8228.99818287117;8230;589.1810383566846;591.0554276430496;593.5696619950587;597.8893904627571;623.2489849731063;3784;3797.7531460454984;3829.100161462054;3841.961580384216;3879.631435013669;82314.58842705748;82362.58818705867;82641.17358826454;83463;83493.58253208695;70975.2902470979;71430.64284678543;71772;71956;73850;62849.057264141076;63054.68472657699;63200.05199922005;65157.674211629586;65262;7515.361194298327;7660.2722741339485;7703.152653208031;7723.9227607723205;7886.526808391515;45248;45328.77335613301;47694.761526192146;48687.40094889133;49956.75108122326;55631.721841390536;66390.66804665946;66634.66682666556;67372;67877;9909.058639429242;9919.872194902831;9928.702138935843;10084.991500849856;10090.293679442662;10501.789964200825;10572.947135264274;10696.03735663763;10778.461076945965;10995.065419439437;10106.49467526606;10228.897711022795;10354.326968747007;10463.267571269938;10553.683389498327;9971.30200885931;10038.29731918788;10321.066560143747;10362.689119326433;10497.10774584169;9829.705108846745;10160.288779785344;10161.085502304828;10200.132988696045;10338.276320657782;8667.566621668766;8782.473051616924;8815.867761983704;8933.687320943736;8937.150970657776;8705.47767133974;8801.955990220007;8803.515806630698;8830.646774128963;8915.643374264957 18:14:37 INFO - PROCESS | 1671 | __end_tp_report 18:14:37 INFO - PROCESS | 1671 | __start_cc_report 18:14:37 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1910 18:14:37 INFO - PROCESS | 1671 | __end_cc_report 18:14:37 INFO - PROCESS | 1671 | __startTimestamp1465002877039__endTimestamp 18:14:37 INFO - PROCESS | 1671 | 18:14:37 INFO - PROCESS | 1671 | ------- Summary: start ------- 18:14:37 INFO - PROCESS | 1671 | Number of tests: 6 18:14:37 INFO - PROCESS | 1671 | 18:14:37 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5639.75 Median:5831.18 stddev:642.02 (11.0%) stddev-sans-first:605.32 18:14:37 INFO - PROCESS | 1671 | Values: 2842.2 3408.7 3411.9 3429.8 3475.2 5598.0 5608.4 5618.0 5623.9 5648.4 5611.7 5622.4 5623.1 5639.9 5655.8 5027.3 5065.7 5135.4 5163.2 5227.1 5164.8 5167.0 5169.4 5172.8 5184.7 5132.4 5167.1 5196.2 5213.1 5224.3 4314.8 4554.0 5169.2 5205.6 5242.2 5016.6 5066.7 5090.8 5124.2 5160.4 5470.3 5474.5 5500.3 5505.3 5515.5 6145.6 6172.2 6180.1 6184.5 6186.4 6043.6 6106.0 6119.8 6203.9 6232.3 5698.3 5719.8 5721.9 5735.7 5769.4 6153.9 6197.1 6213.6 6218.3 6301.7 5345.8 5698.4 5882.9 5987.3 6089.8 6173.7 6190.4 6193.3 6200.1 6205.3 6122.4 6131.7 6140.1 6140.3 6149.0 6005.2 6018.0 6088.0 6152.4 6160.4 4800.3 4820.2 4823.3 4824.7 4832.5 4306.1 4327.2 4332.9 4373.5 4400.6 5645.7 5663.0 5672.8 5678.9 5696.3 6066.0 6127.2 6208.6 6211.8 6214.8 5582.9 5590.1 5675.5 5679.1 5707.5 5292.2 5298.5 5308.8 5316.3 5320.7 6147.1 6163.7 6191.4 6228.8 6244.7 6158.2 6202.8 6207.5 6211.1 6218.2 6231.8 6240.4 6248.8 6252.3 6255.6 5847.3 6015.7 6038.7 6117.7 6132.2 6051.3 6060.1 6084.5 6092.3 6093.8 4963.8 5870.4 6051.5 6052.4 6065.2 5969.9 5978.8 5984.3 5990.9 6026.1 5831.2 5839.5 5853.4 5868.1 5875.7 5764.0 5931.6 6004.7 6005.0 6065.2 5718.6 5794.1 5810.5 5845.8 5848.0 18:14:37 INFO - PROCESS | 1671 | 18:14:37 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:66151.48 Median:35614.38 stddev:140630.06 (394.9%) stddev-sans-first:140938.22 18:14:37 INFO - PROCESS | 1671 | Values: 517.6 518.9 532.3 545.9 596.7 29004.7 30576.0 31269.7 31296.7 36851.0 41234.4 41721.6 41852.0 42045.7 42053.9 9382.7 9580.5 9587.0 9592.6 9596.0 8473.1 8678.8 9356.4 11436.7 11765.5 11424.9 11514.3 11515.7 11529.3 11554.6 8470.0 11350.7 11410.5 11418.7 11433.9 8436.1 8547.5 8562.4 11370.8 11680.0 37847.6 38237.2 38237.9 38295.0 38476.4 3171.0 3260.2 3279.3 3540.9 3861.3 27149.3 27561.4 27629.4 27644.3 28832.9 2722.0 2740.7 2791.9 2800.4 2801.9 496874.5 498768.0 499487.0 500198.0 501096.0 61612.4 61911.7 62054.4 62098.4 62203.0 65802.0 65896.7 66002.0 66136.0 66277.3 17013.3 17518.9 17534.0 17558.4 17615.4 12372.9 12617.3 13702.4 13712.1 13769.4 16265.9 16411.5 16449.8 16486.9 16638.9 5894.1 5960.3 6284.4 6432.3 6476.9 967.1 987.3 1034.4 1075.1 1113.7 24634.3 26403.0 27856.3 29089.4 29908.1 1006.4 1130.0 1181.7 1236.0 1301.3 15005.8 15092.2 15135.5 15452.6 15496.7 610699.0 613045.0 615075.0 615286.0 616604.0 45135.0 58661.7 60180.7 60224.5 60256.0 1316.3 1322.8 1372.3 1514.0 1564.0 28693.4 28915.9 29117.3 29812.0 29867.6 48083.0 51798.7 51943.7 52242.7 52382.0 453706.0 455084.0 455245.0 455592.0 458365.0 38966.8 39832.6 40352.4 40391.0 40395.8 46698.0 46840.0 47700.5 48052.5 49235.5 35471.6 35564.1 35717.8 35995.5 36436.7 31564.8 32945.7 35084.6 35784.3 35915.6 35080.5 35313.3 35664.6 35860.3 36336.3 24517.4 32337.2 33017.3 33227.7 33317.8 24389.1 24534.9 24572.3 24661.6 24979.5 18:14:37 INFO - PROCESS | 1671 | 18:14:37 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:34676.15 Median:2290.61 stddev:100844.45 (4402.5%) stddev-sans-first:101094.46 18:14:37 INFO - PROCESS | 1671 | Values: 376.4 403.8 404.1 406.3 418.0 14146.0 15928.7 19675.9 20336.1 20337.0 20577.6 20745.8 21202.2 21236.9 21843.0 5833.0 6075.8 6094.6 6098.5 6105.7 5847.6 5920.8 6013.7 6028.2 6056.3 5974.4 6009.5 6010.8 6015.2 6020.1 5770.3 5869.7 5931.1 5982.6 6000.3 5178.8 5229.7 5232.7 5241.1 5258.8 25119.4 25966.0 26429.0 26552.3 26564.9 2244.2 2337.0 2517.5 2521.2 2773.3 13518.3 14094.8 14850.2 14862.0 14922.3 1690.5 1699.7 1739.2 1776.5 1816.2 83237.0 108056.2 109029.0 115242.8 118759.4 11352.3 11403.3 11449.5 11462.1 11594.8 14211.8 14253.6 14263.9 14265.0 14272.5 7103.7 8843.8 8979.4 8986.5 9068.9 8033.0 8622.9 9136.8 9151.5 9256.1 5550.4 6859.6 6867.2 6876.7 6886.9 1787.2 1884.7 1907.1 1909.8 1912.5 818.9 964.7 982.4 1021.8 1040.8 19499.9 20635.6 20654.6 20900.5 20914.0 988.4 1013.8 1014.2 1021.5 1032.6 11059.8 11386.4 11408.4 11433.5 11652.1 568625.2 607103.0 610292.0 625067.0 626519.0 112909.4 116136.0 118638.4 119054.0 119555.0 1006.8 1017.7 1019.8 1023.7 1060.3 18869.6 18887.2 18973.8 19032.7 19033.9 51829.2 51840.2 52203.0 53039.5 55198.4 74419.9 75433.0 75519.6 75796.0 76416.0 7793.9 8092.4 8222.8 8241.8 8457.0 11116.9 12377.9 12724.2 12896.6 13192.0 11021.2 11204.2 11260.4 11333.3 11429.4 9202.4 10846.5 11021.2 11124.0 11495.2 5993.9 5997.6 6820.9 11258.6 11302.0 6897.3 7565.7 7727.3 8280.2 8485.4 9833.6 10242.4 10500.0 11158.6 11317.4 18:14:37 INFO - PROCESS | 1671 | 18:14:37 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5650.22 Median:5018.04 stddev:3097.09 (61.7%) stddev-sans-first:3089.46 18:14:37 INFO - PROCESS | 1671 | Values: 1420.1 1553.4 1581.7 1800.5 1953.9 7096.5 7792.5 8652.2 8659.1 8727.1 8250.1 8491.9 8500.5 8533.0 8546.2 2402.3 2441.4 2446.8 2448.8 2454.5 2385.1 2426.1 2426.7 2434.0 2450.6 2406.3 2433.4 2438.9 2443.6 2454.9 2392.7 2423.8 2424.9 2428.6 2435.4 2384.8 2415.4 2426.2 2428.2 2439.5 8440.8 8486.5 8513.9 8525.1 8528.6 5280.9 5456.2 5470.9 5481.0 5481.8 3330.8 3340.0 3364.4 3407.7 3422.5 1041.2 1049.5 1065.8 1074.1 1075.1 11583.3 11760.0 11784.9 11787.2 11823.1 4674.4 4787.3 4869.9 4875.1 4898.8 10002.5 10100.7 10115.3 10148.5 10150.3 5418.4 5438.1 5469.9 5470.6 5481.4 4381.3 4520.0 4740.4 4908.2 4931.3 3947.2 3996.5 4085.3 4089.3 4100.3 1169.9 1277.9 1342.3 1357.9 1358.0 675.2 823.9 830.6 878.9 954.8 5608.9 5785.3 5798.9 5922.6 5969.1 938.8 943.6 961.9 981.1 982.9 3819.0 3952.9 3953.5 4038.3 4044.4 9808.8 10504.7 10515.3 10593.6 10621.5 10134.0 10368.5 10378.6 10495.0 10513.6 7996.9 8213.7 8268.0 8274.2 8324.3 5548.4 5651.4 5744.2 5804.4 5879.5 9037.1 9204.2 9224.9 9320.6 9342.6 9232.0 9301.5 9430.7 9436.8 9468.4 6977.7 7753.3 8136.9 8147.3 8149.0 8008.4 8095.8 8133.5 8147.6 8149.1 6433.6 7436.6 7468.6 7581.3 7598.0 7156.7 7272.3 7316.5 7412.2 7505.4 6968.7 7024.3 7033.4 7036.5 7041.9 4735.2 4783.0 4947.6 4989.2 5009.6 4979.5 5003.2 5026.4 5053.8 5091.2 18:14:37 INFO - PROCESS | 1671 | 18:14:37 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:5696.99 Median:6551.94 stddev:1859.23 (28.4%) stddev-sans-first:1820.08 18:14:37 INFO - PROCESS | 1671 | Values: 317.9 320.9 327.6 328.7 332.7 5939.9 6563.7 6575.2 6575.3 6577.5 6543.2 6564.3 6576.0 6596.0 6599.3 4664.0 4738.5 4741.3 4757.0 4830.1 4776.7 4823.8 4829.4 4846.1 4867.9 3835.6 4784.1 4800.5 4823.7 4824.5 3443.3 4298.9 4578.8 4734.0 4810.5 4027.0 4055.1 4077.3 4095.4 4103.4 6139.6 6154.3 6184.2 6199.8 6227.9 5676.9 5685.9 5702.8 5705.7 5712.7 6896.6 6920.0 6924.8 6932.7 6940.5 3837.9 4334.4 4540.4 4550.8 4643.7 7213.5 7331.0 7332.5 7333.7 7346.7 4592.2 4596.7 4605.0 4605.1 4620.5 3843.4 3879.3 4642.1 4645.6 4653.3 5529.9 5530.9 5531.6 5544.1 5552.1 6642.9 6956.7 6970.6 6973.8 6985.5 1598.2 1605.1 1617.6 1619.6 1628.7 1013.1 1015.6 1037.1 1037.8 1038.1 6335.3 6500.4 6502.3 6506.4 6528.0 7117.7 7216.3 7224.7 7235.7 7251.9 6505.5 6546.4 6557.4 6564.5 6572.7 3210.6 3747.4 3846.2 3846.9 3849.2 7363.3 7600.3 7632.9 7649.9 7650.8 6135.8 7462.7 7522.4 7551.4 7572.6 7606.1 7611.8 7614.9 7621.0 7623.1 7277.5 7286.6 7300.0 7312.3 7332.7 6896.3 7150.7 7166.5 7176.0 7177.8 7574.7 7616.5 7617.9 7637.8 7657.2 4603.2 4603.4 4609.2 4616.0 4616.7 5890.6 6768.2 7119.5 7242.6 7262.2 6702.2 6996.8 7009.2 7010.1 7035.3 6988.7 7034.3 7037.4 7043.8 7051.7 6861.8 6875.4 6875.4 6876.5 6877.8 6994.2 7008.6 7017.0 7022.0 7028.7 6679.8 6855.4 6862.7 6910.3 6920.0 18:14:37 INFO - PROCESS | 1671 | 18:14:37 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:17160.09 Median:62951.87 stddev:23690.78 (37.6%) stddev-sans-first:23725.07 18:14:37 INFO - PROCESS | 1671 | Values: 718.3 757.2 764.6 768.7 812.7 15020.6 15164.1 15177.2 15193.3 15202.9 12717.3 12852.0 12860.5 12862.2 12867.4 741.0 759.8 913.7 928.8 944.6 950.9 954.2 955.4 955.6 955.6 998.4 999.5 1002.1 1003.4 1004.9 760.2 966.5 987.2 992.8 997.6 744.1 744.5 745.7 746.4 749.7 14715.9 14796.9 14805.3 14818.5 14873.0 12284.4 12308.1 12537.0 12628.7 12644.2 10122.2 10150.6 10336.1 10424.6 10454.2 2990.3 3056.3 3510.8 3549.6 3649.6 73893.3 75152.5 75781.0 76656.9 76732.0 9631.9 9703.8 9716.3 9716.9 9820.0 21724.2 21760.3 21775.8 21805.6 21828.7 6455.8 7450.1 7560.7 7649.5 7918.3 3428.4 4045.9 4109.6 4158.1 4284.8 3546.9 3582.7 3589.9 3591.2 3593.7 623.0 649.5 658.9 659.7 667.4 521.3 571.6 603.4 605.0 619.5 7927.5 7982.6 8226.6 8229.0 8230.0 589.2 591.1 593.6 597.9 623.2 3784.0 3797.8 3829.1 3842.0 3879.6 82314.6 82362.6 82641.2 83463.0 83493.6 70975.3 71430.6 71772.0 71956.0 73850.0 62849.1 63054.7 63200.1 65157.7 65262.0 7515.4 7660.3 7703.2 7723.9 7886.5 45248.0 45328.8 47694.8 48687.4 49956.8 55631.7 66390.7 66634.7 67372.0 67877.0 9909.1 9919.9 9928.7 10085.0 10090.3 10501.8 10572.9 10696.0 10778.5 10995.1 10106.5 10228.9 10354.3 10463.3 10553.7 9971.3 10038.3 10321.1 10362.7 10497.1 9829.7 10160.3 10161.1 10200.1 10338.3 8667.6 8782.5 8815.9 8933.7 8937.2 8705.5 8802.0 8803.5 8830.6 8915.6 18:14:37 INFO - PROCESS | 1671 | -------- Summary: end -------- 18:14:37 INFO - PROCESS | 1671 | 18:14:37 INFO - TEST-INFO | 1671: exit 0 18:14:37 INFO - TEST-OK | dromaeo_css | took 1114942ms 18:14:37 INFO - TEST-START | kraken 18:14:37 INFO - operating with platform_type : mac_ 18:14:37 INFO - Initialising browser for kraken test... 18:14:37 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpScBdxO/profile http://localhost:49279/getInfo.html) 18:14:39 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 18:14:39 INFO - PROCESS | 1677 | colorDepth:24 18:14:39 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 18:14:39 INFO - PROCESS | 1677 | __metrics 18:14:39 INFO - PROCESS | 1677 | 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" 18:14:39 ERROR - PROCESS | 1677 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:14:40 INFO - TEST-INFO | 1677: exit 0 18:14:40 INFO - Browser initialized. 18:14:40 INFO - Running cycle 1/1 for kraken test... 18:14:40 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpScBdxO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:14:52 INFO - PROCESS | 1679 | RSS: Main: 211095552 18:14:52 INFO - PROCESS | 1679 | 18:14:55 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 18:14:56 INFO - PROCESS | 1679 | RSS: Main: 271990784 18:14:56 INFO - PROCESS | 1679 | 18:14:58 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 18:14:59 INFO - PROCESS | 1679 | RSS: Main: 286191616 18:14:59 INFO - PROCESS | 1679 | 18:15:02 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 18:15:03 INFO - PROCESS | 1679 | RSS: Main: 371769344 18:15:03 INFO - PROCESS | 1679 | 18:15:05 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 18:15:05 INFO - PROCESS | 1679 | RSS: Main: 279601152 18:15:05 INFO - PROCESS | 1679 | 18:15:07 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:15:08 INFO - PROCESS | 1679 | RSS: Main: 280010752 18:15:08 INFO - PROCESS | 1679 | 18:15:11 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 18:15:11 INFO - PROCESS | 1679 | RSS: Main: 318607360 18:15:11 INFO - PROCESS | 1679 | 18:15:14 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 18:15:15 INFO - PROCESS | 1679 | RSS: Main: 318357504 18:15:15 INFO - PROCESS | 1679 | 18:15:18 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 18:15:18 INFO - PROCESS | 1679 | RSS: Main: 319303680 18:15:18 INFO - PROCESS | 1679 | 18:15:20 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:15:20 INFO - PROCESS | 1679 | RSS: Main: 309575680 18:15:20 INFO - PROCESS | 1679 | 18:15:22 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:15:23 INFO - PROCESS | 1679 | RSS: Main: 316932096 18:15:23 INFO - PROCESS | 1679 | 18:15:25 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:15:26 INFO - PROCESS | 1679 | RSS: Main: 318959616 18:15:26 INFO - PROCESS | 1679 | 18:15:28 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:15:29 INFO - PROCESS | 1679 | RSS: Main: 324247552 18:15:29 INFO - PROCESS | 1679 | 18:15:32 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:15:32 INFO - PROCESS | 1679 | RSS: Main: 322088960 18:15:32 INFO - PROCESS | 1679 | 18:15:34 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 18:15:35 INFO - PROCESS | 1679 | RSS: Main: 386097152 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - PROCESS | 1679 | __start_tp_report 18:15:35 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 18:15:35 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 18:15:35 INFO - PROCESS | 1679 | |i|pagename|runs| 18:15:35 INFO - PROCESS | 1679 | |0;ai-astar;159;168;158;113;112;113;114;114;114;134 18:15:35 INFO - PROCESS | 1679 | |1;audio-beat-detection;155;121;156;156;119;139;119;151;155;113 18:15:35 INFO - PROCESS | 1679 | |2;audio-dft;182;186;187;183;185;183;185;183;185;185 18:15:35 INFO - PROCESS | 1679 | |3;audio-fft;71;78;75;152;55;56;58;65;133;55 18:15:35 INFO - PROCESS | 1679 | |4;audio-oscillator;92;91;143;78;78;86;126;79;76;126 18:15:35 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;91;85;88;86;87;85;89;85;88;84 18:15:35 INFO - PROCESS | 1679 | |6;imaging-darkroom;93;94;94;94;94;94;95;106;149;148 18:15:35 INFO - PROCESS | 1679 | |7;imaging-desaturate;86;84;84;83;86;84;85;85;84;84 18:15:35 INFO - PROCESS | 1679 | |8;json-parse-financial;58;63;63;60;62;64;64;82;60;57 18:15:35 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;63;64;72;76;75;72;71;69;67;68 18:15:35 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;83;81;81;80;81;81;83;78;78;86 18:15:35 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;128;128;128;146;143;125;128;127;147;145 18:15:35 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;168;166;185;180;163;160;166;165;172;162 18:15:35 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;66;66;68;67;58;60;70;93;98;93 18:15:35 INFO - PROCESS | 1679 | __end_tp_report 18:15:35 INFO - PROCESS | 1679 | __start_cc_report 18:15:35 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1965 18:15:35 INFO - PROCESS | 1679 | __end_cc_report 18:15:35 INFO - PROCESS | 1679 | __startTimestamp1465002935010__endTimestamp 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - PROCESS | 1679 | ------- Summary: start ------- 18:15:35 INFO - PROCESS | 1679 | Number of tests: 14 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:129.90 Median:124.00 stddev:22.99 (18.5%) stddev-sans-first:21.83 18:15:35 INFO - PROCESS | 1679 | Values: 159.0 168.0 158.0 113.0 112.0 113.0 114.0 114.0 114.0 134.0 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:153.00 stddev:18.35 (12.0%) stddev-sans-first:18.45 18:15:35 INFO - PROCESS | 1679 | Values: 155.0 121.0 156.0 156.0 119.0 139.0 119.0 151.0 155.0 113.0 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:1.58 (0.9%) stddev-sans-first:1.41 18:15:35 INFO - PROCESS | 1679 | Values: 182.0 186.0 187.0 183.0 185.0 183.0 185.0 183.0 185.0 185.0 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:79.80 Median:61.50 stddev:34.38 (55.9%) stddev-sans-first:36.32 18:15:35 INFO - PROCESS | 1679 | Values: 71.0 78.0 75.0 152.0 55.0 56.0 58.0 65.0 133.0 55.0 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:78.50 stddev:24.64 (31.4%) stddev-sans-first:26.05 18:15:35 INFO - PROCESS | 1679 | Values: 92.0 91.0 143.0 78.0 78.0 86.0 126.0 79.0 76.0 126.0 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.50 stddev:2.20 (2.5%) stddev-sans-first:1.73 18:15:35 INFO - PROCESS | 1679 | Values: 91.0 85.0 88.0 86.0 87.0 85.0 89.0 85.0 88.0 84.0 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:106.10 Median:94.00 stddev:22.66 (24.1%) stddev-sans-first:23.54 18:15:35 INFO - PROCESS | 1679 | Values: 93.0 94.0 94.0 94.0 94.0 94.0 95.0 106.0 149.0 148.0 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:0.97 (1.2%) stddev-sans-first:0.87 18:15:35 INFO - PROCESS | 1679 | Values: 86.0 84.0 84.0 83.0 86.0 84.0 85.0 85.0 84.0 84.0 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.00 stddev:7.01 (11.1%) stddev-sans-first:7.17 18:15:35 INFO - PROCESS | 1679 | Values: 58.0 63.0 63.0 60.0 62.0 64.0 64.0 82.0 60.0 57.0 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:71.50 stddev:4.32 (6.0%) stddev-sans-first:3.84 18:15:35 INFO - PROCESS | 1679 | Values: 63.0 64.0 72.0 76.0 75.0 72.0 71.0 69.0 67.0 68.0 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:2.39 (3.0%) stddev-sans-first:2.45 18:15:35 INFO - PROCESS | 1679 | Values: 83.0 81.0 81.0 80.0 81.0 81.0 83.0 78.0 78.0 86.0 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:135.50 stddev:9.35 (6.9%) stddev-sans-first:9.61 18:15:35 INFO - PROCESS | 1679 | Values: 128.0 128.0 128.0 146.0 143.0 125.0 128.0 127.0 147.0 145.0 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:167.00 stddev:8.07 (4.8%) stddev-sans-first:8.56 18:15:35 INFO - PROCESS | 1679 | Values: 168.0 166.0 185.0 180.0 163.0 160.0 166.0 165.0 172.0 162.0 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:69.00 stddev:14.83 (21.5%) stddev-sans-first:15.45 18:15:35 INFO - PROCESS | 1679 | Values: 66.0 66.0 68.0 67.0 58.0 60.0 70.0 93.0 98.0 93.0 18:15:35 INFO - PROCESS | 1679 | -------- Summary: end -------- 18:15:35 INFO - PROCESS | 1679 | 18:15:35 INFO - TEST-INFO | 1679: exit 0 18:15:35 INFO - TEST-OK | kraken | took 58225ms 18:15:35 INFO - SUITE-END | took 1173s 18:15:36 INFO - Completed test suite (00:19:33) 18:15:36 INFO - javascript benchmark 18:15:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2842.2183899427655, 3408.6591340865907, 3411.897643070709, 3429.7599168058246, 3475.183331916999, 5598.0, 5608.4391560844, 5618.0, 5623.859403514909, 5648.350439699436, 5611.663300201991, 5622.41425495818, 5623.0721930881355, 5639.915401268984, 5655.802046928358, 5027.296178535008, 5065.7467126643705, 5135.435102138762, 5163.173892177234, 5227.137522308814, 5164.793408263665, 5166.974165129169, 5169.353830771153, 5172.818951336704, 5184.662996905208, 5132.384113906336, 5167.095758242312, 5196.168613021917, 5213.113770658978, 5224.294720212761, 4314.848980285675, 4553.977230113861, 5169.1987741899875, 5205.583553315726, 5242.2136679498, 5016.598672106223, 5066.746662666888, 5090.796368145269, 5124.205748109049, 5160.354955630546, 5470.343558772933, 5474.479924407175, 5500.28496295479, 5505.311836020497, 5515.531179849718, 6145.600535965148, 6172.22847144107, 6180.103884936659, 6184.536159788034, 6186.350433204494, 6043.60716553427, 6106.005662907935, 6119.837693858745, 6203.906941395882, 6232.3144454110015, 5698.2592263005545, 5719.771209151588, 5721.885562288731, 5735.741891614887, 5769.365369809318, 6153.876922461525, 6197.101420294032, 6213.596116252429, 6218.347073557302, 6301.7164227609865, 5345.839624811262, 5698.401667824819, 5882.911756323659, 5987.2815262168815, 6089.847753806191, 6173.722182501709, 6190.442860142609, 6193.318734939153, 6200.0699895016105, 6205.317415084337, 6122.448979591858, 6131.662758548234, 6140.140380346755, 6140.263168419729, 6149.046897730859, 6005.189299444606, 6018.037114061729, 6087.9650459422, 6152.415520525543, 6160.353162917919, 4800.255960326085, 4820.1805693031565, 4823.252395878644, 4824.6863953842885, 4832.51674832521, 4306.0957198987935, 4327.242732521859, 4332.935005974913, 4373.497047839539, 4400.603945644843, 5645.661260324311, 5663.037283661705, 5672.7730890763905, 5678.914816277759, 5696.259486266758, 6065.999110146777, 6127.18952814863, 6208.565400421927, 6211.844703882439, 6214.8135555933395, 5582.860428489239, 5590.077637189899, 5675.517581005578, 5679.091345384719, 5707.543396528351, 5292.2326262691695, 5298.523132918056, 5308.840734777963, 5316.308879845596, 5320.654157479751, 6147.108669243024, 6163.660998645118, 6191.4118158774845, 6228.750849966042, 6244.687765611792, 6158.168647232566, 6202.751889924352, 6207.503399727921, 6211.130441738251, 6218.22272215973, 6231.781887633911, 6240.375962403723, 6248.750049998131, 6252.280987686474, 6255.56211065221, 5847.298324201123, 6015.699215039143, 6038.667873266837, 6117.663528505975, 6132.233470816148, 6051.33435322123, 6060.090986352083, 6084.513238940963, 6092.329843717276, 6093.75624974996, 4963.751812409438, 5870.442307980735, 6051.4553690168095, 6052.425019623129, 6065.150878877049, 5969.8806023878415, 5978.790742323998, 5984.31180414258, 5990.940090599038, 6026.126211699367, 5831.1836342912875, 5839.474447299764, 5853.443922827325, 5868.149118377726, 5875.706214689163, 5763.971180144073, 5931.6441013539325, 6004.729787159501, 6005.009173486325, 6065.2418447694035, 5718.571107166896, 5794.101914203306, 5810.535157187331, 5845.795397161079, 5848.0], "value": 5598.2877983370245, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.5962749055735, 518.9065968125739, 532.3292651259413, 545.945405459454, 596.7016491754123, 29004.709952900517, 30576.0, 31269.68730312696, 31296.68703312969, 36851.0, 41234.381484277685, 41721.58278417215, 41852.0, 42045.738627841136, 42053.94865128373, 9382.71851844444, 9580.52097395131, 9587.0, 9592.568334424932, 9595.992420795821, 8473.067962524117, 8678.783030424227, 9356.4386136832, 11436.71408214793, 11765.52937882488, 11424.942875285611, 11514.30914145154, 11515.654530364103, 11529.250598711056, 11554.595589154382, 8470.0, 11350.659480215607, 11410.486528106256, 11418.657440276764, 11433.885661143366, 8436.114208008194, 8547.487150770912, 8562.400631955765, 11370.772584548346, 11680.007199388063, 37847.621523784685, 38237.23525529474, 38237.85286441411, 38295.0, 38476.42285365722, 3171.0, 3260.152360386293, 3279.344131173751, 3540.8760693375607, 3861.2663593917064, 27149.321266968287, 27561.44877102447, 27629.447411051668, 27644.30889227765, 28832.855835720897, 2721.972780272192, 2740.739629735172, 2791.8743656535503, 2800.425912687894, 2801.887924483018, 496874.5156274232, 498768.0, 499487.0, 500198.0, 501096.0, 61612.38387616067, 61911.6904415484, 62054.37945620577, 62098.379016210165, 62203.0, 65802.0, 65896.67051664711, 66002.0, 66136.00795988063, 66277.33722662808, 17013.298670133136, 17518.91240543789, 17534.0, 17558.38545650896, 17615.38346157904, 12372.938135309445, 12617.306048167438, 13702.38339274735, 13712.108712933827, 13769.449222031208, 16265.918670406572, 16411.507654770376, 16449.753253701205, 16486.917565412095, 16638.91680541614, 5894.145348924468, 5960.284765828042, 6284.402981716729, 6432.260290066609, 6476.902846457307, 967.1392460709974, 987.2792861211356, 1034.4414016431042, 1075.086176749772, 1113.6881673131536, 24634.319479298876, 26403.0, 27856.303592409946, 29089.41821163565, 29908.102756917327, 1006.3861044762835, 1130.0338210829786, 1181.710480932177, 1235.950561977511, 1301.3493253373313, 15005.849941500444, 15092.1699306537, 15135.545933622008, 15452.613684657974, 15496.690066198613, 610699.0, 613045.0, 615075.0, 615286.0, 616604.0, 45135.0, 58661.70669146712, 60180.699096504235, 60224.49438764066, 60256.0, 1316.2826259688493, 1322.7751282281843, 1372.3138430784609, 1514.0385854982167, 1563.975595984609, 28693.42613147767, 28915.85542072276, 29117.272068198465, 29811.956581519542, 29867.551986719784, 48083.0, 51798.705032372985, 51943.74028129986, 52242.738786305825, 52381.99999999847, 453706.0, 455084.0, 455245.0, 455592.0, 458365.0, 38966.80516597399, 39832.60167398289, 40352.3947140799, 40391.0, 40395.79802100971, 46698.0, 46840.0, 47700.522994769606, 48052.5194748048, 49235.50764492309, 35471.64528354684, 35564.11089722778, 35717.82141089278, 35995.46006809847, 36436.72471463592, 31564.842175788974, 32945.67054329426, 35084.64915350814, 35784.284314313045, 35915.64084359227, 35080.47379289364, 35313.293734125684, 35664.643353566134, 35860.282794343446, 36336.27327453383, 24517.38706532351, 32337.191570210933, 33017.33965320728, 33227.667723322455, 33317.83341083279, 24389.14637987662, 24534.89592968285, 24572.262832115066, 24661.555703220103, 24979.500409992062], "value": 19763.720085444907, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.3695809519055, 403.84250142444444, 404.0968435546555, 406.2524954084485, 417.9728317659352, 14146.0, 15928.68142637148, 19675.901620491877, 20336.08487618059, 20336.983150842472, 20577.588448231065, 20745.792542074574, 21202.151913923462, 21236.89381553094, 21843.017064232106, 5833.0, 6075.756969721206, 6094.60385074971, 6098.481629061535, 6105.664188469633, 5847.590668653196, 5920.763169473237, 6013.729382177812, 6028.21633187685, 6056.273247210341, 5974.402559744034, 6009.5192384609345, 6010.75956961721, 6015.248093988252, 6020.096985452195, 5770.33641131269, 5869.735861886204, 5931.051031834907, 5982.611130276518, 6000.279966404016, 5178.818741344035, 5229.712365819878, 5232.6860388376435, 5241.109011468022, 5258.842234732964, 25119.37201569957, 25966.0, 26429.0, 26552.336191595172, 26564.867175664192, 2244.2145249162663, 2337.0, 2517.5342561626157, 2521.231024537515, 2773.334399744067, 13518.32408379587, 14094.788578171234, 14850.1832399218, 14862.0, 14922.328495217742, 1690.4506035538377, 1699.7138848249085, 1739.1999680147148, 1776.4581802550217, 1816.228103056209, 83237.0, 108056.20376346725, 109029.0, 115242.8475715249, 118759.4062029693, 11352.262102963281, 11403.258788178742, 11449.542018319175, 11462.083033357312, 11594.826077608843, 14211.78682319766, 14253.64365890861, 14263.857361426253, 14265.0, 14272.500462483764, 7103.715851365888, 8843.823123537493, 8979.416337938013, 8986.505742184243, 9068.909310906807, 8033.0, 8622.913770862211, 9136.771580710536, 9151.496667683341, 9256.07439256069, 5550.417206193372, 6859.622720750307, 6867.244603093655, 6876.656167191721, 6886.8622627547165, 1787.2404228203222, 1884.689026310671, 1907.1227235471838, 1909.8376637985648, 1912.4740696308627, 818.9017317921769, 964.7346979580531, 982.4105536677936, 1021.7854250607455, 1040.8334666453482, 19499.902500487406, 20635.58728825415, 20654.58690826175, 20900.47748806292, 20914.0, 988.3773222869546, 1013.8479228115841, 1014.2190513304714, 1021.4637315409469, 1032.6334151376304, 11059.778804423866, 11386.430678466044, 11408.372539510241, 11433.542658293742, 11652.067834573214, 568625.156874213, 607103.0, 610292.0, 625067.0, 626519.0, 112909.4354528222, 116136.0, 118638.40680796541, 119054.0, 119555.0, 1006.8036732837027, 1017.7404761785697, 1019.8164330420448, 1023.744063984004, 1060.2578195263347, 18869.6226075475, 18887.15007824679, 18973.810261897204, 19032.71450928265, 19033.895431745277, 51829.22256166236, 51840.22239666484, 52203.0, 53039.469605305, 55198.44801551933, 74419.85565500641, 75433.0, 75519.62240188764, 75796.0, 76416.0, 7793.883091753742, 8092.393070519853, 8222.753317400488, 8241.752747417588, 8457.02744184402, 11116.943890330405, 12377.938110309391, 12724.1729287596, 12896.613101606967, 13192.0, 11021.228514004264, 11204.215704900906, 11260.436978151223, 11333.320000799979, 11429.428528573704, 9202.401843880127, 10846.457677115955, 11021.228514003942, 11124.0, 11495.195336326711, 5993.880122397441, 5997.580169388276, 6820.908654615436, 11258.605948792081, 11302.039326657326, 6897.3447522485285, 7565.6973721050545, 7727.343175829893, 8280.171982801672, 8485.448445851, 9833.60665573369, 10242.385456872611, 10499.950004999439, 11158.55365785392, 11317.377544235145], "value": 9666.948727259083, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.0911416693311, 1553.3631211203406, 1581.7073841339354, 1800.4778614201882, 1953.8925359105244, 7096.538724982879, 7792.4934879232815, 8652.178043085913, 8659.134086591337, 8727.127287271269, 8250.133735957728, 8491.872621910676, 8500.489970601768, 8533.0, 8546.188112129354, 2402.3153401280597, 2441.414060625455, 2446.755324467557, 2448.755124487546, 2454.521368333176, 2385.0817435287368, 2426.1387207541334, 2426.708794944609, 2433.9756602434013, 2450.6079027355627, 2406.2901444073955, 2433.3551608823677, 2438.878056097197, 2443.621238707994, 2454.9263522094366, 2392.7009123859516, 2423.8182136339756, 2424.9393765155924, 2428.550718117154, 2435.4398488347692, 2384.8092152627923, 2415.384077060356, 2426.1993542131054, 2428.235105941623, 2439.4511234972165, 8440.83118337636, 8486.490810551324, 8513.872291915626, 8525.104863989254, 8528.6162122704, 5280.867978300535, 5456.154296084113, 5470.890582188374, 5480.972595137038, 5481.835544933659, 3330.8001519908885, 3339.9833000835083, 3364.394409006378, 3407.6762707542994, 3422.5208470814105, 1041.1566631028816, 1049.5277125293571, 1065.7655315830505, 1074.135321066541, 1075.1130317488103, 11583.305001699924, 11760.000399966013, 11784.941075294655, 11787.233829801036, 11823.054155667613, 4674.439067311876, 4787.305840653085, 4869.853904382874, 4875.146849301358, 4898.755062246873, 10002.549885255181, 10100.747481313027, 10115.342502737298, 10148.543315550818, 10150.340227885164, 5418.431064738224, 5438.075527160392, 5469.863253418696, 5470.617056806065, 5481.397046324901, 4381.3208952612395, 4519.954800452019, 4740.360051393087, 4908.165611845995, 4931.334269873521, 3947.1513624570857, 3996.460477835455, 4085.305498065336, 4089.325261331847, 4100.302948498763, 1169.9473523691454, 1277.9105462617713, 1342.2617560341773, 1357.9185248885099, 1357.9728405432033, 675.1830285354678, 823.9382046346428, 830.5971603772166, 878.8813510176044, 954.8138113068024, 5608.9439105609235, 5785.30576330843, 5798.855028624318, 5922.644641321448, 5969.074793407029, 938.8450905600499, 943.556528431636, 961.8653388525612, 981.0728861226215, 982.9017098290257, 3819.0452386903276, 3952.9011774705864, 3953.5058117735284, 4038.2932986727205, 4044.3933409988736, 9808.803823923481, 10504.737381565523, 10515.263931524873, 10593.629222977313, 10621.5220315086, 10134.037266459674, 10368.533415996299, 10378.636747713794, 10495.00297471739, 10513.632022879163, 7996.9200307997335, 8213.712520061888, 8268.007839059232, 8274.213949674771, 8324.29243514296, 5548.361938377138, 5651.350094739158, 5744.167095771173, 5804.3905389935135, 5879.529637628894, 9037.051109633394, 9204.217641500547, 9224.907750922404, 9320.580573874056, 9342.579583918605, 9232.0, 9301.488418137067, 9430.669926552539, 9436.811263774549, 9468.431894086378, 6977.686004129928, 7753.340966017951, 8136.918630813616, 8147.307478864363, 8149.022117345957, 8008.399370047387, 8095.83808323842, 8133.471324363897, 8147.633356498854, 8149.103598604267, 6433.646149461824, 7436.628168591657, 7468.626568671653, 7581.279778421042, 7597.962010189914, 7156.713731450684, 7272.345488906024, 7316.451266155166, 7412.1846596875375, 7505.399568034435, 6968.686409111703, 7024.262452442625, 7033.437325014089, 7036.472264580279, 7041.894371584533, 4735.195016847213, 4783.0, 4947.554720075211, 4989.151844186569, 5009.649324547247, 4979.5269449403695, 5003.1744762115295, 5026.421961474331, 5053.823116190915, 5091.236314552847], "value": 4574.438950062069, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.8744395963594, 320.85401142480174, 327.6166884744848, 328.66312030169064, 332.6507167474152, 5939.910901336483, 6563.7046332915015, 6575.210974683045, 6575.276719560845, 6577.473802095827, 6543.1821022372205, 6564.310747371529, 6575.967120164404, 6596.010598410241, 6599.340065993399, 4663.997240593272, 4738.455077666061, 4741.288806678991, 4757.0, 4830.082284365977, 4776.737279449629, 4823.782929768169, 4829.372181616385, 4846.0792449434675, 4867.9269810952865, 3835.5589107252604, 4784.091022705692, 4800.4719480857075, 4823.710577365369, 4824.517548245165, 3443.2596991646915, 4298.935515967263, 4578.793954272066, 4734.029523947617, 4810.508742289901, 4026.959730402688, 4055.087605288816, 4077.3068578341754, 4095.385692146172, 4103.384492326145, 6139.6009259398, 6154.323024467305, 6184.19605451293, 6199.814005579795, 6227.906581401283, 5676.858078548028, 5685.943140568583, 5702.77188912443, 5705.74324155414, 5712.742926568314, 6896.620685862275, 6919.965400173017, 6924.792256232321, 6932.688029038705, 6940.548864323803, 3837.9253808933545, 4334.393184954078, 4540.432445944257, 4550.840720574764, 4643.674942754009, 7213.4589905757275, 7331.010313607648, 7332.523385979895, 7333.669984850641, 7346.669399877019, 4592.173408786451, 4596.701214421052, 4605.0, 4605.125026245003, 4620.5379462053525, 3843.423486476995, 3879.3017256893468, 4642.141203877293, 4645.558671926162, 4653.278741795028, 5529.944700553024, 5530.917036244379, 5531.585131115183, 5544.085225937756, 5552.139418390156, 6642.86714265712, 6956.686949087303, 6970.616616086164, 6973.825654358681, 6985.476089293222, 1598.224860942442, 1605.077080678591, 1617.6279455725014, 1619.5708137343613, 1628.6742651469517, 1013.1034034879185, 1015.6343716262139, 1037.1339931157568, 1037.7976294622476, 1038.055369613648, 6335.271443783931, 6500.414962653289, 6502.284748677642, 6506.414422701885, 6528.0, 7117.679704413314, 7216.314450127229, 7224.711011559479, 7235.746748863765, 7251.891221631679, 6505.544611877218, 6546.443552298108, 6557.442617377576, 6564.540482166202, 6572.704228309737, 3210.550522926792, 3747.3816820224356, 3846.1538461538416, 3846.8845934622004, 3849.2301539692176, 7363.300486453778, 7600.315971562586, 7632.923670763333, 7649.885251721229, 7650.770476885702, 6135.785247516315, 7462.738804141829, 7522.435817313614, 7551.358134558624, 7572.621368931532, 7606.087269527692, 7611.771646850492, 7614.923850761532, 7621.0, 7623.085229772463, 7277.526960747535, 7286.599237042014, 7300.014498042697, 7312.268773122645, 7332.743353982585, 6896.27589103157, 7150.67821948024, 7166.462515311477, 7175.964120179575, 7177.820554485971, 7574.734884279023, 7616.504927179715, 7617.885731714139, 7637.770866874002, 7657.195994420728, 4603.240465323184, 4603.3785438965315, 4609.216433206296, 4615.953840461552, 4616.746078965689, 5890.617109887844, 6768.2216545097945, 7119.466040046914, 7242.565446073042, 7262.164851042197, 6702.190408589556, 6996.825079373057, 7009.1939426966555, 7010.053642758162, 7035.33164349386, 6988.6505674715045, 7034.296570343129, 7037.366637002694, 7043.823904402431, 7051.717931282691, 6861.828454288683, 6875.3812156906115, 6875.415589674733, 6876.484263680344, 6877.759278425231, 6994.195667498303, 7008.579485230903, 7017.0, 7022.0, 7028.683709233199, 6679.799606011828, 6855.417289530246, 6862.656867156522, 6910.274421185703, 6919.965400172967], "value": 5073.506320501166, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.2853061204102, 757.1973707869658, 764.571839769729, 768.6694721269859, 812.7317985064927, 15020.624484387896, 15164.090154590718, 15177.241137943114, 15193.316300766464, 15202.923985380072, 12717.300548469853, 12852.0, 12860.549880754175, 12862.163959342659, 12867.356632168401, 741.0218511564736, 759.7568777991045, 913.7395842184995, 928.823523530527, 944.5560586524357, 950.9096635819586, 954.2366107114316, 955.350361754007, 955.5699935029264, 955.6082006377387, 998.4009594243432, 999.5152351109742, 1002.1431675917095, 1003.4380746781826, 1004.8844382895987, 760.2397602397602, 966.5167416291854, 987.2250283527396, 992.8064027514638, 997.6258902911409, 744.0884915977938, 744.5123444144094, 745.6607243704102, 746.354403441025, 749.7338444852054, 14715.926420367936, 14796.89023323255, 14805.259737013106, 14818.481353152589, 14873.0, 12284.385780710929, 12308.138430309882, 12537.0, 12628.747425051448, 12644.241345519205, 10122.240831937634, 10150.644727434577, 10336.121429678486, 10424.583016679324, 10454.163666906628, 2990.2823322402683, 3056.312329725816, 3510.7542472026967, 3549.6095429502734, 3649.562052553684, 73893.26106738918, 75152.49695006124, 75781.0, 76656.85014724784, 76732.0, 9631.903680963242, 9703.757406064764, 9716.31985761004, 9716.902830971741, 9820.017998200123, 21724.239651612435, 21760.34718958434, 21775.78224217769, 21805.563888722136, 21828.672569911465, 6455.7740479083, 7450.0687414073245, 7560.735374261984, 7649.502782319131, 7918.326942209861, 3428.434308339146, 4045.8583949561626, 4109.630133288018, 4158.106007208465, 4284.828606855754, 3546.929061418757, 3582.695470885004, 3589.892303230907, 3591.2278860045217, 3593.748437609342, 623.03118650498, 649.4771708774482, 658.9077529145924, 659.7262136213418, 667.3560014585947, 521.3431076843129, 571.5541877335685, 603.3513972479602, 604.9788257410969, 619.4827319188438, 7927.484713493604, 7982.640781164861, 8226.588670566447, 8228.99818287117, 8230.0, 589.1810383566846, 591.0554276430496, 593.5696619950587, 597.8893904627571, 623.2489849731063, 3784.0, 3797.7531460454984, 3829.100161462054, 3841.961580384216, 3879.631435013669, 82314.58842705748, 82362.58818705867, 82641.17358826454, 83463.0, 83493.58253208695, 70975.2902470979, 71430.64284678543, 71772.0, 71956.0, 73850.0, 62849.057264141076, 63054.68472657699, 63200.05199922005, 65157.674211629586, 65262.0, 7515.361194298327, 7660.2722741339485, 7703.152653208031, 7723.9227607723205, 7886.526808391515, 45248.0, 45328.77335613301, 47694.761526192146, 48687.40094889133, 49956.75108122326, 55631.721841390536, 66390.66804665946, 66634.66682666556, 67372.0, 67877.0, 9909.058639429242, 9919.872194902831, 9928.702138935843, 10084.991500849856, 10090.293679442662, 10501.789964200825, 10572.947135264274, 10696.03735663763, 10778.461076945965, 10995.065419439437, 10106.49467526606, 10228.897711022795, 10354.326968747007, 10463.267571269938, 10553.683389498327, 9971.30200885931, 10038.29731918788, 10321.066560143747, 10362.689119326433, 10497.10774584169, 9829.705108846745, 10160.288779785344, 10161.085502304828, 10200.132988696045, 10338.276320657782, 8667.566621668766, 8782.473051616924, 8815.867761983704, 8933.687320943736, 8937.150970657776, 8705.47767133974, 8801.955990220007, 8803.515806630698, 8830.646774128963, 8915.643374264957], "value": 6694.938759626701, "unit": "score"}], "name": "dromaeo_css", "value": 7414.93598224142, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 168.0, 158.0, 113.0, 112.0, 113.0, 114.0, 114.0, 114.0, 134.0], "value": 129.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 121.0, 156.0, 156.0, 119.0, 139.0, 119.0, 151.0, 155.0, 113.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 186.0, 187.0, 183.0, 185.0, 183.0, 185.0, 183.0, 185.0, 185.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 78.0, 75.0, 152.0, 55.0, 56.0, 58.0, 65.0, 133.0, 55.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 143.0, 78.0, 78.0, 86.0, 126.0, 79.0, 76.0, 126.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 85.0, 88.0, 86.0, 87.0, 85.0, 89.0, 85.0, 88.0, 84.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 106.0, 149.0, 148.0], "value": 106.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 83.0, 86.0, 84.0, 85.0, 85.0, 84.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 63.0, 63.0, 60.0, 62.0, 64.0, 64.0, 82.0, 60.0, 57.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 72.0, 76.0, 75.0, 72.0, 71.0, 69.0, 67.0, 68.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 81.0, 80.0, 81.0, 81.0, 83.0, 78.0, 78.0, 86.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 128.0, 146.0, 143.0, 125.0, 128.0, 127.0, 147.0, 145.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 185.0, 180.0, 163.0, 160.0, 166.0, 165.0, 172.0, 162.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 67.0, 58.0, 60.0, 70.0, 93.0, 98.0, 93.0], "value": 73.9, "unit": "score"}], "name": "kraken", "value": 1498.7, "alertThreshold": 2.0}]} 18:15:36 INFO - Return code: 0 18:15:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:15:36 ERROR - # TBPL SUCCESS # 18:15:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:15:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:15:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:15:36 INFO - 2016-06-03 18:15:36.288 screenresolution[1683:10027] starting screenresolution argv=screenresolution get 18:15:36 INFO - 2016-06-03 18:15:36.291 screenresolution[1683:10027] Display 0: 1600x1200x32@60 18:15:36 INFO - 2016-06-03 18:15:36.296 screenresolution[1684:10030] starting screenresolution argv=screenresolution list 18:15:36 INFO - Available Modes on Display 0 18:15:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:15:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:15:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:15:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:15:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:15:36 INFO - Intel Iris: 18:15:36 INFO - Chipset Model: Intel Iris 18:15:36 INFO - Type: GPU 18:15:36 INFO - Bus: Built-In 18:15:36 INFO - VRAM (Dynamic, Max): 1536 MB 18:15:36 INFO - Vendor: Intel (0x8086) 18:15:36 INFO - Device ID: 0x0a2e 18:15:36 INFO - Revision ID: 0x0009 18:15:36 INFO - Displays: 18:15:36 INFO - Display: 18:15:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:15:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:15:36 INFO - Display Serial Number: 1600x1200 60 18:15:36 INFO - Main Display: Yes 18:15:36 INFO - Mirror: Off 18:15:36 INFO - Online: Yes 18:15:36 INFO - Rotation: Supported 18:15:36 INFO - Return code: 0 18:15:36 INFO - Running post-action listener: _resource_record_post_action 18:15:36 INFO - Running post-run listener: _resource_record_post_run 18:15:37 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 31555072; Write bytes: 653753344; Read time: 194; Write time: 1885 18:15:37 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 345985536; Write bytes: 345913344; Read time: 26616; Write time: 760 18:15:37 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 30629376; Write bytes: 297878528; Read time: 183; Write time: 1090 18:15:37 INFO - Running post-run listener: _upload_blobber_files 18:15:37 INFO - Blob upload gear active. 18:15:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:15:37 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 18:15:37 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'] 18:15:37 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 18:15:38 INFO - (blobuploader) - INFO - Open directory for files ... 18:15:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:15:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:15:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:15:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:15:38 INFO - (blobuploader) - INFO - Done attempting. 18:15:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:15:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:15:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:15:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:15:39 INFO - (blobuploader) - INFO - Done attempting. 18:15:39 INFO - (blobuploader) - INFO - Iteration through files over. 18:15:39 INFO - Return code: 0 18:15:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:15:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:15:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da965a105f022bf985c084d8fbb133481cadbddd6a97007c259ec8545790f33f67e37bda1dbc35c94e3ac028455927e29b676cee09f593d13d2c879c60b45c76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c261873a52b556f23c8ea1b1801c0d6ea49d77c99af828a9d089a6edad080e0d214c16f94d688ae51bda35c429ca8f6334242d6a38c2fb04ccbd52bdcf1a72c9"} 18:15:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:15:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:15:39 INFO - Contents: 18:15:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da965a105f022bf985c084d8fbb133481cadbddd6a97007c259ec8545790f33f67e37bda1dbc35c94e3ac028455927e29b676cee09f593d13d2c879c60b45c76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c261873a52b556f23c8ea1b1801c0d6ea49d77c99af828a9d089a6edad080e0d214c16f94d688ae51bda35c429ca8f6334242d6a38c2fb04ccbd52bdcf1a72c9"} 18:15:39 INFO - Running post-run listener: copy_logs_to_upload_dir 18:15:39 INFO - Copying logs to upload dir... 18:15:39 INFO - mkdir: /builds/slave/test/build/upload/logs 18:15:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.981967 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-06-03 18:15:39.693575) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 18:15:39.697257) ========= 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.FOjKVuxJrj/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.co6xYSNczu/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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/da965a105f022bf985c084d8fbb133481cadbddd6a97007c259ec8545790f33f67e37bda1dbc35c94e3ac028455927e29b676cee09f593d13d2c879c60b45c76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c261873a52b556f23c8ea1b1801c0d6ea49d77c99af828a9d089a6edad080e0d214c16f94d688ae51bda35c429ca8f6334242d6a38c2fb04ccbd52bdcf1a72c9"} build_url:https://queue.taskcluster.net/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011068 build_url: 'https://queue.taskcluster.net/v1/task/A1OmdXxmRbiIaKcRIY76OQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da965a105f022bf985c084d8fbb133481cadbddd6a97007c259ec8545790f33f67e37bda1dbc35c94e3ac028455927e29b676cee09f593d13d2c879c60b45c76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c261873a52b556f23c8ea1b1801c0d6ea49d77c99af828a9d089a6edad080e0d214c16f94d688ae51bda35c429ca8f6334242d6a38c2fb04ccbd52bdcf1a72c9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 18:15:39.729354) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 18:15:39.729715) ========= 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.FOjKVuxJrj/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.co6xYSNczu/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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.005069 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 18:15:39.778758) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 18:15:39.779087) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 18:15:39.779445) ========= ========= Total master_lag: 0.18 =========