builder: larch_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0116 starttime: 1467329695.36 results: success (0) buildid: 20160630142223 builduid: 4844506a8c974ba9b059bf0782fd6d3f revision: 153145e35ec01ceb3d139910bcc70cf421ee4ce8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:55.355927) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:55.356342) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:55.356609) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:55.380291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:55.380565) ========= 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.90GuFF8ptC/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.g5it95sxtM/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-30 16:34:55-- 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% 9.58M=0.001s 2016-06-30 16:34:55 (9.58 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091059 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:55.493552) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:55.493854) ========= 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.90GuFF8ptC/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.g5it95sxtM/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.028928 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:55.543658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 16:34:55.543976) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 153145e35ec01ceb3d139910bcc70cf421ee4ce8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 153145e35ec01ceb3d139910bcc70cf421ee4ce8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.90GuFF8ptC/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.g5it95sxtM/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-30 16:34:55,617 truncating revision to first 12 chars 2016-06-30 16:34:55,617 Setting DEBUG logging. 2016-06-30 16:34:55,617 attempt 1/10 2016-06-30 16:34:55,617 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/153145e35ec0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 16:34:56,318 unpacking tar archive at: larch-153145e35ec0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.984480 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 16:34:56.550412) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:56.550760) ========= script_repo_revision: 153145e35ec01ceb3d139910bcc70cf421ee4ce8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:56.551155) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:56.551505) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:56.569688) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-30 16:34:56.569964) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 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', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.90GuFF8ptC/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.g5it95sxtM/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 16:34:56 INFO - MultiFileLogger online at 20160630 16:34:56 in /builds/slave/test 16:34:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 16:34:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:34:56 INFO - {'append_to_log': False, 16:34:56 INFO - 'base_work_dir': '/builds/slave/test', 16:34:56 INFO - 'blob_upload_branch': 'Larch', 16:34:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:34:56 INFO - 'branch': 'Larch', 16:34:56 INFO - 'buildbot_json_path': 'buildprops.json', 16:34:56 INFO - 'config_files': ('talos/mac_config.py',), 16:34:56 INFO - 'default_actions': ('clobber', 16:34:56 INFO - 'read-buildbot-config', 16:34:56 INFO - 'download-and-extract', 16:34:56 INFO - 'populate-webroot', 16:34:56 INFO - 'create-virtualenv', 16:34:56 INFO - 'install', 16:34:56 INFO - 'run-tests'), 16:34:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:34:56 INFO - 'download_minidump_stackwalk': True, 16:34:56 INFO - 'download_symbols': 'ondemand', 16:34:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:34:56 INFO - 'tooltool.py': '/tools/tooltool.py', 16:34:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:34:56 INFO - '/tools/misc-python/virtualenv.py')}, 16:34:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:34:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:34:56 INFO - 'installer_path': 'installer.exe', 16:34:56 INFO - 'log_level': 'info', 16:34:56 INFO - 'log_name': 'talos', 16:34:56 INFO - 'log_to_console': True, 16:34:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:34:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:34:56 INFO - 'opt_config_files': (), 16:34:56 INFO - 'pip_index': False, 16:34:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:34:56 INFO - 'cmd': ('bash', 16:34:56 INFO - '-c', 16:34:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:34:56 INFO - 'enabled': True, 16:34:56 INFO - 'halt_on_failure': False, 16:34:56 INFO - 'name': 'check_screen_resolution'},), 16:34:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:34:56 INFO - 'cmd': ('bash', 16:34:56 INFO - '-c', 16:34:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:34:56 INFO - 'enabled': True, 16:34:56 INFO - 'halt_on_failure': False, 16:34:56 INFO - 'name': 'check_screen_resolution'},), 16:34:56 INFO - 'run_cmd_checks_enabled': True, 16:34:56 INFO - 'sps_profile': False, 16:34:56 INFO - 'sps_profile_interval': 0, 16:34:56 INFO - 'suite': 'dromaeojs', 16:34:56 INFO - 'system_bits': '32', 16:34:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:34:56 INFO - 'title': 't-yosemite-r7-0116', 16:34:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:34:56 INFO - 'use_talos_json': True, 16:34:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:34:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:34:56 INFO - 'work_dir': 'build'} 16:34:56 INFO - ##### 16:34:56 INFO - ##### Running clobber step. 16:34:56 INFO - ##### 16:34:56 INFO - Running pre-action listener: _resource_record_pre_action 16:34:56 INFO - Running main action method: clobber 16:34:56 INFO - rmtree: /builds/slave/test/build 16:34:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:34:58 INFO - Running post-action listener: _resource_record_post_action 16:34:58 INFO - ##### 16:34:58 INFO - ##### Running read-buildbot-config step. 16:34:58 INFO - ##### 16:34:58 INFO - Running pre-action listener: _resource_record_pre_action 16:34:58 INFO - Running main action method: read_buildbot_config 16:34:58 INFO - Using buildbot properties: 16:34:58 INFO - { 16:34:58 INFO - "project": "", 16:34:58 INFO - "product": "firefox", 16:34:58 INFO - "script_repo_revision": "production", 16:34:58 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs", 16:34:58 INFO - "repository": "", 16:34:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs", 16:34:58 INFO - "buildid": "20160630142223", 16:34:58 INFO - "pgo_build": "False", 16:34:58 INFO - "basedir": "/builds/slave/test", 16:34:58 INFO - "buildnumber": 1, 16:34:58 INFO - "slavename": "t-yosemite-r7-0116", 16:34:58 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 16:34:58 INFO - "platform": "yosemite_r7", 16:34:58 INFO - "scheduler": "tests-larch-macosx64-talos", 16:34:58 INFO - "branch": "larch", 16:34:58 INFO - "repo_path": "projects/larch", 16:34:58 INFO - "revision": "153145e35ec01ceb3d139910bcc70cf421ee4ce8", 16:34:58 INFO - "stage_platform": "macosx64", 16:34:58 INFO - "builduid": "4844506a8c974ba9b059bf0782fd6d3f", 16:34:58 INFO - "slavebuilddir": "test" 16:34:58 INFO - } 16:34:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg. 16:34:58 INFO - Running post-action listener: _resource_record_post_action 16:34:58 INFO - ##### 16:34:58 INFO - ##### Running download-and-extract step. 16:34:58 INFO - ##### 16:34:58 INFO - Running pre-action listener: _resource_record_pre_action 16:34:58 INFO - Running main action method: download_and_extract 16:34:58 INFO - mkdir: /builds/slave/test/build/tests 16:34: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')]} 16:34:58 INFO - https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:34:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json 16:34:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json 16:34:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.2.en-US.mac.test_packages.json 16:34:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.2.en-US.mac.test_packages.json'}, attempt #1 16:35:00 INFO - Downloaded 1277 bytes. 16:35:00 INFO - Reading from file /builds/slave/test/build/firefox-47.0.2.en-US.mac.test_packages.json 16:35:00 INFO - Using the following test package requirements: 16:35:00 INFO - {u'common': [u'firefox-47.0.2.en-US.mac.common.tests.zip'], 16:35:00 INFO - u'cppunittest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 16:35:00 INFO - u'firefox-47.0.2.en-US.mac.cppunittest.tests.zip'], 16:35:00 INFO - u'gtest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 16:35:00 INFO - u'firefox-47.0.2.en-US.mac.gtest.tests.zip'], 16:35:00 INFO - u'jittest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 16:35:00 INFO - u'jsshell-mac.zip'], 16:35:00 INFO - u'mochitest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 16:35:00 INFO - u'firefox-47.0.2.en-US.mac.mochitest.tests.zip'], 16:35:00 INFO - u'mozbase': [u'firefox-47.0.2.en-US.mac.common.tests.zip'], 16:35:00 INFO - u'reftest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 16:35:00 INFO - u'firefox-47.0.2.en-US.mac.reftest.tests.zip'], 16:35:00 INFO - u'talos': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 16:35:00 INFO - u'firefox-47.0.2.en-US.mac.talos.tests.zip'], 16:35:00 INFO - u'web-platform': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 16:35:00 INFO - u'firefox-47.0.2.en-US.mac.web-platform.tests.zip'], 16:35:00 INFO - u'webapprt': [u'firefox-47.0.2.en-US.mac.common.tests.zip'], 16:35:00 INFO - u'xpcshell': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 16:35:00 INFO - u'firefox-47.0.2.en-US.mac.xpcshell.tests.zip']} 16:35:00 INFO - Downloading packages: [u'firefox-47.0.2.en-US.mac.common.tests.zip'] for test suite category: common 16:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:00 INFO - https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:35:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip 16:35:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip 16:35:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip 16:35:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip'}, attempt #1 16:35:04 INFO - Downloaded 17990203 bytes. 16:35:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:35:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:35:07 INFO - Return code: 0 16:35:07 INFO - Downloading packages: [u'firefox-47.0.2.en-US.mac.common.tests.zip', u'firefox-47.0.2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:35:07 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')]} 16:35:07 INFO - https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:35:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip 16:35:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip 16:35:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip 16:35:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip'}, attempt #1 16:35:08 INFO - Downloaded 17990203 bytes. 16:35:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:35:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:35:12 INFO - Return code: 0 16:35:12 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')]} 16:35:12 INFO - https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:35:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip 16:35:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip 16:35:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.mac.talos.tests.zip 16:35:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.talos.tests.zip'}, attempt #1 16:35:13 INFO - Downloaded 10845194 bytes. 16:35:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:35:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:35:13 INFO - Return code: 0 16:35: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')]} 16:35:13 INFO - https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg matches https://queue.taskcluster.net 16:35:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg 16:35:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg 16:35:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.2.en-US.mac.dmg 16:35:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.2.en-US.mac.dmg'}, attempt #1 16:35:16 INFO - Downloaded 115397489 bytes. 16:35:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg 16:35:16 INFO - mkdir: /builds/slave/test/properties 16:35:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:35:16 INFO - Writing to file /builds/slave/test/properties/build_url 16:35:16 INFO - Contents: 16:35:16 INFO - build_url:https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg 16:35:17 INFO - Running post-action listener: _resource_record_post_action 16:35:17 INFO - Running post-action listener: set_extra_try_arguments 16:35:17 INFO - ##### 16:35:17 INFO - ##### Running populate-webroot step. 16:35:17 INFO - ##### 16:35:17 INFO - Running pre-action listener: _resource_record_pre_action 16:35:17 INFO - Running main action method: populate_webroot 16:35:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:35:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:35:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:35:17 INFO - '--tppagecycles', 16:35:17 INFO - '7'], 16:35:17 INFO - 'tests': ['tsvgm']}}, 16:35:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:35:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:35:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:35:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:35:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:35:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:35:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:35:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:17 INFO - 'talos_options': ['--e10s'], 16:35:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:35:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:17 INFO - 'tests': ['damp', 'tps']}, 16:35:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:17 INFO - 'talos_options': ['--e10s'], 16:35:17 INFO - 'tests': ['damp', 'tps']}, 16:35:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:35:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:35:17 INFO - 'other': {'tests': ['a11yr', 16:35:17 INFO - 'ts_paint', 16:35:17 INFO - 'tpaint', 16:35:17 INFO - 'sessionrestore', 16:35:17 INFO - 'sessionrestore_no_auto_restore', 16:35:17 INFO - 'tabpaint']}, 16:35:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:35:17 INFO - 'tests': ['a11yr', 16:35:17 INFO - 'ts_paint', 16:35:17 INFO - 'tpaint', 16:35:17 INFO - 'sessionrestore', 16:35:17 INFO - 'sessionrestore_no_auto_restore', 16:35:17 INFO - 'tabpaint']}, 16:35:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:35:17 INFO - 'tests': ['a11yr', 16:35:17 INFO - 'ts_paint', 16:35:17 INFO - 'tpaint', 16:35:17 INFO - 'sessionrestore', 16:35:17 INFO - 'sessionrestore_no_auto_restore', 16:35:17 INFO - 'tabpaint']}, 16:35:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:35:17 INFO - 'tests': ['a11yr', 16:35:17 INFO - 'ts_paint', 16:35:17 INFO - 'tpaint', 16:35:17 INFO - 'sessionrestore', 16:35:17 INFO - 'sessionrestore_no_auto_restore', 16:35:17 INFO - 'tabpaint']}, 16:35:17 INFO - 'other_l64': {'tests': ['a11yr', 16:35:17 INFO - 'ts_paint', 16:35:17 INFO - 'tpaint', 16:35:17 INFO - 'sessionrestore', 16:35:17 INFO - 'sessionrestore_no_auto_restore', 16:35:17 INFO - 'tabpaint']}, 16:35:17 INFO - 'other_nol64': {'tests': ['a11yr', 16:35:17 INFO - 'ts_paint', 16:35:17 INFO - 'tpaint', 16:35:17 INFO - 'sessionrestore', 16:35:17 INFO - 'sessionrestore_no_auto_restore', 16:35:17 INFO - 'tabpaint']}, 16:35:17 INFO - 'svgr': {'tests': ['tsvgx', 16:35:17 INFO - 'tsvgr_opacity', 16:35:17 INFO - 'tart', 16:35:17 INFO - 'tscrollx', 16:35:17 INFO - 'cart']}, 16:35:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:35:17 INFO - 'tests': ['tsvgx', 16:35:17 INFO - 'tsvgr_opacity', 16:35:17 INFO - 'tart', 16:35:17 INFO - 'tscrollx', 16:35:17 INFO - 'cart']}, 16:35:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:17 INFO - 'tests': ['tp5o']}, 16:35:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:17 INFO - 'talos_options': ['--e10s'], 16:35:17 INFO - 'tests': ['tp5o']}, 16:35:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:17 INFO - 'talos_options': ['--xperf_path', 16:35:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:35:17 INFO - 'tests': ['tp5n']}, 16:35:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:17 INFO - 'talos_options': ['--e10s', 16:35:17 INFO - '--xperf_path', 16:35:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:35:17 INFO - 'tests': ['tp5n']}}, 16:35:17 INFO - 'talos.zip': {'path': '', 16:35:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:35:17 INFO - Running post-action listener: _resource_record_post_action 16:35:17 INFO - ##### 16:35:17 INFO - ##### Running create-virtualenv step. 16:35:17 INFO - ##### 16:35:17 INFO - Running pre-action listener: _resource_record_pre_action 16:35:17 INFO - Running main action method: create_virtualenv 16:35:17 INFO - Creating virtualenv /builds/slave/test/build/venv 16:35:17 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 16:35:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:35:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:35:18 INFO - Using real prefix '/tools/python27' 16:35:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:35:18 INFO - Installing distribute.............................................................................................................................................................................................done. 16:35:21 INFO - Installing pip.................done. 16:35:21 INFO - Return code: 0 16:35:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:35: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')]} 16:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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')]} 16:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c188a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc99a5ab770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02cd30>, '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 0x10be50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023b20>, '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.90GuFF8ptC/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.g5it95sxtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 16:35: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', 'pip>=1.5'] in /builds/slave/test/build 16:35: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 pip>=1.5 16:35:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.90GuFF8ptC/Render', 16:35:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:21 INFO - 'HOME': '/Users/cltbld', 16:35:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:21 INFO - 'LOGNAME': 'cltbld', 16:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:21 INFO - 'MOZ_NO_REMOTE': '1', 16:35:21 INFO - 'NO_EM_RESTART': '1', 16:35:21 INFO - 'PAGER': '/bin/cat', 16:35:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:21 INFO - 'PWD': '/builds/slave/test', 16:35:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:21 INFO - 'SHELL': '/bin/bash', 16:35:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5it95sxtM/Listeners', 16:35:21 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 16:35:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:21 INFO - 'USER': 'cltbld', 16:35:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:21 INFO - 'XPC_FLAGS': '0x0', 16:35:21 INFO - 'XPC_SERVICE_NAME': '0', 16:35:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:21 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 16:35:21 INFO - Cleaning up... 16:35:21 INFO - Return code: 0 16:35:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:35: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')]} 16:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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')]} 16:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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', '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 0x10c188a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc99a5ab770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02cd30>, '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 0x10be50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023b20>, '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.90GuFF8ptC/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.g5it95sxtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 16:35: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', 'psutil>=0.7.1'] in /builds/slave/test/build 16:35: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 psutil>=0.7.1 16:35:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.90GuFF8ptC/Render', 16:35:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:21 INFO - 'HOME': '/Users/cltbld', 16:35:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:21 INFO - 'LOGNAME': 'cltbld', 16:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:21 INFO - 'MOZ_NO_REMOTE': '1', 16:35:21 INFO - 'NO_EM_RESTART': '1', 16:35:21 INFO - 'PAGER': '/bin/cat', 16:35:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:21 INFO - 'PWD': '/builds/slave/test', 16:35:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:21 INFO - 'SHELL': '/bin/bash', 16:35:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5it95sxtM/Listeners', 16:35:21 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 16:35:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:21 INFO - 'USER': 'cltbld', 16:35:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:21 INFO - 'XPC_FLAGS': '0x0', 16:35:21 INFO - 'XPC_SERVICE_NAME': '0', 16:35:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:22 INFO - Downloading/unpacking psutil>=0.7.1 16:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:35:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:35:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:35:25 INFO - Installing collected packages: psutil 16:35:25 INFO - Running setup.py install for psutil 16:35:25 INFO - building 'psutil._psutil_osx' extension 16:35:25 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 16:35:25 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 16:35:25 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 16:35:25 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 16:35:26 INFO - building 'psutil._psutil_posix' extension 16:35:26 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 16:35:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:35:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:35:26 INFO - ^ 16:35:26 INFO - 1 warning generated. 16:35:26 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 16:35:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:35:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:35:26 INFO - Successfully installed psutil 16:35:26 INFO - Cleaning up... 16:35:26 INFO - Return code: 0 16:35:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:35:26 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')]} 16:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:26 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')]} 16:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:26 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 0x10c188a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc99a5ab770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02cd30>, '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 0x10be50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023b20>, '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.90GuFF8ptC/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.g5it95sxtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 16:35:26 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 16:35:26 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 16:35:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.90GuFF8ptC/Render', 16:35:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:26 INFO - 'HOME': '/Users/cltbld', 16:35:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:26 INFO - 'LOGNAME': 'cltbld', 16:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:26 INFO - 'MOZ_NO_REMOTE': '1', 16:35:26 INFO - 'NO_EM_RESTART': '1', 16:35:26 INFO - 'PAGER': '/bin/cat', 16:35:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:26 INFO - 'PWD': '/builds/slave/test', 16:35:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:26 INFO - 'SHELL': '/bin/bash', 16:35:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5it95sxtM/Listeners', 16:35:26 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 16:35:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:26 INFO - 'USER': 'cltbld', 16:35:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:26 INFO - 'XPC_FLAGS': '0x0', 16:35:26 INFO - 'XPC_SERVICE_NAME': '0', 16:35:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:35:26 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 16:35:26 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 16:35:26 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 16:35:26 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 16:35:26 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 16:35:26 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 16:35:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:35:29 INFO - Installing collected packages: mozsystemmonitor 16:35:29 INFO - Running setup.py install for mozsystemmonitor 16:35:29 INFO - Successfully installed mozsystemmonitor 16:35:29 INFO - Cleaning up... 16:35:29 INFO - Return code: 0 16:35:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:29 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 0x10c188a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc99a5ab770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02cd30>, '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 0x10be50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023b20>, '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.90GuFF8ptC/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.g5it95sxtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 16:35:29 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 16:35:29 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 16:35:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.90GuFF8ptC/Render', 16:35:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:29 INFO - 'HOME': '/Users/cltbld', 16:35:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:29 INFO - 'LOGNAME': 'cltbld', 16:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:29 INFO - 'MOZ_NO_REMOTE': '1', 16:35:29 INFO - 'NO_EM_RESTART': '1', 16:35:29 INFO - 'PAGER': '/bin/cat', 16:35:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:29 INFO - 'PWD': '/builds/slave/test', 16:35:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:29 INFO - 'SHELL': '/bin/bash', 16:35:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5it95sxtM/Listeners', 16:35:29 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 16:35:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:29 INFO - 'USER': 'cltbld', 16:35:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:29 INFO - 'XPC_FLAGS': '0x0', 16:35:29 INFO - 'XPC_SERVICE_NAME': '0', 16:35:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:29 INFO - Downloading/unpacking blobuploader==1.2.4 16:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:31 INFO - Downloading blobuploader-1.2.4.tar.gz 16:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:35:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:35:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:33 INFO - Downloading docopt-0.6.1.tar.gz 16:35:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:35:33 INFO - Installing collected packages: blobuploader, requests, docopt 16:35:33 INFO - Running setup.py install for blobuploader 16:35:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:35:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:35:33 INFO - Running setup.py install for requests 16:35:33 INFO - Running setup.py install for docopt 16:35:34 INFO - Successfully installed blobuploader requests docopt 16:35:34 INFO - Cleaning up... 16:35:34 INFO - Return code: 0 16:35:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:34 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 0x10c188a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc99a5ab770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02cd30>, '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 0x10be50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023b20>, '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.90GuFF8ptC/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.g5it95sxtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 16:35:34 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 16:35:34 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 16:35:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.90GuFF8ptC/Render', 16:35:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:34 INFO - 'HOME': '/Users/cltbld', 16:35:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:34 INFO - 'LOGNAME': 'cltbld', 16:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:34 INFO - 'MOZ_NO_REMOTE': '1', 16:35:34 INFO - 'NO_EM_RESTART': '1', 16:35:34 INFO - 'PAGER': '/bin/cat', 16:35:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:34 INFO - 'PWD': '/builds/slave/test', 16:35:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:34 INFO - 'SHELL': '/bin/bash', 16:35:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5it95sxtM/Listeners', 16:35:34 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 16:35:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:34 INFO - 'USER': 'cltbld', 16:35:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:34 INFO - 'XPC_FLAGS': '0x0', 16:35:34 INFO - 'XPC_SERVICE_NAME': '0', 16:35:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:35:34 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-HjOnAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:35:34 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Hfl7pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:35:34 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Yww47q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:35:34 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-FV0NZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:35:34 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-s4qsh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:35:34 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-F4279R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:35:34 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-dhr0Np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:35:35 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-KvgVUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:35:35 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Gh1nl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:35:35 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-fArcPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:35:35 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-lynTl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:35:35 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-ugU772-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:35:35 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-F_Ok7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:35:35 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-pQFTnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:35 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-lAhTDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:35:35 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-d_hTUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:35:36 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-NyjE2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:35:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:35:36 INFO - Running setup.py install for manifestparser 16:35:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:35:36 INFO - Running setup.py install for mozcrash 16:35:36 INFO - Running setup.py install for mozdebug 16:35:36 INFO - Running setup.py install for mozdevice 16:35:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:35:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:35:36 INFO - Running setup.py install for mozfile 16:35:36 INFO - Running setup.py install for mozhttpd 16:35:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:35:37 INFO - Running setup.py install for mozinfo 16:35:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:35:37 INFO - Running setup.py install for mozInstall 16:35:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:35:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:35:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:35:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:35:37 INFO - Running setup.py install for mozleak 16:35:37 INFO - Running setup.py install for mozlog 16:35:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:35:37 INFO - Running setup.py install for moznetwork 16:35:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:35:37 INFO - Running setup.py install for mozprocess 16:35:37 INFO - Running setup.py install for mozprofile 16:35:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:35:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:35:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:35:38 INFO - Running setup.py install for mozrunner 16:35:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:35:38 INFO - Running setup.py install for mozscreenshot 16:35:38 INFO - Running setup.py install for moztest 16:35:38 INFO - Running setup.py install for mozversion 16:35:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:35:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:35:38 INFO - Cleaning up... 16:35:38 INFO - Return code: 0 16:35:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c188a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc99a5ab770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02cd30>, '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 0x10be50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023b20>, '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.90GuFF8ptC/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.g5it95sxtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 16:35:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:35:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.90GuFF8ptC/Render', 16:35:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:38 INFO - 'HOME': '/Users/cltbld', 16:35:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:38 INFO - 'LOGNAME': 'cltbld', 16:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:38 INFO - 'MOZ_NO_REMOTE': '1', 16:35:38 INFO - 'NO_EM_RESTART': '1', 16:35:38 INFO - 'PAGER': '/bin/cat', 16:35:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:38 INFO - 'PWD': '/builds/slave/test', 16:35:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:38 INFO - 'SHELL': '/bin/bash', 16:35:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5it95sxtM/Listeners', 16:35:38 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 16:35:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:38 INFO - 'USER': 'cltbld', 16:35:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:38 INFO - 'XPC_FLAGS': '0x0', 16:35:38 INFO - 'XPC_SERVICE_NAME': '0', 16:35:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:35:38 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-fdGeVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:35:39 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)) 16:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:35:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-YbPgIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:35:39 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)) 16:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:35:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-yJfqK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:35:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-SmDoRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:35:39 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)) 16:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:35:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-m644mH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:35:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-OQubV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:35:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-0ceriC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:35:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-rYKdBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:35:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-JmsdHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:35:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-K38cDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:35:40 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)) 16:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:35:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-9B0NXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:35:40 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)) 16:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:35:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-i9Timd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:35:40 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)) 16:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:35:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-7sMUgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:35:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-gUZMXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:35:40 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)) 16:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-zvFM7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:35:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Ca6Pm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:35:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-eJfDxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:35:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:43 INFO - Downloading blessings-1.6.tar.gz 16:35:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:35:43 INFO - Installing collected packages: blessings 16:35:43 INFO - Running setup.py install for blessings 16:35:43 INFO - Successfully installed blessings 16:35:43 INFO - Cleaning up... 16:35:43 INFO - Return code: 0 16:35:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:35:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:35:43 INFO - Reading from file tmpfile_stdout 16:35:43 INFO - Current package versions: 16:35:43 INFO - blessings == 1.6 16:35:43 INFO - blobuploader == 1.2.4 16:35:43 INFO - docopt == 0.6.1 16:35:43 INFO - manifestparser == 1.1 16:35:43 INFO - mozInstall == 1.12 16:35:43 INFO - mozcrash == 0.17 16:35:43 INFO - mozdebug == 0.1 16:35:43 INFO - mozdevice == 0.48 16:35:43 INFO - mozfile == 1.2 16:35:43 INFO - mozhttpd == 0.7 16:35:43 INFO - mozinfo == 0.9 16:35:43 INFO - mozleak == 0.1 16:35:43 INFO - mozlog == 3.1 16:35:43 INFO - moznetwork == 0.27 16:35:43 INFO - mozprocess == 0.22 16:35:43 INFO - mozprofile == 0.28 16:35:43 INFO - mozrunner == 6.11 16:35:43 INFO - mozscreenshot == 0.1 16:35:43 INFO - mozsystemmonitor == 0.0 16:35:43 INFO - moztest == 0.7 16:35:43 INFO - mozversion == 1.4 16:35:43 INFO - psutil == 3.1.1 16:35:43 INFO - requests == 1.2.3 16:35:43 INFO - wsgiref == 0.1.2 16:35:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c188a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc99a5ab770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02cd30>, '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 0x10be50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023b20>, '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.90GuFF8ptC/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.g5it95sxtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 16:35:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:35:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.90GuFF8ptC/Render', 16:35:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:43 INFO - 'HOME': '/Users/cltbld', 16:35:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:43 INFO - 'LOGNAME': 'cltbld', 16:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:43 INFO - 'MOZ_NO_REMOTE': '1', 16:35:43 INFO - 'NO_EM_RESTART': '1', 16:35:43 INFO - 'PAGER': '/bin/cat', 16:35:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:43 INFO - 'PWD': '/builds/slave/test', 16:35:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:43 INFO - 'SHELL': '/bin/bash', 16:35:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5it95sxtM/Listeners', 16:35:43 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 16:35:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:43 INFO - 'USER': 'cltbld', 16:35:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:43 INFO - 'XPC_FLAGS': '0x0', 16:35:43 INFO - 'XPC_SERVICE_NAME': '0', 16:35:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:43 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)) 16:35:43 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)) 16:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:35:44 INFO - Cleaning up... 16:35:44 INFO - Return code: 0 16:35:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c188a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc99a5ab770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02cd30>, '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 0x10be50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023b20>, '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.90GuFF8ptC/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.g5it95sxtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 16:35:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:35:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:35:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.90GuFF8ptC/Render', 16:35:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:44 INFO - 'HOME': '/Users/cltbld', 16:35:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:44 INFO - 'LOGNAME': 'cltbld', 16:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:44 INFO - 'MOZ_NO_REMOTE': '1', 16:35:44 INFO - 'NO_EM_RESTART': '1', 16:35:44 INFO - 'PAGER': '/bin/cat', 16:35:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:44 INFO - 'PWD': '/builds/slave/test', 16:35:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:44 INFO - 'SHELL': '/bin/bash', 16:35:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5it95sxtM/Listeners', 16:35:44 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 16:35:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:44 INFO - 'USER': 'cltbld', 16:35:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:44 INFO - 'XPC_FLAGS': '0x0', 16:35:44 INFO - 'XPC_SERVICE_NAME': '0', 16:35:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:44 INFO - Downloading/unpacking jsonschema 16:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:35:46 INFO - Downloading/unpacking functools32 (from jsonschema) 16:35:46 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 16:35:46 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 16:35:46 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 16:35:46 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 16:35:46 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 16:35:46 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 16:35:47 INFO - Downloading functools32-3.2.3-2.tar.gz 16:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:35:47 INFO - warning: no files found matching '*.txt' 16:35:47 INFO - no previously-included directories found matching 'build' 16:35:47 INFO - no previously-included directories found matching 'dist' 16:35:47 INFO - no previously-included directories found matching '.git*' 16:35:47 INFO - Installing collected packages: jsonschema, functools32 16:35:47 INFO - Running setup.py install for functools32 16:35:47 INFO - warning: no files found matching '*.txt' 16:35:47 INFO - no previously-included directories found matching 'build' 16:35:47 INFO - no previously-included directories found matching 'dist' 16:35:47 INFO - no previously-included directories found matching '.git*' 16:35:47 INFO - Successfully installed jsonschema functools32 16:35:47 INFO - Cleaning up... 16:35:47 INFO - Return code: 0 16:35:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:35:47 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')]} 16:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:47 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')]} 16:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:47 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 0x10c188a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc99a5ab770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c02cd30>, '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 0x10be50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023b20>, '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.90GuFF8ptC/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.g5it95sxtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 16:35:47 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 16:35:47 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 16:35:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.90GuFF8ptC/Render', 16:35:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:47 INFO - 'HOME': '/Users/cltbld', 16:35:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:47 INFO - 'LOGNAME': 'cltbld', 16:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:47 INFO - 'MOZ_NO_REMOTE': '1', 16:35:47 INFO - 'NO_EM_RESTART': '1', 16:35:47 INFO - 'PAGER': '/bin/cat', 16:35:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:47 INFO - 'PWD': '/builds/slave/test', 16:35:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:47 INFO - 'SHELL': '/bin/bash', 16:35:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5it95sxtM/Listeners', 16:35:47 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 16:35:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:47 INFO - 'USER': 'cltbld', 16:35:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:47 INFO - 'XPC_FLAGS': '0x0', 16:35:47 INFO - 'XPC_SERVICE_NAME': '0', 16:35:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:47 INFO - Downloading/unpacking flake8 16:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:35:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:35:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:35:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:35:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:35:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:35:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:35:51 INFO - no previously-included directories found matching 'docs/_build' 16:35:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:35:51 INFO - Running setup.py install for pep8 16:35:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:35:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:35:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:35:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:35:51 INFO - no previously-included directories found matching 'docs/_build' 16:35:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:35:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:35:51 INFO - Cleaning up... 16:35:51 INFO - Return code: 0 16:35:51 INFO - Running post-action listener: _resource_record_post_action 16:35:51 INFO - Running post-action listener: _start_resource_monitoring 16:35:51 INFO - Starting resource monitoring. 16:35:51 INFO - ##### 16:35:51 INFO - ##### Running install step. 16:35:51 INFO - ##### 16:35:51 INFO - Running pre-action listener: _resource_record_pre_action 16:35:51 INFO - Running main action method: install 16:35:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:35:52 INFO - Reading from file tmpfile_stdout 16:35:52 INFO - Detecting whether we're running mozinstall >=1.0... 16:35:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:35:52 INFO - Reading from file tmpfile_stdout 16:35:52 INFO - Output received: 16:35:52 INFO - Usage: mozinstall [options] installer 16:35:52 INFO - Options: 16:35:52 INFO - -h, --help show this help message and exit 16:35:52 INFO - -d DEST, --destination=DEST 16:35:52 INFO - Directory to install application into. [default: 16:35:52 INFO - "/builds/slave/test"] 16:35:52 INFO - --app=APP Application being installed. [default: firefox] 16:35:52 INFO - mkdir: /builds/slave/test/build/application 16:35:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:36:24 INFO - Reading from file tmpfile_stdout 16:36:24 INFO - Output received: 16:36:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:36:24 INFO - Running post-action listener: _resource_record_post_action 16:36:24 INFO - ##### 16:36:24 INFO - ##### Running run-tests step. 16:36:24 INFO - ##### 16:36:24 INFO - Running pre-action listener: _resource_record_pre_action 16:36:24 INFO - Running main action method: run_tests 16:36:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:36:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:36:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:36:24 INFO - 2016-06-30 16:36:24.027 screenresolution[1642:7720] starting screenresolution argv=screenresolution get 16:36:24 INFO - 2016-06-30 16:36:24.030 screenresolution[1642:7720] Display 0: 1600x1200x32@60 16:36:24 INFO - 2016-06-30 16:36:24.036 screenresolution[1643:7722] starting screenresolution argv=screenresolution list 16:36:24 INFO - Available Modes on Display 0 16:36:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:36:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:36:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:36:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:36:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:36:24 INFO - Intel Iris: 16:36:24 INFO - Chipset Model: Intel Iris 16:36:24 INFO - Type: GPU 16:36:24 INFO - Bus: Built-In 16:36:24 INFO - VRAM (Dynamic, Max): 1536 MB 16:36:24 INFO - Vendor: Intel (0x8086) 16:36:24 INFO - Device ID: 0x0a2e 16:36:24 INFO - Revision ID: 0x0009 16:36:24 INFO - Displays: 16:36:24 INFO - Display: 16:36:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:36:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:36:24 INFO - Display Serial Number: 1600x1200 60 16:36:24 INFO - Main Display: Yes 16:36:24 INFO - Mirror: Off 16:36:24 INFO - Online: Yes 16:36:24 INFO - Rotation: Supported 16:36:24 INFO - Return code: 0 16:36:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:36:24 INFO - Python 2.7.3 16:36:24 INFO - Return code: 0 16:36:24 INFO - grabbing minidump binary from tooltool 16:36: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')]} 16:36:24 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 0x10c02cd30>, '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 0x10be50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c023b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:36:24 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 16:36:24 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 16:36:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:36:24 INFO - Return code: 0 16:36:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:36:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:36:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:36:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:36:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:36:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:36:25 INFO - Return code: 0 16:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--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 16:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0116 --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 16:36:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.90GuFF8ptC/Render', 16:36:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:25 INFO - 'HOME': '/Users/cltbld', 16:36:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:25 INFO - 'LOGNAME': 'cltbld', 16:36:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:36:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:25 INFO - 'MOZ_NO_REMOTE': '1', 16:36:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:36:25 INFO - 'NO_EM_RESTART': '1', 16:36:25 INFO - 'PAGER': '/bin/cat', 16:36:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:25 INFO - 'PWD': '/builds/slave/test', 16:36:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:36:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:25 INFO - 'SHELL': '/bin/bash', 16:36:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5it95sxtM/Listeners', 16:36:25 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 16:36:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:25 INFO - 'USER': 'cltbld', 16:36:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:25 INFO - 'XPC_FLAGS': '0x0', 16:36:25 INFO - 'XPC_SERVICE_NAME': '0', 16:36:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--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 16:36:25 INFO - mozversion application_buildid: 20160630142223 16:36:25 INFO - mozversion application_changeset: 153145e35ec01ceb3d139910bcc70cf421ee4ce8 16:36:25 INFO - mozversion application_display_name: Nightly 16:36:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:36:25 INFO - mozversion application_name: Firefox 16:36:25 INFO - mozversion application_remotingname: firefox 16:36:25 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 16:36:25 INFO - mozversion application_vendor: Mozilla 16:36:25 INFO - mozversion application_version: 47.0.2 16:36:25 INFO - mozversion platform_buildid: 20160630142223 16:36:25 INFO - mozversion platform_changeset: 153145e35ec01ceb3d139910bcc70cf421ee4ce8 16:36:25 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 16:36:25 INFO - mozversion platform_version: 47.0.2 16:36:25 INFO - using testdate: 1467329785 16:36:25 INFO - actual date: 1467329785 16:36:25 INFO - starting webserver on 'localhost:49283' 16:36:25 INFO - SUITE-START | Running 2 tests 16:36:25 INFO - TEST-START | dromaeo_css 16:36:25 INFO - operating with platform_type : mac_ 16:36:25 INFO - Initialising browser for dromaeo_css test... 16:36:25 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmplTzvfJ/profile http://localhost:49283/getInfo.html) 16:36:27 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 16:36:27 INFO - PROCESS | 1661 | colorDepth:24 16:36:27 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 16:36:27 INFO - PROCESS | 1661 | __metrics 16:36:27 INFO - PROCESS | 1661 | 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" 16:36:27 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:36:28 INFO - TEST-INFO | 1661: exit 0 16:36:28 INFO - Browser initialized. 16:36:28 INFO - Running cycle 1/1 for dromaeo_css test... 16:36:28 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmplTzvfJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:36:40 INFO - PROCESS | 1663 | RSS: Main: 184659968 16:36:40 INFO - PROCESS | 1663 | 16:37:31 INFO - PROCESS | 1663 | 1467329851642 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] 16:39:42 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 16:39:43 INFO - PROCESS | 1663 | RSS: Main: 293523456 16:39:43 INFO - PROCESS | 1663 | 16:42:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 16:42:46 INFO - PROCESS | 1663 | RSS: Main: 316104704 16:42:46 INFO - PROCESS | 1663 | 16:45:48 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 16:45:48 INFO - PROCESS | 1663 | RSS: Main: 319709184 16:45:48 INFO - PROCESS | 1663 | 16:48:50 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 16:48:51 INFO - PROCESS | 1663 | RSS: Main: 281161728 16:48:51 INFO - PROCESS | 1663 | 16:51:54 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 16:51:54 INFO - PROCESS | 1663 | RSS: Main: 281763840 16:51:54 INFO - PROCESS | 1663 | 16:54:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 16:54:57 INFO - PROCESS | 1663 | RSS: Main: 326946816 16:54:57 INFO - PROCESS | 1663 | 16:54:57 INFO - PROCESS | 1663 | __start_tp_report 16:54:57 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 16:54:57 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 16:54:57 INFO - PROCESS | 1663 | |i|pagename|runs| 16:54:57 INFO - PROCESS | 1663 | |0;dojo.html;3438.46703760917;3507.351140039093;3523.048776830256;3523.207278362367;3581.373259679557;5687.232223649806;5692.060809966356;5714.857128571788;5714.885702285952;5749.367569567345;5704.3154821421385;5740.454656807597;5754.510866576346;5756.683382413976;5765.5099316558035;5154.6134039946965;5177.663451875635;5204.115300398941;5205.3233079699585;5302.655327403726;5284.07528682479;5304.761285742151;5307.2835167252315;5314.388845282803;5314.7608357624;5206.088934436478;5254.789808407659;5260.289860868791;5284.5772338212855;5289.550388216987;5277.261183434303;5281.70950597717;5292.364916210041;5309.044372013036;5324.8136315228785;5047.64666473347;5209.2446595243855;5242.685438873642;5247.527722504955;5251.133562962106;5521.171824226358;5618.550515958714;5632.633878797906;5634.04221282383;5639.971800141014;6094.268687757453;6134.754609815602;6298.527610429191;6306.905396419057;6307.716152773136;6244.87510249797;6249.250089989185;6275.7489700411925;6317.241930968267;6334.651594162319;5679.4036626154075;5755.827325180251;5819.621724587888;5838.32859221195;5838.474537291664;6215.720292586844;6233.2208473940755;6283.340249273851;6286.402791734869;6303.401176888188;6121.422488707842;6134.6625935573975;6139.045126227552;6145.863015342176;6146.631202127886;6239.625622462667;6246.3441338659695;6260.906086408708;6263.78076767311;6268.623882567061;6107;6132.080187971751;6167.969160154171;6196.907046394308;6200.844978875474;6140.565599444524;6247.875042499125;6272.3100458949475;6310.5898116622275;6316.115743795872;4884.145274576935;4886.193778026586;4895.461499235082;4906.730129842893;4908.460069392364;4325.545817689161;4449.154660614473;4449.866504004885;4478.48497422794;4495.280755079171;5277.656952298088;5541.307336582927;5731.799387021434;5776.480116789509;5783.768649254067;6221.96889015552;6226.221722284715;6231.750729970841;6240.781572644935;6269.7492100316385;5564.10974244119;5565.499105080562;5578.972105139448;5612.438756124355;5634.7182640867795;5303.363596368384;5334.973325133349;5368.785248590091;5384.9461505385225;5405.21624364465;6285.151504546919;6306.810795676137;6307.5584709070845;6309.526785491198;6329.461995730415;6183.938160618516;6224;6306.810795676137;6331.05034244867;6340.1123842661145;6264.373562643699;6313.179286692701;6313.463355614824;6321;6353.491720662243;6160.507159427146;6212.0371342440185;6224.688765561795;6226.40849119333;6251.093591429127;6150.04674275488;6224.253089629274;6298.496120310456;6299.96850015747;6337.397947195009;6107.847303817262;6108.236470441195;6111.602745821508;6126.203593532812;6134.447899689049;5869.119632055226;6037.698115094316;6085.9695701521205;6114.327423983269;6115.205023346936;5881.441263080001;5942.168096466412;5971.820845374646;6060.2424696912885;6094.11635312886;6078.784243151299;6118.755249789959;6126.540509461719;6150.138980542817;6152.692365381802;6012.368701286302;6015.218021657157;6039.396060394101;6043.728032238648;6054.243219597551 16:54:57 INFO - PROCESS | 1663 | |1;ext.html;503.36324549444936;571.7763985071947;595.359988012886;661.6757788683545;666.3702800853195;39428.21143577127;40340.39489407661;40458.99999999996;40525.18949621009;40558.98602534938;43840.561594384126;44414.11171776563;44451.77774111133;44522;44551.55448445515;9459;9765.609375625001;9772.364796288219;9780.657676981307;9792.951035244814;9610.567524461416;9727.221822254238;9737.95131024344;9820.410775353466;9836.70489885301;9807.852882206773;9861.556229969668;9862.654807081753;9873.851892221623;9877.555510002067;9778.853317200248;9871;9874.654387096418;9877.308588398815;9890.554925028355;9617.182539484153;9761.755956101155;9764.90235097647;9774.12032917041;9806.264530160266;42930.78534607338;43106.35340469895;43199.352009719565;43282.350764738556;43290.350644740356;3178.268998130443;3359.6808303211155;3509.6665816747623;3764.3412402829395;3831.961680383188;29795.368336993324;29999.400011999638;30137.547936780968;30322.696773032207;30491.6278767456;2744.4785490756694;2771.9307017324527;2826.0815235048485;2831.2497188245134;2840.5597132444504;436343;437333;437924;440332;443073;71774.64112679508;71866.64066679633;72162.2783772166;72233.91649125268;72429.6378518104;66017.66991165014;74637.25362746412;75345;80539.59730201428;80633.59683201546;18389.89660620367;18566.814331856778;18630.347937822113;18645;18664;14102.576922692335;14167.433302667983;14169.929150354183;14197.503087391891;14205.715885682435;22981.88509057444;23151.652725209136;23270.185543505897;23295.650565241536;23296.883515582653;9036.23192028685;9235.199136168518;9236.261099112055;9242.584083716249;9271.860922086174;997.9720887485901;1006.8187726209206;1027.8612387327764;1090.386228381999;1118.8042092633757;27396.090386840056;28983.275418114717;29112.708872911422;29637.110886673436;29725;1137.4928220108388;1148.7645032768262;1218.0803493362455;1246.3145270101409;1257.861635220125;15407.152606606744;15488.979648968569;15500.224988750517;15829.050256984618;15933.283002264925;644228;646759;648205;648746.7562662251;649406;65029.349706502326;65422.34577654258;65486.34513654802;65496.72516374257;65560;1438.6045535830228;1445.140141615758;1470.7058588282387;1517.833038365779;1549.132485807951;27100.864495677397;29911.401771964003;30164.61985841564;31695.207619809687;31711.52432713465;52217.21674174967;52659.47340526699;52813.94372112613;52817.7359113202;52819.47180528146;388878;391311;391365;391573;392210;29963;34013.65986340105;34445.82777086098;34565.48151777776;35286;42679.78660106679;42794;43377;44018.779906100266;44173.55826441823;28930;36073.458898117075;36387;36714;37183.81408092942;36344;36351.81824090863;36581.08547286339;36779.63220367762;38139.42790858084;36839.63160368362;37674.62325376711;37724.43413348747;38744.6125538741;38771.03072423212;32414.83792581022;33685;33734;33803.66196338005;33805.15487112744;24950.13073496571;25629;26274.343141421617;26364.340891477867;26708.46583068289 16:54:57 INFO - PROCESS | 1663 | |2;jquery.html;382.20501357177073;386.96486897549056;387.46336324191003;394.94075888616703;395.44045176075855;13522.526711565097;16997.689150962204;19683.60632787345;20566.280180193695;21172.25897093604;12070.698232544191;17092.31630734769;17296.82703172971;21080.89459552704;21160.788392116076;5266.262723218752;5381.865453363677;5426.864328391783;5439.918401223985;5442.945570544303;4114.773687447189;5342.439043900393;5416.025115479212;7232.0959880015;7563.357114645261;7360.11678598569;7535.434842386816;7549.35830454412;7552.924470755304;7565.886511702329;7374.483786134972;7528.887066694004;7560.243975602423;7566.319031287183;7592.240775922419;7188.101487314086;7240;7256.419486441072;7257.637118144072;7267.164276108262;28250.576241356397;28265;28532.144035678964;29165.41669166626;29169.687364068668;2466.962995555068;2553.2850801775535;3069.907902762921;3073.3085055862252;3179.459491886385;15746.370145194178;16029.679406411922;16401.42595009169;16542.42101526441;16975.490735277963;1886.3303527247904;1892.1863598652574;1908.2843933524928;1930.671785796418;1975.3086419753115;89063;106064;114553;115114.99999999916;124632;15325.846741532441;18641.161147748382;19562.43500519955;19597.804021959597;19689.310874119335;30278.84860575683;30383.392332153235;30929.381412372077;31003.379932401676;31016.379672406427;10750;11211.775764484828;11219.214654974237;11255.493502792395;11359.261647992855;9551.713448596553;9590;9591.376560523544;9678.419294842332;9695.466749328714;7218.169910460364;7333.779986600304;8679.045305016443;8776.736697899074;8801.647934082564;3418.5897692277085;3476.269983303484;3485.2506711057245;3500.5274287971306;3565.94651080234;883.9955800220957;921.8110287391069;947.772534591693;968.5883499512679;1043.5408420295046;20138.597228055358;20281.188752449736;20573.588528229353;21280.361589152042;21297.148114075262;992.9950350248347;1022.5143057047843;1062.766191437898;1083.4420273559124;1113.9275947063416;10976;11379.487923043484;11389.316641001566;11403.543858245743;11405.600803971822;606744;609812;620421;624991;625689;93515;94565.52717236508;106872.86254274871;115943;120481.39759301147;1049.7008352619619;1075.6880504653718;1089.2266490791626;1092.6940456672303;1093.557109370706;17928.462146135636;18049.639007220045;18100.45698629043;18141.45575632733;18968.715469267696;47049.2942605868;47713.52286477091;47718.568442946766;48324.69982333726;48894;74548.2545174563;75368.62315688387;76930;77086;77153;8027.759167224993;8227.83544329122;8258.752237432887;8260.669573217005;8391.07698153215;9672.371295865747;13323.86676133265;13360.331983400596;13461.461541538229;13998.44006239739;11420.543178272776;11516.251443656136;11690;11807.23252988553;11898.643040708792;11427.428628568705;11463.541458341573;11489.712757180803;11636.76726465449;11878.287302761517;11694.30432587253;11725.648230553097;11762.70593235176;12033.398330083635;12155.57455489089;6164.815055548341;7581.6209189541405;8167.714130005421;8349;8461.646136618112;11240.55037798479;11360.579927509061;11707.239029463057;11833.585824496102;12084.39578021113 16:54:57 INFO - PROCESS | 1663 | |3;mootools.html;1612.8064632244132;1631.94288199913;1962.254343349527;2022.3023057045332;2059.9897000515007;7469.365103966169;8940.284777217823;9154.176124148826;9160.450372977626;9167.174954254124;8063.516189028648;8233.505989640626;8707.869381959275;8872.245859101984;8932.866007009883;2536.8731563421848;2568.6147077938367;2570.2417786752953;2574.17626359565;2577.5875859862426;2236.4967882226533;2504.64934909112;2571.897124115033;2578.1749840051193;2578.40696639773;2260.220224022718;2517.093846215361;2570.7943364530793;2572.1126211457017;2573.4081161332906;2473.084958565333;2480.8139389545854;2532.6580911576884;2542.2881593153948;2542.758437948401;2498.962515562268;2500.6499090127395;2535.1000394859743;2538.365408647838;2540.809439292042;8818.250448711868;8941.552922353856;8947.373683842134;8948.955255223747;8977.6857809977;5499.697516636584;5655.208270842086;5682.886342273173;5693.658380497142;5701.2018317435595;3626.9455276597073;3656.3966945453967;3662.047867554428;3672.320620685155;3676.2060833766263;1033.994830025845;1054.288355360129;1054.773223756896;1073.9301945373525;1090.9781804363947;12092.879071209263;12264;12277.20198187124;12289.938550307192;12320.260784352968;4993.375828021497;5023.698578085254;5094.872628184325;5135.922961155586;5137.743112844418;10515.57937682484;10521.316114452537;10544.683659490227;10556.894431055745;10560.313579617301;5655.208270842086;5663.433656634304;5666.03677374839;5668.57485688575;5673.546116310686;4933.4819843915875;5098.158803797406;5100.566451851634;5107.387113546324;5107.821226257063;3952.664023557972;3973.145773658677;3977.54258260298;3994.3009973254566;4013.9764360087993;1275.6938334799768;1308.2019967819622;1308.3196737696535;1319.4260496683974;1336.038052602125;1056.7886422715487;1162.6105254739757;1217.6164508179895;1384.3977869626544;1457.9125252484885;8152.062512810984;8260.586970651444;8336.83326333482;8515.829683406297;8572.957135214285;1061.5488417422564;1264.6585421936027;1272.6818295426144;1280.6158152554196;1290.387066143593;6408.551401401857;6411.5832470889245;6485.4163125318;6492.09110724499;6508.023796430479;10470;10848.891511084947;10926.781464370668;10949.233553651167;10967.725806854733;10484;10706;10759.892401076046;10788.838167427495;11017;6880.415164710956;8589.742307730778;8647.827043459221;8656.004559475616;8658.307335413152;8172.7956801080445;8220.177982201732;8226.30076443509;8345.624446899783;8410.495370277802;9439.669611563562;9601.615935362508;9750.024997500193;9776.706698799047;9962.85427175884;9783.657571985232;10019.649312274036;10152.984701530084;10268.383896966207;10270.435126068138;8468.237858592509;8513.446625969293;8541.402101852811;8639.82720345577;8641.308695304486;8528.232459078712;8562.229399353839;8620.224179823846;8623.827523449621;8624.827503450022;7606.353459955966;7779.7666070017995;7780.942387448204;7860.174681658344;7872.409569282441;7304.196538380667;7445.7766267012075;7457.701691932479;7582.128055273714;7648.73229436967;8052.235037671412;8080.919190808252;8104.716334928249;8114.391420643594;8140.063892652184;6929.514933954776;6958.895616565655;6986.266442023514;7006.439484841302;7007.509474336747;7437.628118594157;7455.142658594114;7498;7507.249275072449;7514.323710866049 16:54:57 INFO - PROCESS | 1663 | |4;prototype.html;325.5101072885307;343.19178335021024;346.6100636783618;346.85952189363314;351.55879371388903;6671.532992690513;6673.165854268216;6687.9331206687975;6718.563293385939;6743.460523158148;6663.400293973554;6708.966455167717;6710.295418980998;6712.899306510394;6714.764983225588;4744.644151688637;4856.955754512779;4861.61107111432;4870.805167793284;5012.8496145115705;4832.830850920219;4872.975635121819;4941.2094064949615;4944.060628480595;4978.303037574742;4874.780634871421;4902.485239049902;4905;4912.508749125094;4924.2121260598315;4714.4106986626675;4913.705177689332;4945.579625731835;4970.5526502614575;4979.925301120486;4151.169766046773;4246.832121166673;4252.170826688797;4259.51015633203;4261.87214383569;6357.268914074894;6379.649119298437;6385.393387628168;6411.3588641135975;6425.550211485198;5922.615030023035;5930.258717660293;5937.821865344046;5937.851553711149;5944.316403613597;7151.284871512859;7160.28397160285;7160.391366733782;7161.140663120407;7182.317679820461;4499;4665.486796452387;4805.471398146201;4806.116330201886;4819.397575303087;7462.776116716507;7501.737439189602;7546.132194797614;7549.131849837284;7594.126675432341;4729.929051064168;4737.028909073701;4740.549647783455;4747.121782470254;4751.809927602926;4817.686850354716;4821.831235906797;4829.420469543677;4841.176999910023;4851.830185943475;5720.370759216483;5737.254156959569;5743.195952566644;5746.051901436216;5762.222100016528;6909.723611055602;7162.068931039036;7176.605286709177;7182;7183.712651493986;1643.761654560106;1651.347717651521;1666.6666666666472;1670.4404024651878;1674.773905522739;1047.261680515235;1056.6724315462232;1071.844582535528;1075.0271004740723;1079.96220132295;6370.77702280418;6519.4132528072705;6532.804015879531;6632.535722499379;6691.531592788556;6095.268567771807;6116.327204007555;7476.70093196277;7486.513376630502;7511.774646760606;6643.169603799525;6651.16860392451;6655.500837437212;6656.7670131545165;6686.297938716462;3213.967860321414;3889;3928.705347098979;3938.4879965604287;3942.4677668514382;7499.8500029999095;7768.028996375453;7790.727324543614;7832.530048197126;7833.412494062968;7689.38484921205;7741.419393545507;7744.6514906829325;7744.8451030980195;7758.185390533913;7759.068911730628;7764.3788496920115;7771.961140194263;7782.416318776114;7798.1811909749795;7194;7465.104187497535;7479.214682458263;7483.738069167553;7492.363149132385;7327.670254838652;7364.631768411451;7374.705011799468;7382.815429614303;7392.112946446461;6813.250542440229;7240.203577606354;7655.655495502827;7708.190639982721;7720.112187098331;4749.121412538691;4753.5008824072975;4759.977414341849;4762.119007983396;4764.213904705684;5967.6419414835245;6299.559030867796;7105.6447177639875;7381.630918454163;7392.741254056083;6855.245922948372;7219.494635375473;7220.061392019214;7228.20489746138;7244.492885498175;7123.928760712534;7182.102237220348;7189.532680375759;7191.676374563052;7208.819779505554;7013.719451221894;7016.859662806817;7029.121359830021;7030.648467576499;7038.577685338896;6954.513184077268;7177.964110179624;7191.856162876608;7195.964020179866;7202.135743710788;6758.763443279461;6951.548149370275;7003.719851206099;7043;7055.400290975119 16:54:57 INFO - PROCESS | 1663 | |5;yui.html;763.7365109037383;776.8990031295931;782.413190107419;788.8580055589994;799.3844739550547;15100.320485578148;15125.848741512582;15378.384864605403;15382.384704611815;15387.153706546149;14674.559763207095;14759.852401475982;14778.778318325207;14804.481843135492;14820;794.9880751788728;807.6002378822461;974.2157563161652;974.9025097490247;1007.6926537406089;975.873136492255;981.7643765496265;983.503330817936;985.2955137076989;988.0909563201872;1028.8971102889725;1033.3283365812208;1035.171862509989;1038.2005855491268;1040.630576145469;843.4896887383106;1012.8227560176939;1018.2617602238317;1028.5011769291887;1031.5254982707963;751.5115175136206;755.2938002967243;759.0549765541881;761.2121454294834;768.561919705768;15198;15271.770923436157;15288.847111528854;15323.31045102973;15358.539243822592;12520.436580353906;12535.934445572137;12780.360981950866;12828.422720977485;12912.935435322857;9760.17038551724;9878.90121098787;9960.402375857471;10114.797704045877;10159.796804063877;3471.375152472554;3487.616362200156;3511.4381698928305;3553.680168784822;3701.6298370163036;76584.61707691426;76996.84504732433;79545;79623.20376796216;79783.8032429514;9191.586378612978;9284;9302;9312.953435232916;9322.673706420243;18282.360117395827;21876;22294.331170064925;22382.776172238395;22382.888085559793;6377.936220637735;7500.474966752275;7512.286332798375;7583.355414789694;7782.143964163937;4074.4559505486473;4086.1010577672864;4101.630853223224;4212.49450065994;4406.339049142654;3654.104744337654;3687.612800655946;3691.6123807000417;3691.760035597731;3699.038250055005;568.3804652928328;640.3372509452694;661.153723234261;662.5031226580065;684.9657517124124;516.5170565521249;581.9912701309484;595.5860676829649;611.7614130489113;617.4751461257895;6339.904901426482;8056.879146812803;8059.314958228499;8339.248757760817;8645.956770216235;598.1506261109236;607.2500461929513;613.6379536073649;616.2758758458882;624.6689254694928;3689.409694448929;3827.942580861289;3867.651911327994;3949.54580223278;3950.48643676326;97359;98599;100426.49786751019;101167;101305;81957.18042819496;82116;82322.64902781301;83719.2326345316;84807.5759621198;72656;73030.2696973034;73866.63066684525;74859.5028099435;75353.6232318835;6552.934470655423;7565.130010048915;7667.46327757074;7762.456628035983;7765.650545725569;47788;47925;48404.03191936212;49041;51432.71418214575;63937.680311598146;67564.6621766888;74888.25111748812;74919;76288.61855690686;9942.950285248528;10072.949635251776;10251.538680759235;10292.742681433025;10314.948425257826;8760.561971901507;10979.725506862393;11043;11304.547818087512;11454.08367330595;10557.260991730505;10710.73223169427;10961.616343427942;10991.39547324873;11471.197016208785;11120.332780033224;11297.378644174649;11454.427278636202;11614.593489227836;11758.176927614984;10846.67459976202;11160.720981975515;11169.218154729091;11304.434778261219;11561.122939050287;9366.531673416439;9564;9564.13922746956;9678.564464598969;10019.048190421898;9507.762305942406;9565.808683826424;9605.751138163527;9624.566894489624;9859.704208873745 16:54:57 INFO - PROCESS | 1663 | __end_tp_report 16:54:57 INFO - PROCESS | 1663 | __start_cc_report 16:54:57 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,985 16:54:57 INFO - PROCESS | 1663 | __end_cc_report 16:54:57 INFO - PROCESS | 1663 | __startTimestamp1467330897426__endTimestamp 16:54:57 INFO - PROCESS | 1663 | 16:54:57 INFO - PROCESS | 1663 | ------- Summary: start ------- 16:54:57 INFO - PROCESS | 1663 | Number of tests: 6 16:54:57 INFO - PROCESS | 1663 | 16:54:57 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5759.31 Median:6039.40 stddev:623.13 (10.3%) stddev-sans-first:597.85 16:54:57 INFO - PROCESS | 1663 | Values: 3438.5 3507.4 3523.0 3523.2 3581.4 5687.2 5692.1 5714.9 5714.9 5749.4 5704.3 5740.5 5754.5 5756.7 5765.5 5154.6 5177.7 5204.1 5205.3 5302.7 5284.1 5304.8 5307.3 5314.4 5314.8 5206.1 5254.8 5260.3 5284.6 5289.6 5277.3 5281.7 5292.4 5309.0 5324.8 5047.6 5209.2 5242.7 5247.5 5251.1 5521.2 5618.6 5632.6 5634.0 5640.0 6094.3 6134.8 6298.5 6306.9 6307.7 6244.9 6249.3 6275.7 6317.2 6334.7 5679.4 5755.8 5819.6 5838.3 5838.5 6215.7 6233.2 6283.3 6286.4 6303.4 6121.4 6134.7 6139.0 6145.9 6146.6 6239.6 6246.3 6260.9 6263.8 6268.6 6107.0 6132.1 6168.0 6196.9 6200.8 6140.6 6247.9 6272.3 6310.6 6316.1 4884.1 4886.2 4895.5 4906.7 4908.5 4325.5 4449.2 4449.9 4478.5 4495.3 5277.7 5541.3 5731.8 5776.5 5783.8 6222.0 6226.2 6231.8 6240.8 6269.7 5564.1 5565.5 5579.0 5612.4 5634.7 5303.4 5335.0 5368.8 5384.9 5405.2 6285.2 6306.8 6307.6 6309.5 6329.5 6183.9 6224.0 6306.8 6331.1 6340.1 6264.4 6313.2 6313.5 6321.0 6353.5 6160.5 6212.0 6224.7 6226.4 6251.1 6150.0 6224.3 6298.5 6300.0 6337.4 6107.8 6108.2 6111.6 6126.2 6134.4 5869.1 6037.7 6086.0 6114.3 6115.2 5881.4 5942.2 5971.8 6060.2 6094.1 6078.8 6118.8 6126.5 6150.1 6152.7 6012.4 6015.2 6039.4 6043.7 6054.2 16:54:57 INFO - PROCESS | 1663 | 16:54:57 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:65191.71 Median:391338.00 stddev:134614.51 (34.4%) stddev-sans-first:134904.52 16:54:57 INFO - PROCESS | 1663 | Values: 503.4 571.8 595.4 661.7 666.4 39428.2 40340.4 40459.0 40525.2 40559.0 43840.6 44414.1 44451.8 44522.0 44551.6 9459.0 9765.6 9772.4 9780.7 9793.0 9610.6 9727.2 9738.0 9820.4 9836.7 9807.9 9861.6 9862.7 9873.9 9877.6 9778.9 9871.0 9874.7 9877.3 9890.6 9617.2 9761.8 9764.9 9774.1 9806.3 42930.8 43106.4 43199.4 43282.4 43290.4 3178.3 3359.7 3509.7 3764.3 3832.0 29795.4 29999.4 30137.5 30322.7 30491.6 2744.5 2771.9 2826.1 2831.2 2840.6 436343.0 437333.0 437924.0 440332.0 443073.0 71774.6 71866.6 72162.3 72233.9 72429.6 66017.7 74637.3 75345.0 80539.6 80633.6 18389.9 18566.8 18630.3 18645.0 18664.0 14102.6 14167.4 14169.9 14197.5 14205.7 22981.9 23151.7 23270.2 23295.7 23296.9 9036.2 9235.2 9236.3 9242.6 9271.9 998.0 1006.8 1027.9 1090.4 1118.8 27396.1 28983.3 29112.7 29637.1 29725.0 1137.5 1148.8 1218.1 1246.3 1257.9 15407.2 15489.0 15500.2 15829.1 15933.3 644228.0 646759.0 648205.0 648746.8 649406.0 65029.3 65422.3 65486.3 65496.7 65560.0 1438.6 1445.1 1470.7 1517.8 1549.1 27100.9 29911.4 30164.6 31695.2 31711.5 52217.2 52659.5 52813.9 52817.7 52819.5 388878.0 391311.0 391365.0 391573.0 392210.0 29963.0 34013.7 34445.8 34565.5 35286.0 42679.8 42794.0 43377.0 44018.8 44173.6 28930.0 36073.5 36387.0 36714.0 37183.8 36344.0 36351.8 36581.1 36779.6 38139.4 36839.6 37674.6 37724.4 38744.6 38771.0 32414.8 33685.0 33734.0 33803.7 33805.2 24950.1 25629.0 26274.3 26364.3 26708.5 16:54:57 INFO - PROCESS | 1663 | 16:54:57 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:35787.50 Median:28848.78 stddev:101986.79 (353.5%) stddev-sans-first:102238.24 16:54:57 INFO - PROCESS | 1663 | Values: 382.2 387.0 387.5 394.9 395.4 13522.5 16997.7 19683.6 20566.3 21172.3 12070.7 17092.3 17296.8 21080.9 21160.8 5266.3 5381.9 5426.9 5439.9 5442.9 4114.8 5342.4 5416.0 7232.1 7563.4 7360.1 7535.4 7549.4 7552.9 7565.9 7374.5 7528.9 7560.2 7566.3 7592.2 7188.1 7240.0 7256.4 7257.6 7267.2 28250.6 28265.0 28532.1 29165.4 29169.7 2467.0 2553.3 3069.9 3073.3 3179.5 15746.4 16029.7 16401.4 16542.4 16975.5 1886.3 1892.2 1908.3 1930.7 1975.3 89063.0 106064.0 114553.0 115115.0 124632.0 15325.8 18641.2 19562.4 19597.8 19689.3 30278.8 30383.4 30929.4 31003.4 31016.4 10750.0 11211.8 11219.2 11255.5 11359.3 9551.7 9590.0 9591.4 9678.4 9695.5 7218.2 7333.8 8679.0 8776.7 8801.6 3418.6 3476.3 3485.3 3500.5 3565.9 884.0 921.8 947.8 968.6 1043.5 20138.6 20281.2 20573.6 21280.4 21297.1 993.0 1022.5 1062.8 1083.4 1113.9 10976.0 11379.5 11389.3 11403.5 11405.6 606744.0 609812.0 620421.0 624991.0 625689.0 93515.0 94565.5 106872.9 115943.0 120481.4 1049.7 1075.7 1089.2 1092.7 1093.6 17928.5 18049.6 18100.5 18141.5 18968.7 47049.3 47713.5 47718.6 48324.7 48894.0 74548.3 75368.6 76930.0 77086.0 77153.0 8027.8 8227.8 8258.8 8260.7 8391.1 9672.4 13323.9 13360.3 13461.5 13998.4 11420.5 11516.3 11690.0 11807.2 11898.6 11427.4 11463.5 11489.7 11636.8 11878.3 11694.3 11725.6 11762.7 12033.4 12155.6 6164.8 7581.6 8167.7 8349.0 8461.6 11240.6 11360.6 11707.2 11833.6 12084.4 16:54:57 INFO - PROCESS | 1663 | 16:54:57 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6256.32 Median:5107.60 stddev:3263.47 (63.9%) stddev-sans-first:3253.96 16:54:57 INFO - PROCESS | 1663 | Values: 1612.8 1631.9 1962.3 2022.3 2060.0 7469.4 8940.3 9154.2 9160.5 9167.2 8063.5 8233.5 8707.9 8872.2 8932.9 2536.9 2568.6 2570.2 2574.2 2577.6 2236.5 2504.6 2571.9 2578.2 2578.4 2260.2 2517.1 2570.8 2572.1 2573.4 2473.1 2480.8 2532.7 2542.3 2542.8 2499.0 2500.6 2535.1 2538.4 2540.8 8818.3 8941.6 8947.4 8949.0 8977.7 5499.7 5655.2 5682.9 5693.7 5701.2 3626.9 3656.4 3662.0 3672.3 3676.2 1034.0 1054.3 1054.8 1073.9 1091.0 12092.9 12264.0 12277.2 12289.9 12320.3 4993.4 5023.7 5094.9 5135.9 5137.7 10515.6 10521.3 10544.7 10556.9 10560.3 5655.2 5663.4 5666.0 5668.6 5673.5 4933.5 5098.2 5100.6 5107.4 5107.8 3952.7 3973.1 3977.5 3994.3 4014.0 1275.7 1308.2 1308.3 1319.4 1336.0 1056.8 1162.6 1217.6 1384.4 1457.9 8152.1 8260.6 8336.8 8515.8 8573.0 1061.5 1264.7 1272.7 1280.6 1290.4 6408.6 6411.6 6485.4 6492.1 6508.0 10470.0 10848.9 10926.8 10949.2 10967.7 10484.0 10706.0 10759.9 10788.8 11017.0 6880.4 8589.7 8647.8 8656.0 8658.3 8172.8 8220.2 8226.3 8345.6 8410.5 9439.7 9601.6 9750.0 9776.7 9962.9 9783.7 10019.6 10153.0 10268.4 10270.4 8468.2 8513.4 8541.4 8639.8 8641.3 8528.2 8562.2 8620.2 8623.8 8624.8 7606.4 7779.8 7780.9 7860.2 7872.4 7304.2 7445.8 7457.7 7582.1 7648.7 8052.2 8080.9 8104.7 8114.4 8140.1 6929.5 6958.9 6986.3 7006.4 7007.5 7437.6 7455.1 7498.0 7507.2 7514.3 16:54:57 INFO - PROCESS | 1663 | 16:54:57 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5859.17 Median:6656.13 stddev:1862.99 (28.0%) stddev-sans-first:1821.33 16:54:57 INFO - PROCESS | 1663 | Values: 325.5 343.2 346.6 346.9 351.6 6671.5 6673.2 6687.9 6718.6 6743.5 6663.4 6709.0 6710.3 6712.9 6714.8 4744.6 4857.0 4861.6 4870.8 5012.8 4832.8 4873.0 4941.2 4944.1 4978.3 4874.8 4902.5 4905.0 4912.5 4924.2 4714.4 4913.7 4945.6 4970.6 4979.9 4151.2 4246.8 4252.2 4259.5 4261.9 6357.3 6379.6 6385.4 6411.4 6425.6 5922.6 5930.3 5937.8 5937.9 5944.3 7151.3 7160.3 7160.4 7161.1 7182.3 4499.0 4665.5 4805.5 4806.1 4819.4 7462.8 7501.7 7546.1 7549.1 7594.1 4729.9 4737.0 4740.5 4747.1 4751.8 4817.7 4821.8 4829.4 4841.2 4851.8 5720.4 5737.3 5743.2 5746.1 5762.2 6909.7 7162.1 7176.6 7182.0 7183.7 1643.8 1651.3 1666.7 1670.4 1674.8 1047.3 1056.7 1071.8 1075.0 1080.0 6370.8 6519.4 6532.8 6632.5 6691.5 6095.3 6116.3 7476.7 7486.5 7511.8 6643.2 6651.2 6655.5 6656.8 6686.3 3214.0 3889.0 3928.7 3938.5 3942.5 7499.9 7768.0 7790.7 7832.5 7833.4 7689.4 7741.4 7744.7 7744.8 7758.2 7759.1 7764.4 7772.0 7782.4 7798.2 7194.0 7465.1 7479.2 7483.7 7492.4 7327.7 7364.6 7374.7 7382.8 7392.1 6813.3 7240.2 7655.7 7708.2 7720.1 4749.1 4753.5 4760.0 4762.1 4764.2 5967.6 6299.6 7105.6 7381.6 7392.7 6855.2 7219.5 7220.1 7228.2 7244.5 7123.9 7182.1 7189.5 7191.7 7208.8 7013.7 7016.9 7029.1 7030.6 7038.6 6954.5 7178.0 7191.9 7196.0 7202.1 6758.8 6951.5 7003.7 7043.0 7055.4 16:54:57 INFO - PROCESS | 1663 | 16:54:57 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18705.97 Median:575.19 stddev:26913.18 (4679.0%) stddev-sans-first:26954.96 16:54:57 INFO - PROCESS | 1663 | Values: 763.7 776.9 782.4 788.9 799.4 15100.3 15125.8 15378.4 15382.4 15387.2 14674.6 14759.9 14778.8 14804.5 14820.0 795.0 807.6 974.2 974.9 1007.7 975.9 981.8 983.5 985.3 988.1 1028.9 1033.3 1035.2 1038.2 1040.6 843.5 1012.8 1018.3 1028.5 1031.5 751.5 755.3 759.1 761.2 768.6 15198.0 15271.8 15288.8 15323.3 15358.5 12520.4 12535.9 12780.4 12828.4 12912.9 9760.2 9878.9 9960.4 10114.8 10159.8 3471.4 3487.6 3511.4 3553.7 3701.6 76584.6 76996.8 79545.0 79623.2 79783.8 9191.6 9284.0 9302.0 9313.0 9322.7 18282.4 21876.0 22294.3 22382.8 22382.9 6377.9 7500.5 7512.3 7583.4 7782.1 4074.5 4086.1 4101.6 4212.5 4406.3 3654.1 3687.6 3691.6 3691.8 3699.0 568.4 640.3 661.2 662.5 685.0 516.5 582.0 595.6 611.8 617.5 6339.9 8056.9 8059.3 8339.2 8646.0 598.2 607.3 613.6 616.3 624.7 3689.4 3827.9 3867.7 3949.5 3950.5 97359.0 98599.0 100426.5 101167.0 101305.0 81957.2 82116.0 82322.6 83719.2 84807.6 72656.0 73030.3 73866.6 74859.5 75353.6 6552.9 7565.1 7667.5 7762.5 7765.7 47788.0 47925.0 48404.0 49041.0 51432.7 63937.7 67564.7 74888.3 74919.0 76288.6 9943.0 10072.9 10251.5 10292.7 10314.9 8760.6 10979.7 11043.0 11304.5 11454.1 10557.3 10710.7 10961.6 10991.4 11471.2 11120.3 11297.4 11454.4 11614.6 11758.2 10846.7 11160.7 11169.2 11304.4 11561.1 9366.5 9564.0 9564.1 9678.6 10019.0 9507.8 9565.8 9605.8 9624.6 9859.7 16:54:57 INFO - PROCESS | 1663 | -------- Summary: end -------- 16:54:57 INFO - PROCESS | 1663 | 16:54:57 INFO - TEST-INFO | 1663: exit 0 16:54:57 INFO - TEST-OK | dromaeo_css | took 1112099ms 16:54:57 INFO - TEST-START | kraken 16:54:57 INFO - operating with platform_type : mac_ 16:54:57 INFO - Initialising browser for kraken test... 16:54:57 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpLB0qHB/profile http://localhost:49283/getInfo.html) 16:54:59 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 16:54:59 INFO - PROCESS | 1672 | colorDepth:24 16:54:59 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 16:54:59 INFO - PROCESS | 1672 | __metrics 16:54:59 INFO - PROCESS | 1672 | 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" 16:54:59 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:55:00 INFO - TEST-INFO | 1672: exit 0 16:55:00 INFO - Browser initialized. 16:55:00 INFO - Running cycle 1/1 for kraken test... 16:55:00 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpLB0qHB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:12 INFO - PROCESS | 1674 | RSS: Main: 184913920 16:55:12 INFO - PROCESS | 1674 | 16:55:14 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection) 16:55:15 INFO - PROCESS | 1674 | RSS: Main: 246079488 16:55:15 INFO - PROCESS | 1674 | 16:55:18 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-dft) 16:55:18 INFO - PROCESS | 1674 | RSS: Main: 256868352 16:55:18 INFO - PROCESS | 1674 | 16:55:21 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-fft) 16:55:22 INFO - PROCESS | 1674 | RSS: Main: 246333440 16:55:22 INFO - PROCESS | 1674 | 16:55:24 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator) 16:55:24 INFO - PROCESS | 1674 | RSS: Main: 247132160 16:55:24 INFO - PROCESS | 1674 | 16:55:27 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:55:27 INFO - PROCESS | 1674 | RSS: Main: 246808576 16:55:27 INFO - PROCESS | 1674 | 16:55:30 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom) 16:55:31 INFO - PROCESS | 1674 | RSS: Main: 248332288 16:55:31 INFO - PROCESS | 1674 | 16:55:33 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate) 16:55:34 INFO - PROCESS | 1674 | RSS: Main: 248328192 16:55:34 INFO - PROCESS | 1674 | 16:55:37 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial) 16:55:37 INFO - PROCESS | 1674 | RSS: Main: 248573952 16:55:37 INFO - PROCESS | 1674 | 16:55:39 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:55:39 INFO - PROCESS | 1674 | RSS: Main: 283500544 16:55:39 INFO - PROCESS | 1674 | 16:55:41 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:55:42 INFO - PROCESS | 1674 | RSS: Main: 284540928 16:55:42 INFO - PROCESS | 1674 | 16:55:44 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:55:44 INFO - PROCESS | 1674 | RSS: Main: 289140736 16:55:44 INFO - PROCESS | 1674 | 16:55:47 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:55:47 INFO - PROCESS | 1674 | RSS: Main: 291602432 16:55:47 INFO - PROCESS | 1674 | 16:55:50 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:55:50 INFO - PROCESS | 1674 | RSS: Main: 291700736 16:55:50 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49283/tests/kraken/driver.html?testName=ai-astar) 16:55:52 INFO - PROCESS | 1674 | RSS: Main: 354508800 16:55:52 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | __start_tp_report 16:55:52 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 16:55:52 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 16:55:52 INFO - PROCESS | 1674 | |i|pagename|runs| 16:55:52 INFO - PROCESS | 1674 | |0;ai-astar;111;112;110;111;114;111;131;110;110;109 16:55:52 INFO - PROCESS | 1674 | |1;audio-beat-detection;155;141;185;167;116;145;109;167;141;123 16:55:52 INFO - PROCESS | 1674 | |2;audio-dft;184;184;187;186;186;187;184;184;185;185 16:55:52 INFO - PROCESS | 1674 | |3;audio-fft;71;81;72;116;56;56;59;58;116;55 16:55:52 INFO - PROCESS | 1674 | |4;audio-oscillator;89;93;129;78;81;80;120;79;92;159 16:55:52 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;86;84;87;82;85;84;87;83;86;83 16:55:52 INFO - PROCESS | 1674 | |6;imaging-darkroom;91;92;93;95;92;91;92;92;92;92 16:55:52 INFO - PROCESS | 1674 | |7;imaging-desaturate;84;87;87;86;86;85;85;86;86;90 16:55:52 INFO - PROCESS | 1674 | |8;json-parse-financial;56;58;58;58;56;57;58;57;69;54 16:55:52 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;59;63;70;62;76;71;66;64;65;66 16:55:52 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;80;80;79;80;80;79;80;83;80;85 16:55:52 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;129;127;110;133;127;126;125;105;126;131 16:55:52 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;131;124;132;133;133;121;135;126;124;130 16:55:52 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;65;65;65;65;66;66;65;68;66;65 16:55:52 INFO - PROCESS | 1674 | __end_tp_report 16:55:52 INFO - PROCESS | 1674 | __start_cc_report 16:55:52 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1203 16:55:52 INFO - PROCESS | 1674 | __end_cc_report 16:55:52 INFO - PROCESS | 1674 | __startTimestamp1467330952866__endTimestamp 16:55:52 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | ------- Summary: start ------- 16:55:52 INFO - PROCESS | 1674 | Number of tests: 14 16:55:52 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:112.90 Median:111.00 stddev:6.51 (5.9%) stddev-sans-first:6.86 16:55:52 INFO - PROCESS | 1674 | Values: 111.0 112.0 110.0 111.0 114.0 111.0 131.0 110.0 110.0 109.0 16:55:52 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:150.00 stddev:24.31 (16.2%) stddev-sans-first:25.51 16:55:52 INFO - PROCESS | 1674 | Values: 155.0 141.0 185.0 167.0 116.0 145.0 109.0 167.0 141.0 123.0 16:55:52 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:185.20 Median:185.50 stddev:1.23 (0.7%) stddev-sans-first:1.22 16:55:52 INFO - PROCESS | 1674 | Values: 184.0 184.0 187.0 186.0 186.0 187.0 184.0 184.0 185.0 185.0 16:55:52 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:74.00 Median:58.50 stddev:23.76 (40.6%) stddev-sans-first:25.17 16:55:52 INFO - PROCESS | 1674 | Values: 71.0 81.0 72.0 116.0 56.0 56.0 59.0 58.0 116.0 55.0 16:55:52 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:100.00 Median:80.50 stddev:27.17 (33.7%) stddev-sans-first:28.52 16:55:52 INFO - PROCESS | 1674 | Values: 89.0 93.0 129.0 78.0 81.0 80.0 120.0 79.0 92.0 159.0 16:55:52 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:84.70 Median:85.50 stddev:1.77 (2.1%) stddev-sans-first:1.81 16:55:52 INFO - PROCESS | 1674 | Values: 86.0 84.0 87.0 82.0 85.0 84.0 87.0 83.0 86.0 83.0 16:55:52 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:92.20 Median:92.00 stddev:1.14 (1.2%) stddev-sans-first:1.12 16:55:52 INFO - PROCESS | 1674 | Values: 91.0 92.0 93.0 95.0 92.0 91.0 92.0 92.0 92.0 92.0 16:55:52 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.00 stddev:1.62 (1.9%) stddev-sans-first:1.51 16:55:52 INFO - PROCESS | 1674 | Values: 84.0 87.0 87.0 86.0 86.0 85.0 85.0 86.0 86.0 90.0 16:55:52 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:4.04 (7.0%) stddev-sans-first:4.21 16:55:52 INFO - PROCESS | 1674 | Values: 56.0 58.0 58.0 58.0 56.0 57.0 58.0 57.0 69.0 54.0 16:55:52 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:4.94 (7.5%) stddev-sans-first:4.50 16:55:52 INFO - PROCESS | 1674 | Values: 59.0 63.0 70.0 62.0 76.0 71.0 66.0 64.0 65.0 66.0 16:55:52 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:1.90 (2.4%) stddev-sans-first:2.00 16:55:52 INFO - PROCESS | 1674 | Values: 80.0 80.0 79.0 80.0 80.0 79.0 80.0 83.0 80.0 85.0 16:55:52 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:127.00 stddev:9.06 (7.1%) stddev-sans-first:9.42 16:55:52 INFO - PROCESS | 1674 | Values: 129.0 127.0 110.0 133.0 127.0 126.0 125.0 105.0 126.0 131.0 16:55:52 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:128.90 Median:131.50 stddev:4.77 (3.6%) stddev-sans-first:5.00 16:55:52 INFO - PROCESS | 1674 | Values: 131.0 124.0 132.0 133.0 133.0 121.0 135.0 126.0 124.0 130.0 16:55:52 INFO - PROCESS | 1674 | 16:55:52 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:0.97 (1.5%) stddev-sans-first:1.00 16:55:52 INFO - PROCESS | 1674 | Values: 65.0 65.0 65.0 65.0 66.0 66.0 65.0 68.0 66.0 65.0 16:55:52 INFO - PROCESS | 1674 | -------- Summary: end -------- 16:55:52 INFO - PROCESS | 1674 | 16:55:53 INFO - TEST-INFO | 1674: exit 0 16:55:53 INFO - TEST-OK | kraken | took 55577ms 16:55:53 INFO - SUITE-END | took 1167s 16:55:53 INFO - Completed test suite (00:19:27) 16:55:53 INFO - javascript benchmark 16:55:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3438.46703760917, 3507.351140039093, 3523.048776830256, 3523.207278362367, 3581.373259679557, 5687.232223649806, 5692.060809966356, 5714.857128571788, 5714.885702285952, 5749.367569567345, 5704.3154821421385, 5740.454656807597, 5754.510866576346, 5756.683382413976, 5765.5099316558035, 5154.6134039946965, 5177.663451875635, 5204.115300398941, 5205.3233079699585, 5302.655327403726, 5284.07528682479, 5304.761285742151, 5307.2835167252315, 5314.388845282803, 5314.7608357624, 5206.088934436478, 5254.789808407659, 5260.289860868791, 5284.5772338212855, 5289.550388216987, 5277.261183434303, 5281.70950597717, 5292.364916210041, 5309.044372013036, 5324.8136315228785, 5047.64666473347, 5209.2446595243855, 5242.685438873642, 5247.527722504955, 5251.133562962106, 5521.171824226358, 5618.550515958714, 5632.633878797906, 5634.04221282383, 5639.971800141014, 6094.268687757453, 6134.754609815602, 6298.527610429191, 6306.905396419057, 6307.716152773136, 6244.87510249797, 6249.250089989185, 6275.7489700411925, 6317.241930968267, 6334.651594162319, 5679.4036626154075, 5755.827325180251, 5819.621724587888, 5838.32859221195, 5838.474537291664, 6215.720292586844, 6233.2208473940755, 6283.340249273851, 6286.402791734869, 6303.401176888188, 6121.422488707842, 6134.6625935573975, 6139.045126227552, 6145.863015342176, 6146.631202127886, 6239.625622462667, 6246.3441338659695, 6260.906086408708, 6263.78076767311, 6268.623882567061, 6107.0, 6132.080187971751, 6167.969160154171, 6196.907046394308, 6200.844978875474, 6140.565599444524, 6247.875042499125, 6272.3100458949475, 6310.5898116622275, 6316.115743795872, 4884.145274576935, 4886.193778026586, 4895.461499235082, 4906.730129842893, 4908.460069392364, 4325.545817689161, 4449.154660614473, 4449.866504004885, 4478.48497422794, 4495.280755079171, 5277.656952298088, 5541.307336582927, 5731.799387021434, 5776.480116789509, 5783.768649254067, 6221.96889015552, 6226.221722284715, 6231.750729970841, 6240.781572644935, 6269.7492100316385, 5564.10974244119, 5565.499105080562, 5578.972105139448, 5612.438756124355, 5634.7182640867795, 5303.363596368384, 5334.973325133349, 5368.785248590091, 5384.9461505385225, 5405.21624364465, 6285.151504546919, 6306.810795676137, 6307.5584709070845, 6309.526785491198, 6329.461995730415, 6183.938160618516, 6224.0, 6306.810795676137, 6331.05034244867, 6340.1123842661145, 6264.373562643699, 6313.179286692701, 6313.463355614824, 6321.0, 6353.491720662243, 6160.507159427146, 6212.0371342440185, 6224.688765561795, 6226.40849119333, 6251.093591429127, 6150.04674275488, 6224.253089629274, 6298.496120310456, 6299.96850015747, 6337.397947195009, 6107.847303817262, 6108.236470441195, 6111.602745821508, 6126.203593532812, 6134.447899689049, 5869.119632055226, 6037.698115094316, 6085.9695701521205, 6114.327423983269, 6115.205023346936, 5881.441263080001, 5942.168096466412, 5971.820845374646, 6060.2424696912885, 6094.11635312886, 6078.784243151299, 6118.755249789959, 6126.540509461719, 6150.138980542817, 6152.692365381802, 6012.368701286302, 6015.218021657157, 6039.396060394101, 6043.728032238648, 6054.243219597551], "unit": "score", "name": "dojo.html", "value": 5720.479269095053}, {"lowerIsBetter": false, "replicates": [503.36324549444936, 571.7763985071947, 595.359988012886, 661.6757788683545, 666.3702800853195, 39428.21143577127, 40340.39489407661, 40458.99999999996, 40525.18949621009, 40558.98602534938, 43840.561594384126, 44414.11171776563, 44451.77774111133, 44522.0, 44551.55448445515, 9459.0, 9765.609375625001, 9772.364796288219, 9780.657676981307, 9792.951035244814, 9610.567524461416, 9727.221822254238, 9737.95131024344, 9820.410775353466, 9836.70489885301, 9807.852882206773, 9861.556229969668, 9862.654807081753, 9873.851892221623, 9877.555510002067, 9778.853317200248, 9871.0, 9874.654387096418, 9877.308588398815, 9890.554925028355, 9617.182539484153, 9761.755956101155, 9764.90235097647, 9774.12032917041, 9806.264530160266, 42930.78534607338, 43106.35340469895, 43199.352009719565, 43282.350764738556, 43290.350644740356, 3178.268998130443, 3359.6808303211155, 3509.6665816747623, 3764.3412402829395, 3831.961680383188, 29795.368336993324, 29999.400011999638, 30137.547936780968, 30322.696773032207, 30491.6278767456, 2744.4785490756694, 2771.9307017324527, 2826.0815235048485, 2831.2497188245134, 2840.5597132444504, 436343.0, 437333.0, 437924.0, 440332.0, 443073.0, 71774.64112679508, 71866.64066679633, 72162.2783772166, 72233.91649125268, 72429.6378518104, 66017.66991165014, 74637.25362746412, 75345.0, 80539.59730201428, 80633.59683201546, 18389.89660620367, 18566.814331856778, 18630.347937822113, 18645.0, 18664.0, 14102.576922692335, 14167.433302667983, 14169.929150354183, 14197.503087391891, 14205.715885682435, 22981.88509057444, 23151.652725209136, 23270.185543505897, 23295.650565241536, 23296.883515582653, 9036.23192028685, 9235.199136168518, 9236.261099112055, 9242.584083716249, 9271.860922086174, 997.9720887485901, 1006.8187726209206, 1027.8612387327764, 1090.386228381999, 1118.8042092633757, 27396.090386840056, 28983.275418114717, 29112.708872911422, 29637.110886673436, 29725.0, 1137.4928220108388, 1148.7645032768262, 1218.0803493362455, 1246.3145270101409, 1257.861635220125, 15407.152606606744, 15488.979648968569, 15500.224988750517, 15829.050256984618, 15933.283002264925, 644228.0, 646759.0, 648205.0, 648746.7562662251, 649406.0, 65029.349706502326, 65422.34577654258, 65486.34513654802, 65496.72516374257, 65560.0, 1438.6045535830228, 1445.140141615758, 1470.7058588282387, 1517.833038365779, 1549.132485807951, 27100.864495677397, 29911.401771964003, 30164.61985841564, 31695.207619809687, 31711.52432713465, 52217.21674174967, 52659.47340526699, 52813.94372112613, 52817.7359113202, 52819.47180528146, 388878.0, 391311.0, 391365.0, 391573.0, 392210.0, 29963.0, 34013.65986340105, 34445.82777086098, 34565.48151777776, 35286.0, 42679.78660106679, 42794.0, 43377.0, 44018.779906100266, 44173.55826441823, 28930.0, 36073.458898117075, 36387.0, 36714.0, 37183.81408092942, 36344.0, 36351.81824090863, 36581.08547286339, 36779.63220367762, 38139.42790858084, 36839.63160368362, 37674.62325376711, 37724.43413348747, 38744.6125538741, 38771.03072423212, 32414.83792581022, 33685.0, 33734.0, 33803.66196338005, 33805.15487112744, 24950.13073496571, 25629.0, 26274.343141421617, 26364.340891477867, 26708.46583068289], "unit": "score", "name": "ext.html", "value": 20684.648435853785}, {"lowerIsBetter": false, "replicates": [382.20501357177073, 386.96486897549056, 387.46336324191003, 394.94075888616703, 395.44045176075855, 13522.526711565097, 16997.689150962204, 19683.60632787345, 20566.280180193695, 21172.25897093604, 12070.698232544191, 17092.31630734769, 17296.82703172971, 21080.89459552704, 21160.788392116076, 5266.262723218752, 5381.865453363677, 5426.864328391783, 5439.918401223985, 5442.945570544303, 4114.773687447189, 5342.439043900393, 5416.025115479212, 7232.0959880015, 7563.357114645261, 7360.11678598569, 7535.434842386816, 7549.35830454412, 7552.924470755304, 7565.886511702329, 7374.483786134972, 7528.887066694004, 7560.243975602423, 7566.319031287183, 7592.240775922419, 7188.101487314086, 7240.0, 7256.419486441072, 7257.637118144072, 7267.164276108262, 28250.576241356397, 28265.0, 28532.144035678964, 29165.41669166626, 29169.687364068668, 2466.962995555068, 2553.2850801775535, 3069.907902762921, 3073.3085055862252, 3179.459491886385, 15746.370145194178, 16029.679406411922, 16401.42595009169, 16542.42101526441, 16975.490735277963, 1886.3303527247904, 1892.1863598652574, 1908.2843933524928, 1930.671785796418, 1975.3086419753115, 89063.0, 106064.0, 114553.0, 115114.99999999916, 124632.0, 15325.846741532441, 18641.161147748382, 19562.43500519955, 19597.804021959597, 19689.310874119335, 30278.84860575683, 30383.392332153235, 30929.381412372077, 31003.379932401676, 31016.379672406427, 10750.0, 11211.775764484828, 11219.214654974237, 11255.493502792395, 11359.261647992855, 9551.713448596553, 9590.0, 9591.376560523544, 9678.419294842332, 9695.466749328714, 7218.169910460364, 7333.779986600304, 8679.045305016443, 8776.736697899074, 8801.647934082564, 3418.5897692277085, 3476.269983303484, 3485.2506711057245, 3500.5274287971306, 3565.94651080234, 883.9955800220957, 921.8110287391069, 947.772534591693, 968.5883499512679, 1043.5408420295046, 20138.597228055358, 20281.188752449736, 20573.588528229353, 21280.361589152042, 21297.148114075262, 992.9950350248347, 1022.5143057047843, 1062.766191437898, 1083.4420273559124, 1113.9275947063416, 10976.0, 11379.487923043484, 11389.316641001566, 11403.543858245743, 11405.600803971822, 606744.0, 609812.0, 620421.0, 624991.0, 625689.0, 93515.0, 94565.52717236508, 106872.86254274871, 115943.0, 120481.39759301147, 1049.7008352619619, 1075.6880504653718, 1089.2266490791626, 1092.6940456672303, 1093.557109370706, 17928.462146135636, 18049.639007220045, 18100.45698629043, 18141.45575632733, 18968.715469267696, 47049.2942605868, 47713.52286477091, 47718.568442946766, 48324.69982333726, 48894.0, 74548.2545174563, 75368.62315688387, 76930.0, 77086.0, 77153.0, 8027.759167224993, 8227.83544329122, 8258.752237432887, 8260.669573217005, 8391.07698153215, 9672.371295865747, 13323.86676133265, 13360.331983400596, 13461.461541538229, 13998.44006239739, 11420.543178272776, 11516.251443656136, 11690.0, 11807.23252988553, 11898.643040708792, 11427.428628568705, 11463.541458341573, 11489.712757180803, 11636.76726465449, 11878.287302761517, 11694.30432587253, 11725.648230553097, 11762.70593235176, 12033.398330083635, 12155.57455489089, 6164.815055548341, 7581.6209189541405, 8167.714130005421, 8349.0, 8461.646136618112, 11240.55037798479, 11360.579927509061, 11707.239029463057, 11833.585824496102, 12084.39578021113], "unit": "score", "name": "jquery.html", "value": 10760.385403983206}, {"lowerIsBetter": false, "replicates": [1612.8064632244132, 1631.94288199913, 1962.254343349527, 2022.3023057045332, 2059.9897000515007, 7469.365103966169, 8940.284777217823, 9154.176124148826, 9160.450372977626, 9167.174954254124, 8063.516189028648, 8233.505989640626, 8707.869381959275, 8872.245859101984, 8932.866007009883, 2536.8731563421848, 2568.6147077938367, 2570.2417786752953, 2574.17626359565, 2577.5875859862426, 2236.4967882226533, 2504.64934909112, 2571.897124115033, 2578.1749840051193, 2578.40696639773, 2260.220224022718, 2517.093846215361, 2570.7943364530793, 2572.1126211457017, 2573.4081161332906, 2473.084958565333, 2480.8139389545854, 2532.6580911576884, 2542.2881593153948, 2542.758437948401, 2498.962515562268, 2500.6499090127395, 2535.1000394859743, 2538.365408647838, 2540.809439292042, 8818.250448711868, 8941.552922353856, 8947.373683842134, 8948.955255223747, 8977.6857809977, 5499.697516636584, 5655.208270842086, 5682.886342273173, 5693.658380497142, 5701.2018317435595, 3626.9455276597073, 3656.3966945453967, 3662.047867554428, 3672.320620685155, 3676.2060833766263, 1033.994830025845, 1054.288355360129, 1054.773223756896, 1073.9301945373525, 1090.9781804363947, 12092.879071209263, 12264.0, 12277.20198187124, 12289.938550307192, 12320.260784352968, 4993.375828021497, 5023.698578085254, 5094.872628184325, 5135.922961155586, 5137.743112844418, 10515.57937682484, 10521.316114452537, 10544.683659490227, 10556.894431055745, 10560.313579617301, 5655.208270842086, 5663.433656634304, 5666.03677374839, 5668.57485688575, 5673.546116310686, 4933.4819843915875, 5098.158803797406, 5100.566451851634, 5107.387113546324, 5107.821226257063, 3952.664023557972, 3973.145773658677, 3977.54258260298, 3994.3009973254566, 4013.9764360087993, 1275.6938334799768, 1308.2019967819622, 1308.3196737696535, 1319.4260496683974, 1336.038052602125, 1056.7886422715487, 1162.6105254739757, 1217.6164508179895, 1384.3977869626544, 1457.9125252484885, 8152.062512810984, 8260.586970651444, 8336.83326333482, 8515.829683406297, 8572.957135214285, 1061.5488417422564, 1264.6585421936027, 1272.6818295426144, 1280.6158152554196, 1290.387066143593, 6408.551401401857, 6411.5832470889245, 6485.4163125318, 6492.09110724499, 6508.023796430479, 10470.0, 10848.891511084947, 10926.781464370668, 10949.233553651167, 10967.725806854733, 10484.0, 10706.0, 10759.892401076046, 10788.838167427495, 11017.0, 6880.415164710956, 8589.742307730778, 8647.827043459221, 8656.004559475616, 8658.307335413152, 8172.7956801080445, 8220.177982201732, 8226.30076443509, 8345.624446899783, 8410.495370277802, 9439.669611563562, 9601.615935362508, 9750.024997500193, 9776.706698799047, 9962.85427175884, 9783.657571985232, 10019.649312274036, 10152.984701530084, 10268.383896966207, 10270.435126068138, 8468.237858592509, 8513.446625969293, 8541.402101852811, 8639.82720345577, 8641.308695304486, 8528.232459078712, 8562.229399353839, 8620.224179823846, 8623.827523449621, 8624.827503450022, 7606.353459955966, 7779.7666070017995, 7780.942387448204, 7860.174681658344, 7872.409569282441, 7304.196538380667, 7445.7766267012075, 7457.701691932479, 7582.128055273714, 7648.73229436967, 8052.235037671412, 8080.919190808252, 8104.716334928249, 8114.391420643594, 8140.063892652184, 6929.514933954776, 6958.895616565655, 6986.266442023514, 7006.439484841302, 7007.509474336747, 7437.628118594157, 7455.142658594114, 7498.0, 7507.249275072449, 7514.323710866049], "unit": "score", "name": "mootools.html", "value": 5112.491053009338}, {"lowerIsBetter": false, "replicates": [325.5101072885307, 343.19178335021024, 346.6100636783618, 346.85952189363314, 351.55879371388903, 6671.532992690513, 6673.165854268216, 6687.9331206687975, 6718.563293385939, 6743.460523158148, 6663.400293973554, 6708.966455167717, 6710.295418980998, 6712.899306510394, 6714.764983225588, 4744.644151688637, 4856.955754512779, 4861.61107111432, 4870.805167793284, 5012.8496145115705, 4832.830850920219, 4872.975635121819, 4941.2094064949615, 4944.060628480595, 4978.303037574742, 4874.780634871421, 4902.485239049902, 4905.0, 4912.508749125094, 4924.2121260598315, 4714.4106986626675, 4913.705177689332, 4945.579625731835, 4970.5526502614575, 4979.925301120486, 4151.169766046773, 4246.832121166673, 4252.170826688797, 4259.51015633203, 4261.87214383569, 6357.268914074894, 6379.649119298437, 6385.393387628168, 6411.3588641135975, 6425.550211485198, 5922.615030023035, 5930.258717660293, 5937.821865344046, 5937.851553711149, 5944.316403613597, 7151.284871512859, 7160.28397160285, 7160.391366733782, 7161.140663120407, 7182.317679820461, 4499.0, 4665.486796452387, 4805.471398146201, 4806.116330201886, 4819.397575303087, 7462.776116716507, 7501.737439189602, 7546.132194797614, 7549.131849837284, 7594.126675432341, 4729.929051064168, 4737.028909073701, 4740.549647783455, 4747.121782470254, 4751.809927602926, 4817.686850354716, 4821.831235906797, 4829.420469543677, 4841.176999910023, 4851.830185943475, 5720.370759216483, 5737.254156959569, 5743.195952566644, 5746.051901436216, 5762.222100016528, 6909.723611055602, 7162.068931039036, 7176.605286709177, 7182.0, 7183.712651493986, 1643.761654560106, 1651.347717651521, 1666.6666666666472, 1670.4404024651878, 1674.773905522739, 1047.261680515235, 1056.6724315462232, 1071.844582535528, 1075.0271004740723, 1079.96220132295, 6370.77702280418, 6519.4132528072705, 6532.804015879531, 6632.535722499379, 6691.531592788556, 6095.268567771807, 6116.327204007555, 7476.70093196277, 7486.513376630502, 7511.774646760606, 6643.169603799525, 6651.16860392451, 6655.500837437212, 6656.7670131545165, 6686.297938716462, 3213.967860321414, 3889.0, 3928.705347098979, 3938.4879965604287, 3942.4677668514382, 7499.8500029999095, 7768.028996375453, 7790.727324543614, 7832.530048197126, 7833.412494062968, 7689.38484921205, 7741.419393545507, 7744.6514906829325, 7744.8451030980195, 7758.185390533913, 7759.068911730628, 7764.3788496920115, 7771.961140194263, 7782.416318776114, 7798.1811909749795, 7194.0, 7465.104187497535, 7479.214682458263, 7483.738069167553, 7492.363149132385, 7327.670254838652, 7364.631768411451, 7374.705011799468, 7382.815429614303, 7392.112946446461, 6813.250542440229, 7240.203577606354, 7655.655495502827, 7708.190639982721, 7720.112187098331, 4749.121412538691, 4753.5008824072975, 4759.977414341849, 4762.119007983396, 4764.213904705684, 5967.6419414835245, 6299.559030867796, 7105.6447177639875, 7381.630918454163, 7392.741254056083, 6855.245922948372, 7219.494635375473, 7220.061392019214, 7228.20489746138, 7244.492885498175, 7123.928760712534, 7182.102237220348, 7189.532680375759, 7191.676374563052, 7208.819779505554, 7013.719451221894, 7016.859662806817, 7029.121359830021, 7030.648467576499, 7038.577685338896, 6954.513184077268, 7177.964110179624, 7191.856162876608, 7195.964020179866, 7202.135743710788, 6758.763443279461, 6951.548149370275, 7003.719851206099, 7043.0, 7055.400290975119], "unit": "score", "name": "prototype.html", "value": 5235.1994898587855}, {"lowerIsBetter": false, "replicates": [763.7365109037383, 776.8990031295931, 782.413190107419, 788.8580055589994, 799.3844739550547, 15100.320485578148, 15125.848741512582, 15378.384864605403, 15382.384704611815, 15387.153706546149, 14674.559763207095, 14759.852401475982, 14778.778318325207, 14804.481843135492, 14820.0, 794.9880751788728, 807.6002378822461, 974.2157563161652, 974.9025097490247, 1007.6926537406089, 975.873136492255, 981.7643765496265, 983.503330817936, 985.2955137076989, 988.0909563201872, 1028.8971102889725, 1033.3283365812208, 1035.171862509989, 1038.2005855491268, 1040.630576145469, 843.4896887383106, 1012.8227560176939, 1018.2617602238317, 1028.5011769291887, 1031.5254982707963, 751.5115175136206, 755.2938002967243, 759.0549765541881, 761.2121454294834, 768.561919705768, 15198.0, 15271.770923436157, 15288.847111528854, 15323.31045102973, 15358.539243822592, 12520.436580353906, 12535.934445572137, 12780.360981950866, 12828.422720977485, 12912.935435322857, 9760.17038551724, 9878.90121098787, 9960.402375857471, 10114.797704045877, 10159.796804063877, 3471.375152472554, 3487.616362200156, 3511.4381698928305, 3553.680168784822, 3701.6298370163036, 76584.61707691426, 76996.84504732433, 79545.0, 79623.20376796216, 79783.8032429514, 9191.586378612978, 9284.0, 9302.0, 9312.953435232916, 9322.673706420243, 18282.360117395827, 21876.0, 22294.331170064925, 22382.776172238395, 22382.888085559793, 6377.936220637735, 7500.474966752275, 7512.286332798375, 7583.355414789694, 7782.143964163937, 4074.4559505486473, 4086.1010577672864, 4101.630853223224, 4212.49450065994, 4406.339049142654, 3654.104744337654, 3687.612800655946, 3691.6123807000417, 3691.760035597731, 3699.038250055005, 568.3804652928328, 640.3372509452694, 661.153723234261, 662.5031226580065, 684.9657517124124, 516.5170565521249, 581.9912701309484, 595.5860676829649, 611.7614130489113, 617.4751461257895, 6339.904901426482, 8056.879146812803, 8059.314958228499, 8339.248757760817, 8645.956770216235, 598.1506261109236, 607.2500461929513, 613.6379536073649, 616.2758758458882, 624.6689254694928, 3689.409694448929, 3827.942580861289, 3867.651911327994, 3949.54580223278, 3950.48643676326, 97359.0, 98599.0, 100426.49786751019, 101167.0, 101305.0, 81957.18042819496, 82116.0, 82322.64902781301, 83719.2326345316, 84807.5759621198, 72656.0, 73030.2696973034, 73866.63066684525, 74859.5028099435, 75353.6232318835, 6552.934470655423, 7565.130010048915, 7667.46327757074, 7762.456628035983, 7765.650545725569, 47788.0, 47925.0, 48404.03191936212, 49041.0, 51432.71418214575, 63937.680311598146, 67564.6621766888, 74888.25111748812, 74919.0, 76288.61855690686, 9942.950285248528, 10072.949635251776, 10251.538680759235, 10292.742681433025, 10314.948425257826, 8760.561971901507, 10979.725506862393, 11043.0, 11304.547818087512, 11454.08367330595, 10557.260991730505, 10710.73223169427, 10961.616343427942, 10991.39547324873, 11471.197016208785, 11120.332780033224, 11297.378644174649, 11454.427278636202, 11614.593489227836, 11758.176927614984, 10846.67459976202, 11160.720981975515, 11169.218154729091, 11304.434778261219, 11561.122939050287, 9366.531673416439, 9564.0, 9564.13922746956, 9678.564464598969, 10019.048190421898, 9507.762305942406, 9565.808683826424, 9605.751138163527, 9624.566894489624, 9859.704208873745], "unit": "score", "name": "yui.html", "value": 6980.009548970191}], "name": "dromaeo_css", "value": 7871.5651188221145}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 110.0, 111.0, 114.0, 111.0, 131.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [155.0, 141.0, 185.0, 167.0, 116.0, 145.0, 109.0, 167.0, 141.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 144.9}, {"lowerIsBetter": true, "replicates": [184.0, 184.0, 187.0, 186.0, 186.0, 187.0, 184.0, 184.0, 185.0, 185.0], "unit": "score", "name": "audio-dft", "value": 185.2}, {"lowerIsBetter": true, "replicates": [71.0, 81.0, 72.0, 116.0, 56.0, 56.0, 59.0, 58.0, 116.0, 55.0], "unit": "score", "name": "audio-fft", "value": 74.0}, {"lowerIsBetter": true, "replicates": [89.0, 93.0, 129.0, 78.0, 81.0, 80.0, 120.0, 79.0, 92.0, 159.0], "unit": "score", "name": "audio-oscillator", "value": 100.0}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 87.0, 82.0, 85.0, 84.0, 87.0, 83.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 84.7}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 93.0, 95.0, 92.0, 91.0, 92.0, 92.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.2}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 87.0, 86.0, 86.0, 85.0, 85.0, 86.0, 86.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 86.2}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 58.0, 58.0, 56.0, 57.0, 58.0, 57.0, 69.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [59.0, 63.0, 70.0, 62.0, 76.0, 71.0, 66.0, 64.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.2}, {"lowerIsBetter": true, "replicates": [80.0, 80.0, 79.0, 80.0, 80.0, 79.0, 80.0, 83.0, 80.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.6}, {"lowerIsBetter": true, "replicates": [129.0, 127.0, 110.0, 133.0, 127.0, 126.0, 125.0, 105.0, 126.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.9}, {"lowerIsBetter": true, "replicates": [131.0, 124.0, 132.0, 133.0, 133.0, 121.0, 135.0, 126.0, 124.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 128.9}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 68.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1403.4000000000003}]} 16:55:53 INFO - Return code: 0 16:55:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:55:53 INFO - # TBPL SUCCESS # 16:55:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:55:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:55:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:55:53 INFO - 2016-06-30 16:55:53.654 screenresolution[1678:10145] starting screenresolution argv=screenresolution get 16:55:53 INFO - 2016-06-30 16:55:53.657 screenresolution[1678:10145] Display 0: 1600x1200x32@60 16:55:53 INFO - 2016-06-30 16:55:53.663 screenresolution[1679:10148] starting screenresolution argv=screenresolution list 16:55:53 INFO - Available Modes on Display 0 16:55:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:55:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:55:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:55:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:55:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:55:53 INFO - Intel Iris: 16:55:53 INFO - Chipset Model: Intel Iris 16:55:53 INFO - Type: GPU 16:55:53 INFO - Bus: Built-In 16:55:53 INFO - VRAM (Dynamic, Max): 1536 MB 16:55:53 INFO - Vendor: Intel (0x8086) 16:55:53 INFO - Device ID: 0x0a2e 16:55:53 INFO - Revision ID: 0x0009 16:55:53 INFO - Displays: 16:55:53 INFO - Display: 16:55:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:55:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:55:53 INFO - Display Serial Number: 1600x1200 60 16:55:53 INFO - Main Display: Yes 16:55:53 INFO - Mirror: Off 16:55:53 INFO - Online: Yes 16:55:53 INFO - Rotation: Supported 16:55:53 INFO - Return code: 0 16:55:53 INFO - Running post-action listener: _resource_record_post_action 16:55:53 INFO - Running post-run listener: _resource_record_post_run 16:55:54 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 38053376; Write bytes: 662842880; Read time: 395; Write time: 1801 16:55:54 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 361693696; Write bytes: 362694656; Read time: 28198; Write time: 690 16:55:54 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 36230656; Write bytes: 298776064; Read time: 374; Write time: 1109 16:55:54 INFO - Running post-run listener: _upload_blobber_files 16:55:54 INFO - Blob upload gear active. 16:55:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:55:54 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 16:55:54 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:55:54 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:55:55 INFO - (blobuploader) - INFO - Open directory for files ... 16:55:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:55:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:55:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:56 INFO - (blobuploader) - INFO - Done attempting. 16:55:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:55:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:55:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:57 INFO - (blobuploader) - INFO - Done attempting. 16:55:57 INFO - (blobuploader) - INFO - Iteration through files over. 16:55:57 INFO - Return code: 0 16:55:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:55:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:55:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b0c33acb6a58159c52b43a7670f9ccb8a074169c52efa90179614bf6232be6e03fc21e65265be0068ecced076615d01f85af656416539b9f489472e2662f7996", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/902e4ebe6a5c8d1dffd0b5bbe8e1dd8552b6ec2c51c71ea5c20d859cd3cb82dda8963ad2ada4ea2d7e8bd0530d75c7dcc8acc74a29c362ef9d5b4a49ad281280"} 16:55:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:55:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:55:57 INFO - Contents: 16:55:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b0c33acb6a58159c52b43a7670f9ccb8a074169c52efa90179614bf6232be6e03fc21e65265be0068ecced076615d01f85af656416539b9f489472e2662f7996", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/902e4ebe6a5c8d1dffd0b5bbe8e1dd8552b6ec2c51c71ea5c20d859cd3cb82dda8963ad2ada4ea2d7e8bd0530d75c7dcc8acc74a29c362ef9d5b4a49ad281280"} 16:55:57 INFO - Running post-run listener: copy_logs_to_upload_dir 16:55:57 INFO - Copying logs to upload dir... 16:55:57 INFO - mkdir: /builds/slave/test/build/upload/logs 16:55:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.640640 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-30 16:55:57.250751) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 16:55:57.254046) ========= 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.90GuFF8ptC/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.g5it95sxtM/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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/Larch/sha512/b0c33acb6a58159c52b43a7670f9ccb8a074169c52efa90179614bf6232be6e03fc21e65265be0068ecced076615d01f85af656416539b9f489472e2662f7996", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/902e4ebe6a5c8d1dffd0b5bbe8e1dd8552b6ec2c51c71ea5c20d859cd3cb82dda8963ad2ada4ea2d7e8bd0530d75c7dcc8acc74a29c362ef9d5b4a49ad281280"} build_url:https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011124 build_url: 'https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b0c33acb6a58159c52b43a7670f9ccb8a074169c52efa90179614bf6232be6e03fc21e65265be0068ecced076615d01f85af656416539b9f489472e2662f7996", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/902e4ebe6a5c8d1dffd0b5bbe8e1dd8552b6ec2c51c71ea5c20d859cd3cb82dda8963ad2ada4ea2d7e8bd0530d75c7dcc8acc74a29c362ef9d5b4a49ad281280"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 16:55:57.289525) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:55:57.289879) ========= 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.90GuFF8ptC/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.g5it95sxtM/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.005056 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:55:57.338416) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 16:55:57.338746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 16:55:57.339068) ========= ========= Total master_lag: 0.17 =========