builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0114 starttime: 1461615739.62 results: success (0) buildid: 20160425113506 builduid: 1445a4f8deb94df187e81eff5838680b revision: 14952428292c90aa00c28fdfb1f1e79bd8257ce2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:19.616071) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:19.616507) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:19.616777) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:19.638453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:19.638746) ========= 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.cPvtyivwEb/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.vNLxHyw02A/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-25 13:22:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.29M=0.002s 2016-04-25 13:22:19 (7.29 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092126 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:19.747561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:19.747887) ========= 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.cPvtyivwEb/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.vNLxHyw02A/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.019699 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:19.801413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-25 13:22:19.801756) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 14952428292c90aa00c28fdfb1f1e79bd8257ce2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 14952428292c90aa00c28fdfb1f1e79bd8257ce2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cPvtyivwEb/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.vNLxHyw02A/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-25 13:22:19,837 truncating revision to first 12 chars 2016-04-25 13:22:19,837 Setting DEBUG logging. 2016-04-25 13:22:19,837 attempt 1/10 2016-04-25 13:22:19,837 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/14952428292c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 13:22:21,704 unpacking tar archive at: fx-team-14952428292c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.112291 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-25 13:22:21.934255) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:21.934574) ========= script_repo_revision: 14952428292c90aa00c28fdfb1f1e79bd8257ce2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:21.934968) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:21.938146) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 13:22:21.958663) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-25 13:22:21.959036) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cPvtyivwEb/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.vNLxHyw02A/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 13:22:22 INFO - MultiFileLogger online at 20160425 13:22:22 in /builds/slave/test 13:22:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:22:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:22:22 INFO - {'append_to_log': False, 13:22:22 INFO - 'base_work_dir': '/builds/slave/test', 13:22:22 INFO - 'blob_upload_branch': 'Fx-Team', 13:22:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:22:22 INFO - 'branch': 'Fx-Team', 13:22:22 INFO - 'buildbot_json_path': 'buildprops.json', 13:22:22 INFO - 'config_files': ('talos/mac_config.py',), 13:22:22 INFO - 'default_actions': ('clobber', 13:22:22 INFO - 'read-buildbot-config', 13:22:22 INFO - 'download-and-extract', 13:22:22 INFO - 'populate-webroot', 13:22:22 INFO - 'create-virtualenv', 13:22:22 INFO - 'install', 13:22:22 INFO - 'run-tests'), 13:22:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:22:22 INFO - 'download_minidump_stackwalk': True, 13:22:22 INFO - 'download_symbols': 'ondemand', 13:22:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:22:22 INFO - 'tooltool.py': '/tools/tooltool.py', 13:22:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:22:22 INFO - '/tools/misc-python/virtualenv.py')}, 13:22:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:22:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:22:22 INFO - 'installer_path': 'installer.exe', 13:22:22 INFO - 'log_level': 'info', 13:22:22 INFO - 'log_name': 'talos', 13:22:22 INFO - 'log_to_console': True, 13:22:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:22:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:22:22 INFO - 'opt_config_files': (), 13:22:22 INFO - 'pip_index': False, 13:22:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:22:22 INFO - 'cmd': ('bash', 13:22:22 INFO - '-c', 13:22:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:22:22 INFO - 'enabled': True, 13:22:22 INFO - 'halt_on_failure': False, 13:22:22 INFO - 'name': 'check_screen_resolution'},), 13:22:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:22:22 INFO - 'cmd': ('bash', 13:22:22 INFO - '-c', 13:22:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:22:22 INFO - 'enabled': True, 13:22:22 INFO - 'halt_on_failure': False, 13:22:22 INFO - 'name': 'check_screen_resolution'},), 13:22:22 INFO - 'run_cmd_checks_enabled': True, 13:22:22 INFO - 'sps_profile': False, 13:22:22 INFO - 'sps_profile_interval': 0, 13:22:22 INFO - 'suite': 'dromaeojs', 13:22:22 INFO - 'system_bits': '32', 13:22:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:22:22 INFO - 'title': 't-yosemite-r7-0114', 13:22:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:22:22 INFO - 'use_talos_json': True, 13:22:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:22:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:22:22 INFO - 'work_dir': 'build'} 13:22:22 INFO - ##### 13:22:22 INFO - ##### Running clobber step. 13:22:22 INFO - ##### 13:22:22 INFO - Running pre-action listener: _resource_record_pre_action 13:22:22 INFO - Running main action method: clobber 13:22:22 INFO - rmtree: /builds/slave/test/build 13:22:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:22:23 INFO - Running post-action listener: _resource_record_post_action 13:22:23 INFO - ##### 13:22:23 INFO - ##### Running read-buildbot-config step. 13:22:23 INFO - ##### 13:22:23 INFO - Running pre-action listener: _resource_record_pre_action 13:22:23 INFO - Running main action method: read_buildbot_config 13:22:23 INFO - Using buildbot properties: 13:22:23 INFO - { 13:22:23 INFO - "project": "", 13:22:23 INFO - "product": "firefox", 13:22:23 INFO - "script_repo_revision": "production", 13:22:23 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 13:22:23 INFO - "repository": "", 13:22:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 13:22:23 INFO - "buildid": "20160425113506", 13:22:23 INFO - "pgo_build": "False", 13:22:23 INFO - "basedir": "/builds/slave/test", 13:22:23 INFO - "buildnumber": 769, 13:22:23 INFO - "slavename": "t-yosemite-r7-0114", 13:22:23 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:22:23 INFO - "platform": "yosemite_r7", 13:22:23 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:22:23 INFO - "branch": "fx-team", 13:22:23 INFO - "repo_path": "integration/fx-team", 13:22:23 INFO - "revision": "14952428292c90aa00c28fdfb1f1e79bd8257ce2", 13:22:23 INFO - "stage_platform": "macosx64", 13:22:23 INFO - "builduid": "1445a4f8deb94df187e81eff5838680b", 13:22:23 INFO - "slavebuilddir": "test" 13:22:23 INFO - } 13:22:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 13:22:23 INFO - Running post-action listener: _resource_record_post_action 13:22:23 INFO - ##### 13:22:23 INFO - ##### Running download-and-extract step. 13:22:23 INFO - ##### 13:22:23 INFO - Running pre-action listener: _resource_record_pre_action 13:22:23 INFO - Running main action method: download_and_extract 13:22:23 INFO - mkdir: /builds/slave/test/build/tests 13:22:23 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')]} 13:22:23 INFO - https://queue.taskcluster.net/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:22:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 13:22:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 13:22:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 13:22:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 13:22:24 INFO - Downloaded 1199 bytes. 13:22:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 13:22:24 INFO - Using the following test package requirements: 13:22:24 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 13:22:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:22:24 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 13:22:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:22:24 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 13:22:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:22:24 INFO - u'jsshell-mac.zip'], 13:22:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:22:24 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 13:22:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 13:22:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:22:24 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 13:22:24 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:22:24 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 13:22:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:22:24 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 13:22:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:22:24 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 13:22:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:22: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')]} 13:22:24 INFO - https://queue.taskcluster.net/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:22:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:22:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:22:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:22:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:22:25 INFO - Downloaded 18111437 bytes. 13:22:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:22:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:22:28 INFO - Return code: 0 13:22:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:28 INFO - https://queue.taskcluster.net/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:22:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:22:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:22:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:22:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:22:30 INFO - Downloaded 18111437 bytes. 13:22:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:22:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:22:33 INFO - Return code: 0 13:22:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:33 INFO - https://queue.taskcluster.net/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:22:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 13:22:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 13:22:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 13:22:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:22:34 INFO - Downloaded 10840145 bytes. 13:22:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:22:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:22:34 INFO - Return code: 0 13:22: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')]} 13:22:34 INFO - https://queue.taskcluster.net/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:22:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:22:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:22:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 13:22:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 13:22:38 INFO - Downloaded 110147537 bytes. 13:22:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:22:38 INFO - mkdir: /builds/slave/test/properties 13:22:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:22:38 INFO - Writing to file /builds/slave/test/properties/build_url 13:22:38 INFO - Contents: 13:22:38 INFO - build_url:https://queue.taskcluster.net/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:22:38 INFO - Running post-action listener: _resource_record_post_action 13:22:38 INFO - Running post-action listener: set_extra_try_arguments 13:22:38 INFO - ##### 13:22:38 INFO - ##### Running populate-webroot step. 13:22:38 INFO - ##### 13:22:38 INFO - Running pre-action listener: _resource_record_pre_action 13:22:38 INFO - Running main action method: populate_webroot 13:22:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:22:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:22:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:22:38 INFO - '--tppagecycles', 13:22:38 INFO - '7'], 13:22:38 INFO - 'tests': ['tsvgm']}}, 13:22:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:22:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:22:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:22:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:22:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:22:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:22:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:38 INFO - 'talos_options': ['--disable-e10s'], 13:22:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:22:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:22:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:38 INFO - 'talos_options': ['--disable-e10s'], 13:22:38 INFO - 'tests': ['damp', 'tps']}, 13:22:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:38 INFO - 'tests': ['damp', 'tps']}, 13:22:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:22:38 INFO - 'tests': ['dromaeo_dom']}, 13:22:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:22:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:22:38 INFO - 'tests': ['a11yr', 13:22:38 INFO - 'ts_paint', 13:22:38 INFO - 'tpaint', 13:22:38 INFO - 'sessionrestore', 13:22:38 INFO - 'sessionrestore_no_auto_restore', 13:22:38 INFO - 'tabpaint']}, 13:22:38 INFO - 'other-e10s': {'tests': ['a11yr', 13:22:38 INFO - 'ts_paint', 13:22:38 INFO - 'tpaint', 13:22:38 INFO - 'sessionrestore', 13:22:38 INFO - 'sessionrestore_no_auto_restore', 13:22:38 INFO - 'tabpaint']}, 13:22:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:22:38 INFO - 'ts_paint', 13:22:38 INFO - 'tpaint', 13:22:38 INFO - 'sessionrestore', 13:22:38 INFO - 'sessionrestore_no_auto_restore', 13:22:38 INFO - 'tabpaint']}, 13:22:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:22:38 INFO - 'ts_paint', 13:22:38 INFO - 'tpaint', 13:22:38 INFO - 'sessionrestore', 13:22:38 INFO - 'sessionrestore_no_auto_restore', 13:22:38 INFO - 'tabpaint']}, 13:22:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:22:38 INFO - 'tests': ['a11yr', 13:22:38 INFO - 'ts_paint', 13:22:38 INFO - 'tpaint', 13:22:38 INFO - 'sessionrestore', 13:22:38 INFO - 'sessionrestore_no_auto_restore', 13:22:38 INFO - 'tabpaint']}, 13:22:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:22:38 INFO - 'tests': ['a11yr', 13:22:38 INFO - 'ts_paint', 13:22:38 INFO - 'tpaint', 13:22:38 INFO - 'sessionrestore', 13:22:38 INFO - 'sessionrestore_no_auto_restore', 13:22:38 INFO - 'tabpaint']}, 13:22:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:22:38 INFO - 'tests': ['tsvgx', 13:22:38 INFO - 'tsvgr_opacity', 13:22:38 INFO - 'tart', 13:22:38 INFO - 'tscrollx', 13:22:38 INFO - 'cart']}, 13:22:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:22:38 INFO - 'tsvgr_opacity', 13:22:38 INFO - 'tart', 13:22:38 INFO - 'tscrollx', 13:22:38 INFO - 'cart']}, 13:22:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:38 INFO - 'talos_options': ['--disable-e10s'], 13:22:38 INFO - 'tests': ['tp5o']}, 13:22:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:38 INFO - 'tests': ['tp5o']}, 13:22:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:38 INFO - 'talos_options': ['--disable-e10s', 13:22:38 INFO - '--xperf_path', 13:22:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:22:38 INFO - 'tests': ['tp5n']}, 13:22:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:38 INFO - 'talos_options': ['--xperf_path', 13:22:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:22:38 INFO - 'tests': ['tp5n']}}, 13:22:38 INFO - 'talos.zip': {'path': '', 13:22:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:22:38 INFO - Running post-action listener: _resource_record_post_action 13:22:38 INFO - ##### 13:22:38 INFO - ##### Running create-virtualenv step. 13:22:38 INFO - ##### 13:22:38 INFO - Running pre-action listener: _resource_record_pre_action 13:22:38 INFO - Running main action method: create_virtualenv 13:22:38 INFO - Creating virtualenv /builds/slave/test/build/venv 13:22:38 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 13:22:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:22:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:22:39 INFO - Using real prefix '/tools/python27' 13:22:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:22:39 INFO - Installing distribute.............................................................................................................................................................................................done. 13:22:42 INFO - Installing pip.................done. 13:22:42 INFO - Return code: 0 13:22:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:22:42 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')]} 13:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:42 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')]} 13:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:42 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 0x1074cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbecb574fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736be00>, '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 0x107194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107366b20>, '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.cPvtyivwEb/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.vNLxHyw02A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 13:22:42 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 13:22:42 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 13:22:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPvtyivwEb/Render', 13:22:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:22:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:22:42 INFO - 'HOME': '/Users/cltbld', 13:22:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:22:42 INFO - 'LOGNAME': 'cltbld', 13:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:42 INFO - 'MOZ_NO_REMOTE': '1', 13:22:42 INFO - 'NO_EM_RESTART': '1', 13:22:42 INFO - 'PAGER': '/bin/cat', 13:22:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:42 INFO - 'PWD': '/builds/slave/test', 13:22:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:22:42 INFO - 'SHELL': '/bin/bash', 13:22:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNLxHyw02A/Listeners', 13:22:42 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 13:22:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:22:42 INFO - 'USER': 'cltbld', 13:22:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:22:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:42 INFO - 'XPC_FLAGS': '0x0', 13:22:42 INFO - 'XPC_SERVICE_NAME': '0', 13:22:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:42 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 13:22:42 INFO - Cleaning up... 13:22:42 INFO - Return code: 0 13:22:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:22:42 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')]} 13:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:42 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')]} 13:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:42 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 0x1074cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbecb574fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736be00>, '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 0x107194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107366b20>, '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.cPvtyivwEb/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.vNLxHyw02A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 13:22:42 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 13:22:42 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 13:22:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPvtyivwEb/Render', 13:22:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:22:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:22:42 INFO - 'HOME': '/Users/cltbld', 13:22:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:22:42 INFO - 'LOGNAME': 'cltbld', 13:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:42 INFO - 'MOZ_NO_REMOTE': '1', 13:22:42 INFO - 'NO_EM_RESTART': '1', 13:22:42 INFO - 'PAGER': '/bin/cat', 13:22:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:42 INFO - 'PWD': '/builds/slave/test', 13:22:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:22:42 INFO - 'SHELL': '/bin/bash', 13:22:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNLxHyw02A/Listeners', 13:22:42 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 13:22:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:22:42 INFO - 'USER': 'cltbld', 13:22:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:22:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:42 INFO - 'XPC_FLAGS': '0x0', 13:22:42 INFO - 'XPC_SERVICE_NAME': '0', 13:22:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:43 INFO - Downloading/unpacking psutil>=0.7.1 13:22:43 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 13:22:43 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 13:22:43 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 13:22:43 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 13:22:43 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 13:22:43 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 13:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:22:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:22:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:22:45 INFO - Installing collected packages: psutil 13:22:45 INFO - Running setup.py install for psutil 13:22:45 INFO - building 'psutil._psutil_osx' extension 13:22:45 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 13:22:46 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 13:22:46 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 13:22:46 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 13:22:46 INFO - building 'psutil._psutil_posix' extension 13:22:46 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 13:22:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:22:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:22:46 INFO - ^ 13:22:46 INFO - 1 warning generated. 13:22:46 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 13:22:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:22:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:22:46 INFO - Successfully installed psutil 13:22:46 INFO - Cleaning up... 13:22:46 INFO - Return code: 0 13:22:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:22:46 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')]} 13:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:46 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')]} 13:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:46 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 0x1074cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbecb574fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736be00>, '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 0x107194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107366b20>, '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.cPvtyivwEb/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.vNLxHyw02A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 13:22:46 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 13:22:46 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 13:22:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPvtyivwEb/Render', 13:22:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:22:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:22:46 INFO - 'HOME': '/Users/cltbld', 13:22:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:22:46 INFO - 'LOGNAME': 'cltbld', 13:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:46 INFO - 'MOZ_NO_REMOTE': '1', 13:22:46 INFO - 'NO_EM_RESTART': '1', 13:22:46 INFO - 'PAGER': '/bin/cat', 13:22:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:46 INFO - 'PWD': '/builds/slave/test', 13:22:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:22:46 INFO - 'SHELL': '/bin/bash', 13:22:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNLxHyw02A/Listeners', 13:22:46 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 13:22:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:22:46 INFO - 'USER': 'cltbld', 13:22:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:22:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:46 INFO - 'XPC_FLAGS': '0x0', 13:22:46 INFO - 'XPC_SERVICE_NAME': '0', 13:22:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:22: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 13:22: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 13:22: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 13:22: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 13:22: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 13:22: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 13:22:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:22:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:22:49 INFO - Installing collected packages: mozsystemmonitor 13:22:49 INFO - Running setup.py install for mozsystemmonitor 13:22:49 INFO - Successfully installed mozsystemmonitor 13:22:49 INFO - Cleaning up... 13:22:49 INFO - Return code: 0 13:22:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:22:49 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')]} 13:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:49 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')]} 13:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:49 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 0x1074cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbecb574fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736be00>, '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 0x107194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107366b20>, '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.cPvtyivwEb/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.vNLxHyw02A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 13:22:49 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 13:22:49 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 13:22:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPvtyivwEb/Render', 13:22:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:22:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:22:49 INFO - 'HOME': '/Users/cltbld', 13:22:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:22:49 INFO - 'LOGNAME': 'cltbld', 13:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:49 INFO - 'MOZ_NO_REMOTE': '1', 13:22:49 INFO - 'NO_EM_RESTART': '1', 13:22:49 INFO - 'PAGER': '/bin/cat', 13:22:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:49 INFO - 'PWD': '/builds/slave/test', 13:22:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:22:49 INFO - 'SHELL': '/bin/bash', 13:22:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNLxHyw02A/Listeners', 13:22:49 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 13:22:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:22:49 INFO - 'USER': 'cltbld', 13:22:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:22:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:49 INFO - 'XPC_FLAGS': '0x0', 13:22:49 INFO - 'XPC_SERVICE_NAME': '0', 13:22:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:49 INFO - Downloading/unpacking blobuploader==1.2.4 13:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:52 INFO - Downloading blobuploader-1.2.4.tar.gz 13:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:22:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:22:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:53 INFO - Downloading docopt-0.6.1.tar.gz 13:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:22:53 INFO - Installing collected packages: blobuploader, requests, docopt 13:22:53 INFO - Running setup.py install for blobuploader 13:22:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:22:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:22:53 INFO - Running setup.py install for requests 13:22:54 INFO - Running setup.py install for docopt 13:22:54 INFO - Successfully installed blobuploader requests docopt 13:22:54 INFO - Cleaning up... 13:22:54 INFO - Return code: 0 13:22:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:22:54 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')]} 13:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:54 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')]} 13:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:54 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 0x1074cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbecb574fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736be00>, '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 0x107194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107366b20>, '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.cPvtyivwEb/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.vNLxHyw02A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 13:22:54 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 13:22:54 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 13:22:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPvtyivwEb/Render', 13:22:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:22:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:22:54 INFO - 'HOME': '/Users/cltbld', 13:22:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:22:54 INFO - 'LOGNAME': 'cltbld', 13:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:54 INFO - 'MOZ_NO_REMOTE': '1', 13:22:54 INFO - 'NO_EM_RESTART': '1', 13:22:54 INFO - 'PAGER': '/bin/cat', 13:22:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:54 INFO - 'PWD': '/builds/slave/test', 13:22:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:22:54 INFO - 'SHELL': '/bin/bash', 13:22:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNLxHyw02A/Listeners', 13:22:54 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 13:22:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:22:54 INFO - 'USER': 'cltbld', 13:22:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:22:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:54 INFO - 'XPC_FLAGS': '0x0', 13:22:54 INFO - 'XPC_SERVICE_NAME': '0', 13:22:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:22:54 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-fQLaK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:22:54 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-sAsrTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:22:54 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-Cpd_Xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:22:54 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-JkmCuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:22:54 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-TbcMk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:22:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-0yCfoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:22:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-Ixcqwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:22:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-2AiXdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:22:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-F4es8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:22:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-NU3i3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:22:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-jcN8gP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:22:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-LwzyDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:22:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-K1ygCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:22:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-oOp6ZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:22:56 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-M6Af9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:22:56 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-PemItV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:22:56 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-BLw_Mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:22:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:22:56 INFO - Running setup.py install for manifestparser 13:22:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:22:56 INFO - Running setup.py install for mozcrash 13:22:56 INFO - Running setup.py install for mozdebug 13:22:56 INFO - Running setup.py install for mozdevice 13:22:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:22:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:22:56 INFO - Running setup.py install for mozfile 13:22:57 INFO - Running setup.py install for mozhttpd 13:22:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:22:57 INFO - Running setup.py install for mozinfo 13:22:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:22:57 INFO - Running setup.py install for mozInstall 13:22:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:22:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:22:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:22:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:22:57 INFO - Running setup.py install for mozleak 13:22:57 INFO - Running setup.py install for mozlog 13:22:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:22:57 INFO - Running setup.py install for moznetwork 13:22:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:22:57 INFO - Running setup.py install for mozprocess 13:22:58 INFO - Running setup.py install for mozprofile 13:22:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:22:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:22:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:22:58 INFO - Running setup.py install for mozrunner 13:22:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:22:58 INFO - Running setup.py install for mozscreenshot 13:22:58 INFO - Running setup.py install for moztest 13:22:58 INFO - Running setup.py install for mozversion 13:22:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:22:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:22:58 INFO - Cleaning up... 13:22:58 INFO - Return code: 0 13:22:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:22: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')]} 13:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22: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')]} 13:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:58 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 0x1074cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbecb574fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736be00>, '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 0x107194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107366b20>, '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.cPvtyivwEb/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.vNLxHyw02A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 13:22:58 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 13:22:58 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 13:22:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPvtyivwEb/Render', 13:22:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:22:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:22:58 INFO - 'HOME': '/Users/cltbld', 13:22:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:22:58 INFO - 'LOGNAME': 'cltbld', 13:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:58 INFO - 'MOZ_NO_REMOTE': '1', 13:22:58 INFO - 'NO_EM_RESTART': '1', 13:22:58 INFO - 'PAGER': '/bin/cat', 13:22:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:58 INFO - 'PWD': '/builds/slave/test', 13:22:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:22:58 INFO - 'SHELL': '/bin/bash', 13:22:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNLxHyw02A/Listeners', 13:22:58 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 13:22:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:22:58 INFO - 'USER': 'cltbld', 13:22:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:22:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:58 INFO - 'XPC_FLAGS': '0x0', 13:22:58 INFO - 'XPC_SERVICE_NAME': '0', 13:22:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:22:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-YmCDRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:22:59 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)) 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:22:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-lXgebS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:22:59 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)) 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:22:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-FjIsPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:22:59 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)) 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:22:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-lBUGmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:22:59 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)) 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:22:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-2Cy820-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:22:59 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)) 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:22:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-Nj7JU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:22:59 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)) 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:22:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-rfhyAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:22:59 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)) 13:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:22:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-xJBAcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:00 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)) 13:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-pLJ7zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:00 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)) 13:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-jCJ0CP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:00 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)) 13:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-7dl9Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:00 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)) 13:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-p95H5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:00 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)) 13:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-IzezWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:00 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)) 13:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-R2YIx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:00 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)) 13:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-s7bA5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:00 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)) 13:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-LX9OSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:00 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)) 13:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-pLAaRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:00 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)) 13:23:00 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)) 13:23:00 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)) 13:23:00 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)) 13:23:00 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)) 13:23:00 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)) 13:23:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:23:00 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 13:23:00 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 13:23:00 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 13:23:00 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 13:23:00 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 13:23:00 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 13:23:03 INFO - Downloading blessings-1.6.tar.gz 13:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:23:03 INFO - Installing collected packages: blessings 13:23:03 INFO - Running setup.py install for blessings 13:23:03 INFO - Successfully installed blessings 13:23:03 INFO - Cleaning up... 13:23:03 INFO - Return code: 0 13:23:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:23:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:03 INFO - Reading from file tmpfile_stdout 13:23:03 INFO - Current package versions: 13:23:03 INFO - blessings == 1.6 13:23:03 INFO - blobuploader == 1.2.4 13:23:03 INFO - docopt == 0.6.1 13:23:03 INFO - manifestparser == 1.1 13:23:03 INFO - mozInstall == 1.12 13:23:03 INFO - mozcrash == 0.17 13:23:03 INFO - mozdebug == 0.1 13:23:03 INFO - mozdevice == 0.48 13:23:03 INFO - mozfile == 1.2 13:23:03 INFO - mozhttpd == 0.7 13:23:03 INFO - mozinfo == 0.9 13:23:03 INFO - mozleak == 0.1 13:23:03 INFO - mozlog == 3.1 13:23:03 INFO - moznetwork == 0.27 13:23:03 INFO - mozprocess == 0.22 13:23:03 INFO - mozprofile == 0.28 13:23:03 INFO - mozrunner == 6.11 13:23:03 INFO - mozscreenshot == 0.1 13:23:03 INFO - mozsystemmonitor == 0.0 13:23:03 INFO - moztest == 0.7 13:23:03 INFO - mozversion == 1.4 13:23:03 INFO - psutil == 3.1.1 13:23:03 INFO - requests == 1.2.3 13:23:03 INFO - wsgiref == 0.1.2 13:23:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:03 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 0x1074cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbecb574fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736be00>, '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 0x107194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107366b20>, '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.cPvtyivwEb/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.vNLxHyw02A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 13:23:03 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 13:23:03 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 13:23:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPvtyivwEb/Render', 13:23:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:23:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:23:03 INFO - 'HOME': '/Users/cltbld', 13:23:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:23:03 INFO - 'LOGNAME': 'cltbld', 13:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:03 INFO - 'MOZ_NO_REMOTE': '1', 13:23:03 INFO - 'NO_EM_RESTART': '1', 13:23:03 INFO - 'PAGER': '/bin/cat', 13:23:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:03 INFO - 'PWD': '/builds/slave/test', 13:23:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:23:03 INFO - 'SHELL': '/bin/bash', 13:23:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNLxHyw02A/Listeners', 13:23:03 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 13:23:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:23:03 INFO - 'USER': 'cltbld', 13:23:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:23:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:03 INFO - 'XPC_FLAGS': '0x0', 13:23:03 INFO - 'XPC_SERVICE_NAME': '0', 13:23:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:04 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)) 13:23:04 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)) 13:23:04 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)) 13:23:04 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)) 13:23:04 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)) 13:23:04 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)) 13:23:04 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)) 13:23:04 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)) 13:23:04 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)) 13:23:04 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)) 13:23:04 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)) 13:23:04 INFO - Cleaning up... 13:23:04 INFO - Return code: 0 13:23:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:04 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 0x1074cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbecb574fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736be00>, '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 0x107194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107366b20>, '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.cPvtyivwEb/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.vNLxHyw02A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 13:23:04 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 13:23:04 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 13:23:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPvtyivwEb/Render', 13:23:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:23:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:23:04 INFO - 'HOME': '/Users/cltbld', 13:23:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:23:04 INFO - 'LOGNAME': 'cltbld', 13:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:04 INFO - 'MOZ_NO_REMOTE': '1', 13:23:04 INFO - 'NO_EM_RESTART': '1', 13:23:04 INFO - 'PAGER': '/bin/cat', 13:23:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:04 INFO - 'PWD': '/builds/slave/test', 13:23:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:23:04 INFO - 'SHELL': '/bin/bash', 13:23:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNLxHyw02A/Listeners', 13:23:04 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 13:23:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:23:04 INFO - 'USER': 'cltbld', 13:23:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:23:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:04 INFO - 'XPC_FLAGS': '0x0', 13:23:04 INFO - 'XPC_SERVICE_NAME': '0', 13:23:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:04 INFO - Downloading/unpacking jsonschema 13:23:04 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 13:23:04 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 13:23:04 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 13:23:04 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 13:23:04 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 13:23:04 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 13:23:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:23:06 INFO - Downloading/unpacking functools32 (from jsonschema) 13:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:07 INFO - Downloading functools32-3.2.3-2.tar.gz 13:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:23:07 INFO - warning: no files found matching '*.txt' 13:23:07 INFO - no previously-included directories found matching 'build' 13:23:07 INFO - no previously-included directories found matching 'dist' 13:23:07 INFO - no previously-included directories found matching '.git*' 13:23:07 INFO - Installing collected packages: jsonschema, functools32 13:23:07 INFO - Running setup.py install for functools32 13:23:07 INFO - warning: no files found matching '*.txt' 13:23:07 INFO - no previously-included directories found matching 'build' 13:23:07 INFO - no previously-included directories found matching 'dist' 13:23:07 INFO - no previously-included directories found matching '.git*' 13:23:07 INFO - Successfully installed jsonschema functools32 13:23:07 INFO - Cleaning up... 13:23:07 INFO - Return code: 0 13:23:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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')]} 13:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:07 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 0x1074cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbecb574fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736be00>, '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 0x107194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107366b20>, '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.cPvtyivwEb/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.vNLxHyw02A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 13:23:07 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 13:23:07 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 13:23:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPvtyivwEb/Render', 13:23:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:23:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:23:07 INFO - 'HOME': '/Users/cltbld', 13:23:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:23:07 INFO - 'LOGNAME': 'cltbld', 13:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:07 INFO - 'MOZ_NO_REMOTE': '1', 13:23:07 INFO - 'NO_EM_RESTART': '1', 13:23:07 INFO - 'PAGER': '/bin/cat', 13:23:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:07 INFO - 'PWD': '/builds/slave/test', 13:23:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:23:07 INFO - 'SHELL': '/bin/bash', 13:23:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNLxHyw02A/Listeners', 13:23:07 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 13:23:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:23:07 INFO - 'USER': 'cltbld', 13:23:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:23:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:07 INFO - 'XPC_FLAGS': '0x0', 13:23:07 INFO - 'XPC_SERVICE_NAME': '0', 13:23:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:07 INFO - Downloading/unpacking flake8 13:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:23:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:23:10 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 13:23:10 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 13:23:10 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 13:23:10 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 13:23:10 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 13:23:10 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 13:23:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:23:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:23:10 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 13:23:10 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 13:23:10 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 13:23:10 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 13:23:10 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 13:23:10 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 13:23:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:23:11 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 13:23:11 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 13:23:11 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 13:23:11 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 13:23:11 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 13:23:11 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 13:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:23:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:23:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:23:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:23:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:23:11 INFO - no previously-included directories found matching 'docs/_build' 13:23:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:23:11 INFO - Running setup.py install for pep8 13:23:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:23:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:23:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:23:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:23:11 INFO - no previously-included directories found matching 'docs/_build' 13:23:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:23:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:23:11 INFO - Cleaning up... 13:23:12 INFO - Return code: 0 13:23:12 INFO - Running post-action listener: _resource_record_post_action 13:23:12 INFO - Running post-action listener: _start_resource_monitoring 13:23:12 INFO - Starting resource monitoring. 13:23:12 INFO - ##### 13:23:12 INFO - ##### Running install step. 13:23:12 INFO - ##### 13:23:12 INFO - Running pre-action listener: _resource_record_pre_action 13:23:12 INFO - Running main action method: install 13:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:12 INFO - Reading from file tmpfile_stdout 13:23:12 INFO - Detecting whether we're running mozinstall >=1.0... 13:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:23:12 INFO - Reading from file tmpfile_stdout 13:23:12 INFO - Output received: 13:23:12 INFO - Usage: mozinstall [options] installer 13:23:12 INFO - Options: 13:23:12 INFO - -h, --help show this help message and exit 13:23:12 INFO - -d DEST, --destination=DEST 13:23:12 INFO - Directory to install application into. [default: 13:23:12 INFO - "/builds/slave/test"] 13:23:12 INFO - --app=APP Application being installed. [default: firefox] 13:23:12 INFO - mkdir: /builds/slave/test/build/application 13:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:23:46 INFO - Reading from file tmpfile_stdout 13:23:46 INFO - Output received: 13:23:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:23:46 INFO - Running post-action listener: _resource_record_post_action 13:23:46 INFO - ##### 13:23:46 INFO - ##### Running run-tests step. 13:23:46 INFO - ##### 13:23:46 INFO - Running pre-action listener: _resource_record_pre_action 13:23:46 INFO - Running main action method: run_tests 13:23:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:23:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:23:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:23:46 INFO - 2016-04-25 13:23:46.116 screenresolution[1927:17683] starting screenresolution argv=screenresolution get 13:23:46 INFO - 2016-04-25 13:23:46.119 screenresolution[1927:17683] Display 0: 1600x1200x32@60 13:23:46 INFO - 2016-04-25 13:23:46.125 screenresolution[1928:17685] starting screenresolution argv=screenresolution list 13:23:46 INFO - Available Modes on Display 0 13:23:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:23:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:23:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:23:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:23:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:23:46 INFO - Intel Iris: 13:23:46 INFO - Chipset Model: Intel Iris 13:23:46 INFO - Type: GPU 13:23:46 INFO - Bus: Built-In 13:23:46 INFO - VRAM (Dynamic, Max): 1536 MB 13:23:46 INFO - Vendor: Intel (0x8086) 13:23:46 INFO - Device ID: 0x0a2e 13:23:46 INFO - Revision ID: 0x0009 13:23:46 INFO - Displays: 13:23:46 INFO - Display: 13:23:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:23:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:23:46 INFO - Display Serial Number: 1600x1200 60 13:23:46 INFO - Main Display: Yes 13:23:46 INFO - Mirror: Off 13:23:46 INFO - Online: Yes 13:23:46 INFO - Rotation: Supported 13:23:46 INFO - Return code: 0 13:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:23:46 INFO - Python 2.7.3 13:23:46 INFO - Return code: 0 13:23:46 INFO - grabbing minidump binary from tooltool 13:23:46 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')]} 13:23:46 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 0x10736be00>, '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 0x107194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107366b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:23:46 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 13:23:46 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 13:23:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:23:46 INFO - Return code: 0 13:23:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:23:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:23:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:23:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:23:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:23:47 INFO - Return code: 0 13:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--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 13:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0114 --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 13:23:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cPvtyivwEb/Render', 13:23:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:23:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:23:47 INFO - 'HOME': '/Users/cltbld', 13:23:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:23:47 INFO - 'LOGNAME': 'cltbld', 13:23:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:23:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:47 INFO - 'MOZ_NO_REMOTE': '1', 13:23:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:23:47 INFO - 'NO_EM_RESTART': '1', 13:23:47 INFO - 'PAGER': '/bin/cat', 13:23:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:47 INFO - 'PWD': '/builds/slave/test', 13:23:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:23:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:23:47 INFO - 'SHELL': '/bin/bash', 13:23:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNLxHyw02A/Listeners', 13:23:47 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 13:23:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:23:47 INFO - 'USER': 'cltbld', 13:23:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:23:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:47 INFO - 'XPC_FLAGS': '0x0', 13:23:47 INFO - 'XPC_SERVICE_NAME': '0', 13:23:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:23:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--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 13:23:47 INFO - mozversion application_buildid: 20160425113506 13:23:47 INFO - mozversion application_changeset: 14952428292c90aa00c28fdfb1f1e79bd8257ce2 13:23:47 INFO - mozversion application_display_name: Nightly 13:23:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:23:47 INFO - mozversion application_name: Firefox 13:23:47 INFO - mozversion application_remotingname: firefox 13:23:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:23:47 INFO - mozversion application_vendor: Mozilla 13:23:47 INFO - mozversion application_version: 48.0a1 13:23:47 INFO - mozversion platform_buildid: 20160425113506 13:23:47 INFO - mozversion platform_changeset: 14952428292c90aa00c28fdfb1f1e79bd8257ce2 13:23:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:23:47 INFO - mozversion platform_version: 48.0a1 13:23:47 INFO - using testdate: 1461615827 13:23:47 INFO - actual date: 1461615827 13:23:47 INFO - starting webserver on 'localhost:54191' 13:23:47 INFO - SUITE-START | Running 2 tests 13:23:47 INFO - TEST-START | dromaeo_css 13:23:47 INFO - operating with platform_type : mac_ 13:23:47 INFO - Initialising browser for dromaeo_css test... 13:23:47 INFO - TEST-INFO | started process 1946 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmp4KD7fj/profile http://localhost:54191/getInfo.html) 13:23:50 INFO - PROCESS | 1946 | __metrics Screen width/height:1600/1200 13:23:50 INFO - PROCESS | 1946 | colorDepth:24 13:23:50 INFO - PROCESS | 1946 | Browser inner width/height: 1024/689 13:23:50 INFO - PROCESS | 1946 | __metrics 13:23:50 INFO - PROCESS | 1946 | 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" 13:23:50 ERROR - PROCESS | 1946 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:23:50 INFO - TEST-INFO | 1946: exit 0 13:23:50 INFO - Browser initialized. 13:23:50 INFO - Running cycle 1/1 for dromaeo_css test... 13:23:50 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmp4KD7fj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:24:02 INFO - PROCESS | 1948 | RSS: Main: 239681536 13:24:02 INFO - PROCESS | 1948 | 13:24:54 INFO - PROCESS | 1948 | 1461615894201 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] 13:27:03 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:54191/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54191/tests/dromaeo/cssquery-ext.html) 13:27:05 INFO - PROCESS | 1948 | RSS: Main: 455028736 13:27:05 INFO - PROCESS | 1948 | 13:30:09 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:54191/tests/dromaeo/cssquery-ext.html (next: http://localhost:54191/tests/dromaeo/cssquery-jquery.html) 13:30:09 INFO - PROCESS | 1948 | RSS: Main: 379650048 13:30:09 INFO - PROCESS | 1948 | 13:33:12 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:54191/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54191/tests/dromaeo/cssquery-mootools.html) 13:33:12 INFO - PROCESS | 1948 | RSS: Main: 368447488 13:33:12 INFO - PROCESS | 1948 | 13:36:14 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:54191/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54191/tests/dromaeo/cssquery-prototype.html) 13:36:15 INFO - PROCESS | 1948 | RSS: Main: 377040896 13:36:15 INFO - PROCESS | 1948 | 13:39:18 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:54191/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54191/tests/dromaeo/cssquery-yui.html) 13:39:19 INFO - PROCESS | 1948 | RSS: Main: 347824128 13:39:19 INFO - PROCESS | 1948 | 13:42:22 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:54191/tests/dromaeo/cssquery-yui.html (next: http://localhost:54191/tests/dromaeo/cssquery-dojo.html) 13:42:22 INFO - PROCESS | 1948 | RSS: Main: 384974848 13:42:22 INFO - PROCESS | 1948 | 13:42:22 INFO - PROCESS | 1948 | __start_tp_report 13:42:22 INFO - PROCESS | 1948 | _x_x_mozilla_page_load 13:42:22 INFO - PROCESS | 1948 | _x_x_mozilla_page_load_details 13:42:22 INFO - PROCESS | 1948 | |i|pagename|runs| 13:42:22 INFO - PROCESS | 1948 | |0;dojo.html;2758.3104223944015;3407.437772767492;3433.3648275069113;3443.8966830995046;3486.808225547594;5615.2700148980675;5639.492445679888;5651.6891570963635;5675.978323901706;5710.7430165642545;5661.264035675356;5677.290338707661;5724.599278050528;5828.562857785672;5831.4751672349485;4641.651876109288;4743.454502732196;5001.324821149153;5087.7710503027265;5211.478852114796;5161.612879034069;5194.454582268864;5218.921716174261;5223;5228.843134705965;5067.417247016585;5137.974310128463;5150.97424512875;5152.819651312224;5177.352830896138;5141.691498510064;5159.484051594848;5162.948370516285;5170.767315470813;5175.146100893348;5051.848444546669;5059.139946209153;5141.100307446182;5147.742612869341;5152.458991805881;5574.358948720908;5581.6371935824445;5588.804391846266;5589.664620122765;5607.243022191993;6076.756929722806;6172.7530898764;6174.104754810573;6189.38106189382;6192.783252586138;5920.763169473216;5990.880182396371;6185.87628247437;6240.1263823064355;6241.563090583661;5773.740181691834;5774.48029677331;5782.306123265193;5784.566157538202;5812.273465816773;6247.187865577446;6250.218722659668;6262.499000079983;6275.184226050585;6297.2128483939505;5947.881042379128;6023.457065635116;6029.231128814905;6047.758089676452;6070.0591408331775;6112.083187521907;6124.960759790135;6152.846178845564;6205.22434695663;6218.595791273553;6102.298235702951;6150.07748837669;6165.907511387333;6175.104609831549;6184.598001130003;6233.719482623293;6246.6876656167005;6253.280872699698;6253.78111766086;6257.812265632038;4783.5933945614315;4864.975675121602;4906.1414252505665;4919.680220785637;4935.901281974412;4398.3842262083335;4411.919079825463;4459.687821852504;4465.397171381822;4466.486354069324;5627.212190293362;5691.573132015115;5723.141528770634;5755.740991655385;5756.769729210785;6265.248170219512;6282.560220784592;6294;6308.589941653778;6311.495080393557;5659.858503537363;5676.7161641918565;5683.147527870769;5687.1753595729215;5727.198192253088;5240.9475905241225;5322.946770532322;5336.866578335573;5368;5408.513233808976;6260;6260.060990851409;6271.9686401568615;6283.8114856554375;6292.811215663537;6223.502119830493;6277.905831412624;6298.0552917062805;6302.401271879165;6308.400701933309;6169.136320914986;6213.285472170758;6239.344868788712;6248.968755156195;6289.7484100635465;6167.383261673796;6186.257649082139;6186.783462578788;6187.783427580193;6197.442230199304;5240.68555886648;6274.717637706223;6281.560290779602;6286.119943207863;6288.5283603728985;4977.303177555217;5986.820395388146;6022.488088512526;6023.909641355471;6035.69821508914;5997.31030931431;6003.099535069775;6039.849003774941;6040.667763272886;6058.3335833057445;5900.144479050599;5900.291964964232;5901.9966605678;5902.793402230901;5915.615484993462;6005.189299444519;6007.681823813654;6010.278766548042;6020.187274718032;6091.664958427329;5969.791057312973;5975.910361344497;5992.64044157352;6014.849628759316;6023.27720673522 13:42:22 INFO - PROCESS | 1948 | |1;ext.html;486.84664330735836;487.82682147837517;492.3033907021564;507.22394736053826;596.8209537138857;38960.80519597402;40377.79811100944;40557;40589.39115913256;40628.59371406289;44466.7776661117;45102.77448612761;45438.09123817521;45455.863603409845;45467.0906581869;8368.832623347529;8570.357223208253;9454.290928180397;9655.613775448974;9690.951545242264;11073.058790002859;11342.546298148065;11356.375399353032;11389.943050284737;11396.25924314921;11363.977242048255;11495.310281383145;11499.712507187303;11505.539778408895;11517.251378660401;8323.542205178743;8514.829703405898;8515.403921725481;8517.318614510887;11285;9478.336516443851;11118.944405278004;11269.661910142628;11319.603813866557;11384.772304553862;38177.618223817684;38838.61161388378;38859.8057009716;38886.22227555461;38920.61079389198;2827.0529372660185;2963.2147480917574;3256.169676732418;3683.963160368389;3975.662068724162;28357.291067723265;28684.282892927637;29537.26156846096;29766;30141.547876781864;2752.4357506711076;2773.237359726071;2836.0357478457217;2844.7866410019333;2902.2454161917844;495179;495715;496623;498633;499272.5036374795;33887.83056084704;34805.47791783125;62529;62929.96560275167;62991.6850415745;34951;35300.64699353025;35391.82304088463;35433;35468.645313546534;12560.937195314147;14808.777868331983;14824.258787060604;15044.022138560958;15055.322510487054;11337.319760814378;11601.76796464066;12360.134790564574;12575.182613130117;12581.811272830915;8110.716124935599;8181.67273309061;8196.303314218358;8229.876551851727;8270.627821748036;3394.8966585859694;3416.8462419191196;3427.5715535558056;3430.3310854383653;3462.23830757233;999.715081201854;1002.8445590933417;1035.4266671956213;1106.6956586938495;1144.6508814811395;29780.957666482;29873.850630746707;29985.550216746768;30387.544186837215;30525.236869078006;984.7981163861391;1051.7423231308378;1104.3594715065242;1181.9113566482376;1237.9876201238053;15421.074735515906;15513.379464821506;15518.767218491732;15859;16070.678586428206;675154;678943;685942;686595;688486;62029.68985155045;62472;62557.06164407537;62658.373416265254;62874.37125628777;1347.2994043097535;1459.4599998000594;1486.0712054965647;1492.5671555248857;1494;28705.856470717514;28897;29017.69420376046;29679.25801854971;29798.8510057457;48525.27212091892;49000.754996224794;49046.50953490562;49074.75462622664;49106;356809;367009;367052;367092;368796;23637.881810590836;25374.873125634254;25677.743222567537;26164.869175654;26456.735432645426;41340.586594134875;42656.54005070041;42896;44477.55522444864;44848;37215.255694886495;37667.81166094152;37788.05529861776;38408.615913840506;38849;35536.46695299521;35943.64056359403;36705.44941825821;36753.63246367502;37469.06327341838;35450.256777738665;35877.28245435129;36097.63902361048;36532.81733591422;37202.8139859299;31097.44512774307;32542.67457325491;32579.18552036218;32626.858059967788;32708.836455817567;23798.286051418487;24218.749999999578;24243;24324.39189020218;25205.87397063003 13:42:22 INFO - PROCESS | 1948 | |2;jquery.html;357.3942168025197;398.8783421056577;398.94614227079336;401.1375542583447;409.2388158026071;13720.456052365262;18900.62198756024;21062.052207650653;21200.36398908033;21215.363539093814;14013.859861401383;16071.357145714157;20276.89861550694;20554.89722551385;20665;5822.563307751914;6106.419890110433;6165.0444181152;6165.938340616582;6169.290531588857;5775.740091695884;6043.395660433944;6072.271327440713;6091.817245482643;6130.785422510213;3927.725059245854;4161.667066634662;5734.770609175628;6076.149339092531;6077.939220607804;6000.249968753906;6052.697365131726;6058.909116363258;6075.301340345851;6098.908516372214;5652.604317697763;5829.36777702244;5852.736626851802;5858.531317494633;5860.238169038041;12771.616851494377;13009.869901301056;13175.60473185806;13292.401841917137;13301.201927884262;2135.3273718778537;2267.965980510294;2488.216211893266;2756.4073724149202;2765.2119146043483;8325.500469971821;9138.360314777969;9630.18143457807;9962.800743985079;10034.89965100347;1682.8064772551068;1710.2474911039228;1753.1935309757528;1769.2480695704403;1841.0978620476005;133589;134118.3294083533;134780;138044;139877;11577.884221157681;11608.129390295762;11627.883721162849;11672.824907626393;11750.177487575787;14895.255237238094;15010.924945375422;15017.098974061591;15031.323590438456;15042.849571504365;8408.873866892001;8607.311415086779;8628.52543110135;8689.826203475895;8753.431026983226;7784.143744188134;7935.484193527518;8476;8509.787255318543;8559.315254779603;4462.598366147063;4536.77316134192;4548.590626843534;4602.1025899949855;4651;1304.7260075384277;1617.563257920355;1895.3934740882785;1931.51712071982;1980.3068376537854;780.9062912450429;897.6858099665066;942.8167649599845;958.3148049144895;1025.6769117727893;18976.43070707881;19417.611647767248;20026.499337516678;20197.889116098755;20233.595328093357;950.9919485345417;955.5699935029264;958.4872093429982;974.0746291023556;1031.5976769060073;8906.510141942126;10646.870625874855;10917.126629869592;10947.945260273807;10964.890351096547;600867;617783;619047;620194;625690.8715456394;104612;128230.71769282375;137167.31416343054;141246;148032;896.8878590547674;935.9391639543544;1014.852846337277;1041.146260066738;1041.8020576090519;18058.548536286697;18213.54466138357;18235.81764182341;18268.269269229615;18333.633327333646;52660.73669631627;55237.89524209413;55450;56087;56309.43690563042;79711;79773.77912543675;79808;80649;83575.58212209144;7920.495105929855;8049.798755030937;8084.272415482635;8317.251447369767;8363.201911588794;8945;11836.171467997157;12386.5664701735;12803.35983200855;12845.871541284467;6205.410486003822;7450.850982980419;10589;10848.294860834021;10984.780304394028;8642.913570864463;10858.511366988663;10860.185486088732;10965.95823396776;11059.115270778479;10483.58065677395;11101.5559377624;11324.6036388726;11370.829437558277;11475.540978360772;6838;8038.15599362082;8059.153788852086;8143.51138931666;8350.582470876554;7793.2596403341595;7849.626315394669;7863.410244231591;8157.143499932659;8345.207205315486 13:42:22 INFO - PROCESS | 1948 | |3;mootools.html;1386.9861301386984;1416.70957453722;1632.126812155497;1854.5997771682378;2006.9297574584884;7727.227277272277;8485.151484851513;8537.719342098688;8733.475991440519;8733.563321833899;7453.4409919256;8593.613287402066;8600.35497337699;8604.483730976146;8606.741797746063;2425.745296743843;2450.277168235375;2455.9631605525933;2456.7666071723247;2462.384403899025;2395.5089206712582;2447.5104979004273;2449.1305586516796;2451.6935383077116;2458.864762438065;2353.2822489140804;2366.96449553256;2372.264597974625;2385.0817435287454;2385.2605692235375;2377.3699969508093;2394.521095780842;2394.832361734679;2402.2072716003677;2426.078090325665;2372.1223147435385;2377.358113309414;2384.6899903012495;2385.1175065225802;2388.749181335952;8448.450850694746;8660.17728315809;8762.474251544927;8764.43031202976;8774.947006359278;5263.236830659571;5390.245365648812;5456.972715136439;5459.617826752129;5459.863503412406;3033.0294305822144;3380.323935212967;3478.9826050869838;3547.343741407848;3553.1472446612884;965.6427121964848;968.5980318167951;979.8285300072458;987.6888780034266;1005.653049697853;11193.328400296008;11293.435328233638;11464.999999999916;11498.31010139386;11532.827007594893;4452.777361131995;4732.645051621143;4732.763361831895;4740.5733483986605;4742.762861856893;9084.954575227213;9145.268378529701;9151.267898568098;9167.312451566158;9170.08299170091;4992.750362481861;5230.712310822942;5312.468753124734;5315.388730296066;5330.600204984642;4358.193734159191;4540.318952157203;4740.336352910595;4902.166631672624;4910.558049775537;3036.6659667436566;3687.502187204747;3751;3767.830447629863;3798.867039653599;1203.4524291447372;1210.673118258083;1213.3266037349356;1226.6197478781605;1228.0543981134476;661.3981277037968;797.6490344248512;867.7743786615525;870.0168809245639;1011.2870426349406;4913.65604407688;5760.251167348218;5923;6024.397560244028;6110.358412366726;901.6303315640556;935.0275713258271;963.7783309838776;965.2278177458005;995.0397866059287;3452.4993875887853;3832.9233415331537;3940.566537680853;4021.3766866135797;4049.655779258796;10136.543855526372;10425.687229383131;10698.304610200468;10773.299735517166;10851.348919064882;10688.78622427547;10854.131669466424;10865.076468500267;10867.510962006729;10876.238663293652;7796.610169491502;7960.044794624682;8181.3863960203225;8215.876761848576;8275.793105172419;5867.090600956859;5949.167116603592;5989.610675306091;6015.037593984942;6064.787732429344;8638.611262493077;10008.84986725185;10056.899431005597;10116.949415252877;10128.240381971234;9939.552720127756;10051.346662466916;10136.645217417356;10406.219533535166;10421.114205292331;7018.719251229893;7038.929610703827;7160.964195178991;7167.139943206848;7174.784756457315;7692.653830577526;8223.753287401387;8301.584920753818;8311;8396;7347.228541003332;7359;7391.519551229153;7476.514026588255;7519.022527071445;7192.784216473514;7279.963600182177;7293;7461;7485.214052524624;6918.5502942308585;6993.825154371181;6995.650217489004;7020.859582808417;7023.929760702327;4709.293605959134;4989.975050124726;4994.425641051325;5005.749712514433;5048.596112310933;4956.653034287565;5035.16919708244;5043.87390315245;5084.669496482717;5268.315119034501 13:42:22 INFO - PROCESS | 1948 | |4;prototype.html;317.26236500137185;319.43778949049675;324.8570628923275;328.35642141402843;329.64398449674354;4575.771211439427;4938.160512712839;5175.3272074630295;5328.547073498752;5332.546733527645;5163.845084647457;5219.660722053064;5220.738963051842;5226.498246175062;5247.504461228551;3789.393697008479;3887.6306750858766;3926.1951299983434;4037.37420699792;4061.5938406159444;3963.8810835674976;4034.3257548117494;4046.037671729209;4052.3111071117833;4059.8985025374304;3211.020638705194;3320.2695407010538;3979.343408337621;3988.222296652154;4022;3245.6267529234206;3500.3174380995715;3521.8239088045493;3877.4908707619647;4026.1545075534173;3503.8598456061727;3509.894703158909;3514.6836784689244;3550.5265314894286;3554.2180720241504;4636.930446043312;5034.09386310464;5059.721715305656;5060;5065.290859279704;4408.911821763579;4524.954750452519;4584.426946631671;4661.557152070582;4678.95321046792;4350.694132109987;4834;5503.010317519806;5524.977879092381;5573.804916827891;3909.9052265365744;3915.6882444381167;3923.4899463069905;3926.2736393767245;3932.7443716158646;5308.70802105884;5400.892816972511;5725.971370143123;5768.990551566663;5844.88310233793;3332.5334453176574;3963.128111815396;3966.345552983725;3994.701721940323;4026.8993275168355;3755;4032;4036.3340048891605;4061.7156799023783;4063.89840253996;4392.516823149451;4401.977990110029;4618.49196588375;4618.538146185422;4636.907261854812;4960.851174464772;5132.9743351283005;5140.588752899759;5556.91664625031;5562.193481945095;1407.8873690104767;1462.7293950619169;1489.8286697029764;1491.5898128014883;1493.3056128900114;844.0125053687201;957.5212393803098;991.7124034030195;1002.0230275481348;1004.2016596805557;4506.639468842484;4532.410786597788;5039.521245481674;5096.413912400121;5105.923411148836;5098.59211263098;5563.304586926634;5577.581681373913;5582.525485333792;5708.828735137869;4900.852974410774;5179.306760484527;5182.378114626269;5195.532402083831;5206.219067139884;2577.587585986233;2660.467906418724;2771.9743694832637;3068.4170007698467;3316.336732653479;5516.7517461714315;6128;6518.543701940914;6554.442872355903;6576.539642224999;4922.360093187935;6050.818475445743;6413.518986076063;6467.223933127961;6489;5233.5551478124025;5509.449055094458;6433.710483028275;6514.837129071811;6517.967410162919;5243.711595862264;5963.850903727442;6261.935470969855;6265.780697675559;6281.780137695158;5236.9738151309;5410.810621628224;6107.389261073857;6128.571000029955;6164.4760195382105;6105;6179.918514260076;6482.611043337415;6503.642299673564;6517.706703198272;3964.6035396460125;4123.422720819148;4132.173565287015;4149.211649786652;4158.9584104159785;5308.548773354154;6233.065040244;6248.8752024636005;6253.343398943045;6283;4755.048990201904;5048.697078175322;5131.923021154611;6060.545459090497;6074.908876366946;5332.626716129834;5757.453041961007;5995;6026.276846778414;6073.210482637229;4899.706017638953;5166.793328266827;5893.233879595797;5911.349751527243;5915.378885217162;4789.664723469324;5122.97642431245;5315.521603055744;5497.8075767347955;5519.558435325244;5342.973285133549;5372.570194384518;5372.919406208832;5388.595855310946;5397.7840886365675 13:42:22 INFO - PROCESS | 1948 | |5;yui.html;629.012450452789;664.9567778094425;714.4657071283517;752.5522314223042;753.1978442958252;14048.789268160974;14547.854521454783;14553.708925821504;14565.198914059722;14587.416503339868;13240.08535572346;13800.1719896806;14173.929130354334;14216.857831421683;14243.643908902282;720.4164626652403;923.2982932970923;930.623097645453;933.6965486217007;939.5724945149974;746.9878314883337;911.7811725185974;946.0303189231024;946.857971304303;948.0898337595917;985.1232403161192;987.279286121132;987.9407235565889;988.2439933450916;990.9207263418946;754.97357592484;948.6347756113877;983.6311383231289;984.6307634637011;988.8022395520925;732.6739600877612;732.809469537924;734.0750654175723;734.2547314475811;736.333618075637;14922.62693432662;14976;14992;15016.399344026226;15049.54851354461;12326.445309961073;12352.814707779391;12385.690357741038;12663.936680316632;12761.744765104646;9848.803023939552;9971.850422243671;10046.9497652512;10071.043250891154;10708.30396024256;3482.3035392921515;3531.2760884018717;3563.982180089109;3579.731520136;3652.0322114639644;73575.63212183905;74704;77642;77661.05847353805;77996.61001694955;9643.517824108767;9646.372985755903;9679.903200968041;9884.11043006133;10005.04952029556;22142.346512825203;22147.335579932627;22167.667484987738;22180.334589962327;22257.777422225896;6955.965220173866;7145.999560061596;7253.891191632129;7457.888131678029;7555.546667199876;3941.329973904386;3988.521377434726;4003.739756915791;4051.817668204879;4093.9181216375505;3502.3695734767475;3584.086058055231;3587.121155316964;3593.191531905353;3604.675579197885;640.4140211706236;644.0693198328464;650.1677852349001;651.0527182948798;658.0721183131761;477.54496219849364;506.3215291509322;529.3198240261246;535.6598559914482;554.8418700670289;8045.396595255379;8130.715424960216;8286.917130828615;8314.542700151429;8416.705415310435;507.55588859747724;547.690554836524;575.8445219790633;628.4375483941847;637.1175921348872;3547.769394989369;3822.8853134406013;3901.6293452122572;3926.1951299983434;4097.467329247238;94827.52586237024;95384;100669.15313734146;100965;101678;77945;78782.6060869692;78796;79927.20072799314;80699.73335451918;61029;61385;61853.9999999991;62032.68983655143;64252.678736606016;7515.210902855121;7641.961790191013;7773.844523109619;7836.255555722198;7844.450888437755;40462.393064103475;41736;43644;43695.344569832116;43715.12569748651;58328;59099.11351329648;59887;59965.8006839852;60612.39387606244;9058.818823623622;10820.67537973862;11061.225714199929;11152.330860148417;11330.320180789178;11789.174757766874;11846.940765296464;11880.34658093813;11898;12912.677183070498;11348.773024539629;11418.600348987746;11522.366269854903;11997.040236780862;12314.014878809494;11250.493727782106;11314.321140731583;11384.089272858317;11619.535218591162;11647.359395233343;11048.281861679287;11141.88858111441;11183.776324473627;11248;11469;9134.257189688624;9167.724968250963;9487.573059212215;9628.037196280316;9805.75485612837;9453.291003174927;9474.810503790024;9506.049395060438;9520.666776662783;9694.32139750239 13:42:22 INFO - PROCESS | 1948 | __end_tp_report 13:42:22 INFO - PROCESS | 1948 | __start_cc_report 13:42:22 INFO - PROCESS | 1948 | _x_x_mozilla_cycle_collect,2229 13:42:22 INFO - PROCESS | 1948 | __end_cc_report 13:42:22 INFO - PROCESS | 1948 | __startTimestamp1461616942829__endTimestamp 13:42:22 INFO - PROCESS | 1948 | 13:42:22 INFO - PROCESS | 1948 | ------- Summary: start ------- 13:42:22 INFO - PROCESS | 1948 | Number of tests: 6 13:42:22 INFO - PROCESS | 1948 | 13:42:22 INFO - PROCESS | 1948 | [#0] dojo.html Cycles:165 Average:5694.81 Median:5920.76 stddev:653.52 (11.0%) stddev-sans-first:613.59 13:42:22 INFO - PROCESS | 1948 | Values: 2758.3 3407.4 3433.4 3443.9 3486.8 5615.3 5639.5 5651.7 5676.0 5710.7 5661.3 5677.3 5724.6 5828.6 5831.5 4641.7 4743.5 5001.3 5087.8 5211.5 5161.6 5194.5 5218.9 5223.0 5228.8 5067.4 5138.0 5151.0 5152.8 5177.4 5141.7 5159.5 5162.9 5170.8 5175.1 5051.8 5059.1 5141.1 5147.7 5152.5 5574.4 5581.6 5588.8 5589.7 5607.2 6076.8 6172.8 6174.1 6189.4 6192.8 5920.8 5990.9 6185.9 6240.1 6241.6 5773.7 5774.5 5782.3 5784.6 5812.3 6247.2 6250.2 6262.5 6275.2 6297.2 5947.9 6023.5 6029.2 6047.8 6070.1 6112.1 6125.0 6152.8 6205.2 6218.6 6102.3 6150.1 6165.9 6175.1 6184.6 6233.7 6246.7 6253.3 6253.8 6257.8 4783.6 4865.0 4906.1 4919.7 4935.9 4398.4 4411.9 4459.7 4465.4 4466.5 5627.2 5691.6 5723.1 5755.7 5756.8 6265.2 6282.6 6294.0 6308.6 6311.5 5659.9 5676.7 5683.1 5687.2 5727.2 5240.9 5322.9 5336.9 5368.0 5408.5 6260.0 6260.1 6272.0 6283.8 6292.8 6223.5 6277.9 6298.1 6302.4 6308.4 6169.1 6213.3 6239.3 6249.0 6289.7 6167.4 6186.3 6186.8 6187.8 6197.4 5240.7 6274.7 6281.6 6286.1 6288.5 4977.3 5986.8 6022.5 6023.9 6035.7 5997.3 6003.1 6039.8 6040.7 6058.3 5900.1 5900.3 5902.0 5902.8 5915.6 6005.2 6007.7 6010.3 6020.2 6091.7 5969.8 5975.9 5992.6 6014.8 6023.3 13:42:22 INFO - PROCESS | 1948 | 13:42:22 INFO - PROCESS | 1948 | [#1] ext.html Cycles:180 Average:64126.39 Median:35412.41 stddev:142481.43 (402.3%) stddev-sans-first:142801.01 13:42:22 INFO - PROCESS | 1948 | Values: 486.8 487.8 492.3 507.2 596.8 38960.8 40377.8 40557.0 40589.4 40628.6 44466.8 45102.8 45438.1 45455.9 45467.1 8368.8 8570.4 9454.3 9655.6 9691.0 11073.1 11342.5 11356.4 11389.9 11396.3 11364.0 11495.3 11499.7 11505.5 11517.3 8323.5 8514.8 8515.4 8517.3 11285.0 9478.3 11118.9 11269.7 11319.6 11384.8 38177.6 38838.6 38859.8 38886.2 38920.6 2827.1 2963.2 3256.2 3684.0 3975.7 28357.3 28684.3 29537.3 29766.0 30141.5 2752.4 2773.2 2836.0 2844.8 2902.2 495179.0 495715.0 496623.0 498633.0 499272.5 33887.8 34805.5 62529.0 62930.0 62991.7 34951.0 35300.6 35391.8 35433.0 35468.6 12560.9 14808.8 14824.3 15044.0 15055.3 11337.3 11601.8 12360.1 12575.2 12581.8 8110.7 8181.7 8196.3 8229.9 8270.6 3394.9 3416.8 3427.6 3430.3 3462.2 999.7 1002.8 1035.4 1106.7 1144.7 29781.0 29873.9 29985.6 30387.5 30525.2 984.8 1051.7 1104.4 1181.9 1238.0 15421.1 15513.4 15518.8 15859.0 16070.7 675154.0 678943.0 685942.0 686595.0 688486.0 62029.7 62472.0 62557.1 62658.4 62874.4 1347.3 1459.5 1486.1 1492.6 1494.0 28705.9 28897.0 29017.7 29679.3 29798.9 48525.3 49000.8 49046.5 49074.8 49106.0 356809.0 367009.0 367052.0 367092.0 368796.0 23637.9 25374.9 25677.7 26164.9 26456.7 41340.6 42656.5 42896.0 44477.6 44848.0 37215.3 37667.8 37788.1 38408.6 38849.0 35536.5 35943.6 36705.4 36753.6 37469.1 35450.3 35877.3 36097.6 36532.8 37202.8 31097.4 32542.7 32579.2 32626.9 32708.8 23798.3 24218.7 24243.0 24324.4 25205.9 13:42:22 INFO - PROCESS | 1948 | 13:42:22 INFO - PROCESS | 1948 | [#2] jquery.html Cycles:180 Average:35616.34 Median:405.19 stddev:103516.63 (25547.8%) stddev-sans-first:103773.17 13:42:22 INFO - PROCESS | 1948 | Values: 357.4 398.9 398.9 401.1 409.2 13720.5 18900.6 21062.1 21200.4 21215.4 14013.9 16071.4 20276.9 20554.9 20665.0 5822.6 6106.4 6165.0 6165.9 6169.3 5775.7 6043.4 6072.3 6091.8 6130.8 3927.7 4161.7 5734.8 6076.1 6077.9 6000.2 6052.7 6058.9 6075.3 6098.9 5652.6 5829.4 5852.7 5858.5 5860.2 12771.6 13009.9 13175.6 13292.4 13301.2 2135.3 2268.0 2488.2 2756.4 2765.2 8325.5 9138.4 9630.2 9962.8 10034.9 1682.8 1710.2 1753.2 1769.2 1841.1 133589.0 134118.3 134780.0 138044.0 139877.0 11577.9 11608.1 11627.9 11672.8 11750.2 14895.3 15010.9 15017.1 15031.3 15042.8 8408.9 8607.3 8628.5 8689.8 8753.4 7784.1 7935.5 8476.0 8509.8 8559.3 4462.6 4536.8 4548.6 4602.1 4651.0 1304.7 1617.6 1895.4 1931.5 1980.3 780.9 897.7 942.8 958.3 1025.7 18976.4 19417.6 20026.5 20197.9 20233.6 951.0 955.6 958.5 974.1 1031.6 8906.5 10646.9 10917.1 10947.9 10964.9 600867.0 617783.0 619047.0 620194.0 625690.9 104612.0 128230.7 137167.3 141246.0 148032.0 896.9 935.9 1014.9 1041.1 1041.8 18058.5 18213.5 18235.8 18268.3 18333.6 52660.7 55237.9 55450.0 56087.0 56309.4 79711.0 79773.8 79808.0 80649.0 83575.6 7920.5 8049.8 8084.3 8317.3 8363.2 8945.0 11836.2 12386.6 12803.4 12845.9 6205.4 7450.9 10589.0 10848.3 10984.8 8642.9 10858.5 10860.2 10966.0 11059.1 10483.6 11101.6 11324.6 11370.8 11475.5 6838.0 8038.2 8059.2 8143.5 8350.6 7793.3 7849.6 7863.4 8157.1 8345.2 13:42:22 INFO - PROCESS | 1948 | 13:42:22 INFO - PROCESS | 1948 | [#3] mootools.html Cycles:180 Average:5635.72 Median:5000.09 stddev:3139.40 (62.8%) stddev-sans-first:3131.97 13:42:22 INFO - PROCESS | 1948 | Values: 1387.0 1416.7 1632.1 1854.6 2006.9 7727.2 8485.2 8537.7 8733.5 8733.6 7453.4 8593.6 8600.4 8604.5 8606.7 2425.7 2450.3 2456.0 2456.8 2462.4 2395.5 2447.5 2449.1 2451.7 2458.9 2353.3 2367.0 2372.3 2385.1 2385.3 2377.4 2394.5 2394.8 2402.2 2426.1 2372.1 2377.4 2384.7 2385.1 2388.7 8448.5 8660.2 8762.5 8764.4 8774.9 5263.2 5390.2 5457.0 5459.6 5459.9 3033.0 3380.3 3479.0 3547.3 3553.1 965.6 968.6 979.8 987.7 1005.7 11193.3 11293.4 11465.0 11498.3 11532.8 4452.8 4732.6 4732.8 4740.6 4742.8 9085.0 9145.3 9151.3 9167.3 9170.1 4992.8 5230.7 5312.5 5315.4 5330.6 4358.2 4540.3 4740.3 4902.2 4910.6 3036.7 3687.5 3751.0 3767.8 3798.9 1203.5 1210.7 1213.3 1226.6 1228.1 661.4 797.6 867.8 870.0 1011.3 4913.7 5760.3 5923.0 6024.4 6110.4 901.6 935.0 963.8 965.2 995.0 3452.5 3832.9 3940.6 4021.4 4049.7 10136.5 10425.7 10698.3 10773.3 10851.3 10688.8 10854.1 10865.1 10867.5 10876.2 7796.6 7960.0 8181.4 8215.9 8275.8 5867.1 5949.2 5989.6 6015.0 6064.8 8638.6 10008.8 10056.9 10116.9 10128.2 9939.6 10051.3 10136.6 10406.2 10421.1 7018.7 7038.9 7161.0 7167.1 7174.8 7692.7 8223.8 8301.6 8311.0 8396.0 7347.2 7359.0 7391.5 7476.5 7519.0 7192.8 7280.0 7293.0 7461.0 7485.2 6918.6 6993.8 6995.7 7020.9 7023.9 4709.3 4990.0 4994.4 5005.7 5048.6 4956.7 5035.2 5043.9 5084.7 5268.3 13:42:22 INFO - PROCESS | 1948 | 13:42:22 INFO - PROCESS | 1948 | [#4] prototype.html Cycles:180 Average:4618.78 Median:5080.85 stddev:1457.05 (28.7%) stddev-sans-first:1424.92 13:42:22 INFO - PROCESS | 1948 | Values: 317.3 319.4 324.9 328.4 329.6 4575.8 4938.2 5175.3 5328.5 5332.5 5163.8 5219.7 5220.7 5226.5 5247.5 3789.4 3887.6 3926.2 4037.4 4061.6 3963.9 4034.3 4046.0 4052.3 4059.9 3211.0 3320.3 3979.3 3988.2 4022.0 3245.6 3500.3 3521.8 3877.5 4026.2 3503.9 3509.9 3514.7 3550.5 3554.2 4636.9 5034.1 5059.7 5060.0 5065.3 4408.9 4525.0 4584.4 4661.6 4679.0 4350.7 4834.0 5503.0 5525.0 5573.8 3909.9 3915.7 3923.5 3926.3 3932.7 5308.7 5400.9 5726.0 5769.0 5844.9 3332.5 3963.1 3966.3 3994.7 4026.9 3755.0 4032.0 4036.3 4061.7 4063.9 4392.5 4402.0 4618.5 4618.5 4636.9 4960.9 5133.0 5140.6 5556.9 5562.2 1407.9 1462.7 1489.8 1491.6 1493.3 844.0 957.5 991.7 1002.0 1004.2 4506.6 4532.4 5039.5 5096.4 5105.9 5098.6 5563.3 5577.6 5582.5 5708.8 4900.9 5179.3 5182.4 5195.5 5206.2 2577.6 2660.5 2772.0 3068.4 3316.3 5516.8 6128.0 6518.5 6554.4 6576.5 4922.4 6050.8 6413.5 6467.2 6489.0 5233.6 5509.4 6433.7 6514.8 6518.0 5243.7 5963.9 6261.9 6265.8 6281.8 5237.0 5410.8 6107.4 6128.6 6164.5 6105.0 6179.9 6482.6 6503.6 6517.7 3964.6 4123.4 4132.2 4149.2 4159.0 5308.5 6233.1 6248.9 6253.3 6283.0 4755.0 5048.7 5131.9 6060.5 6074.9 5332.6 5757.5 5995.0 6026.3 6073.2 4899.7 5166.8 5893.2 5911.3 5915.4 4789.7 5123.0 5315.5 5497.8 5519.6 5343.0 5372.6 5372.9 5388.6 5397.8 13:42:22 INFO - PROCESS | 1948 | 13:42:22 INFO - PROCESS | 1948 | [#5] yui.html Cycles:180 Average:17716.76 Median:59493.06 stddev:24980.21 (42.0%) stddev-sans-first:25017.33 13:42:22 INFO - PROCESS | 1948 | Values: 629.0 665.0 714.5 752.6 753.2 14048.8 14547.9 14553.7 14565.2 14587.4 13240.1 13800.2 14173.9 14216.9 14243.6 720.4 923.3 930.6 933.7 939.6 747.0 911.8 946.0 946.9 948.1 985.1 987.3 987.9 988.2 990.9 755.0 948.6 983.6 984.6 988.8 732.7 732.8 734.1 734.3 736.3 14922.6 14976.0 14992.0 15016.4 15049.5 12326.4 12352.8 12385.7 12663.9 12761.7 9848.8 9971.9 10046.9 10071.0 10708.3 3482.3 3531.3 3564.0 3579.7 3652.0 73575.6 74704.0 77642.0 77661.1 77996.6 9643.5 9646.4 9679.9 9884.1 10005.0 22142.3 22147.3 22167.7 22180.3 22257.8 6956.0 7146.0 7253.9 7457.9 7555.5 3941.3 3988.5 4003.7 4051.8 4093.9 3502.4 3584.1 3587.1 3593.2 3604.7 640.4 644.1 650.2 651.1 658.1 477.5 506.3 529.3 535.7 554.8 8045.4 8130.7 8286.9 8314.5 8416.7 507.6 547.7 575.8 628.4 637.1 3547.8 3822.9 3901.6 3926.2 4097.5 94827.5 95384.0 100669.2 100965.0 101678.0 77945.0 78782.6 78796.0 79927.2 80699.7 61029.0 61385.0 61854.0 62032.7 64252.7 7515.2 7642.0 7773.8 7836.3 7844.5 40462.4 41736.0 43644.0 43695.3 43715.1 58328.0 59099.1 59887.0 59965.8 60612.4 9058.8 10820.7 11061.2 11152.3 11330.3 11789.2 11846.9 11880.3 11898.0 12912.7 11348.8 11418.6 11522.4 11997.0 12314.0 11250.5 11314.3 11384.1 11619.5 11647.4 11048.3 11141.9 11183.8 11248.0 11469.0 9134.3 9167.7 9487.6 9628.0 9805.8 9453.3 9474.8 9506.0 9520.7 9694.3 13:42:22 INFO - PROCESS | 1948 | -------- Summary: end -------- 13:42:22 INFO - PROCESS | 1948 | 13:42:23 INFO - TEST-INFO | 1948: exit 0 13:42:23 INFO - TEST-OK | dromaeo_css | took 1115649ms 13:42:23 INFO - TEST-START | kraken 13:42:23 INFO - operating with platform_type : mac_ 13:42:23 INFO - Initialising browser for kraken test... 13:42:23 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpQ6BQuo/profile http://localhost:54191/getInfo.html) 13:42:25 INFO - PROCESS | 1953 | __metrics Screen width/height:1600/1200 13:42:25 INFO - PROCESS | 1953 | colorDepth:24 13:42:25 INFO - PROCESS | 1953 | Browser inner width/height: 1024/689 13:42:25 INFO - PROCESS | 1953 | __metrics 13:42:25 INFO - PROCESS | 1953 | 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" 13:42:25 ERROR - PROCESS | 1953 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:42:26 INFO - TEST-INFO | 1953: exit 0 13:42:26 INFO - Browser initialized. 13:42:26 INFO - Running cycle 1/1 for kraken test... 13:42:26 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpQ6BQuo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:42:38 INFO - PROCESS | 1955 | RSS: Main: 239616000 13:42:38 INFO - PROCESS | 1955 | 13:42:40 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54191/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54191/tests/kraken/driver.html?testName=audio-beat-detection) 13:42:41 INFO - PROCESS | 1955 | RSS: Main: 287264768 13:42:41 INFO - PROCESS | 1955 | 13:42:44 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54191/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54191/tests/kraken/driver.html?testName=audio-dft) 13:42:45 INFO - PROCESS | 1955 | RSS: Main: 299892736 13:42:45 INFO - PROCESS | 1955 | 13:42:48 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54191/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54191/tests/kraken/driver.html?testName=audio-fft) 13:42:49 INFO - PROCESS | 1955 | RSS: Main: 386473984 13:42:49 INFO - PROCESS | 1955 | 13:42:51 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54191/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54191/tests/kraken/driver.html?testName=audio-oscillator) 13:42:52 INFO - PROCESS | 1955 | RSS: Main: 287592448 13:42:52 INFO - PROCESS | 1955 | 13:42:54 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54191/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54191/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:42:54 INFO - PROCESS | 1955 | RSS: Main: 292966400 13:42:54 INFO - PROCESS | 1955 | 13:42:57 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54191/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54191/tests/kraken/driver.html?testName=imaging-darkroom) 13:42:58 INFO - PROCESS | 1955 | RSS: Main: 329814016 13:42:58 INFO - PROCESS | 1955 | 13:43:00 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54191/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54191/tests/kraken/driver.html?testName=imaging-desaturate) 13:43:01 INFO - PROCESS | 1955 | RSS: Main: 332591104 13:43:01 INFO - PROCESS | 1955 | 13:43:04 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54191/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54191/tests/kraken/driver.html?testName=json-parse-financial) 13:43:05 INFO - PROCESS | 1955 | RSS: Main: 328921088 13:43:05 INFO - PROCESS | 1955 | 13:43:06 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54191/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54191/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:43:07 INFO - PROCESS | 1955 | RSS: Main: 322179072 13:43:07 INFO - PROCESS | 1955 | 13:43:09 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54191/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54191/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:43:09 INFO - PROCESS | 1955 | RSS: Main: 328511488 13:43:09 INFO - PROCESS | 1955 | 13:43:11 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54191/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54191/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:43:12 INFO - PROCESS | 1955 | RSS: Main: 330850304 13:43:12 INFO - PROCESS | 1955 | 13:43:15 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54191/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54191/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:43:16 INFO - PROCESS | 1955 | RSS: Main: 335572992 13:43:16 INFO - PROCESS | 1955 | 13:43:18 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54191/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54191/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:43:19 INFO - PROCESS | 1955 | RSS: Main: 333500416 13:43:19 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:54191/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54191/tests/kraken/driver.html?testName=ai-astar) 13:43:21 INFO - PROCESS | 1955 | RSS: Main: 398942208 13:43:21 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | __start_tp_report 13:43:21 INFO - PROCESS | 1955 | _x_x_mozilla_page_load 13:43:21 INFO - PROCESS | 1955 | _x_x_mozilla_page_load_details 13:43:21 INFO - PROCESS | 1955 | |i|pagename|runs| 13:43:21 INFO - PROCESS | 1955 | |0;ai-astar;112;112;108;111;111;115;161;165;107;112 13:43:21 INFO - PROCESS | 1955 | |1;audio-beat-detection;157;125;144;174;118;143;143;117;165;112 13:43:21 INFO - PROCESS | 1955 | |2;audio-dft;186;254;238;182;185;184;183;183;186;182 13:43:21 INFO - PROCESS | 1955 | |3;audio-fft;80;74;90;93;55;57;58;103;115;75 13:43:21 INFO - PROCESS | 1955 | |4;audio-oscillator;94;94;140;79;79;80;126;80;77;127 13:43:21 INFO - PROCESS | 1955 | |5;imaging-gaussian-blur;88;84;89;86;87;83;85;85;86;90 13:43:21 INFO - PROCESS | 1955 | |6;imaging-darkroom;92;94;93;94;92;93;93;93;93;92 13:43:21 INFO - PROCESS | 1955 | |7;imaging-desaturate;87;86;86;85;85;86;83;100;136;85 13:43:21 INFO - PROCESS | 1955 | |8;json-parse-financial;58;58;58;60;58;58;61;77;60;58 13:43:21 INFO - PROCESS | 1955 | |9;json-stringify-tinderbox;65;69;65;72;69;67;67;67;67;67 13:43:21 INFO - PROCESS | 1955 | |10;stanford-crypto-aes;81;82;82;83;82;80;80;82;80;84 13:43:21 INFO - PROCESS | 1955 | |11;stanford-crypto-ccm;152;131;146;159;140;139;136;135;175;139 13:43:21 INFO - PROCESS | 1955 | |12;stanford-crypto-pbkdf2;177;169;173;170;170;173;168;168;171;168 13:43:21 INFO - PROCESS | 1955 | |13;stanford-crypto-sha256-iterative;70;68;69;70;70;69;68;70;70;67 13:43:21 INFO - PROCESS | 1955 | __end_tp_report 13:43:21 INFO - PROCESS | 1955 | __start_cc_report 13:43:21 INFO - PROCESS | 1955 | _x_x_mozilla_cycle_collect,2001 13:43:21 INFO - PROCESS | 1955 | __end_cc_report 13:43:21 INFO - PROCESS | 1955 | __startTimestamp1461617001469__endTimestamp 13:43:21 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | ------- Summary: start ------- 13:43:21 INFO - PROCESS | 1955 | Number of tests: 14 13:43:21 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | [#0] ai-astar Cycles:10 Average:121.40 Median:112.00 stddev:22.06 (19.7%) stddev-sans-first:23.13 13:43:21 INFO - PROCESS | 1955 | Values: 112.0 112.0 108.0 111.0 111.0 115.0 161.0 165.0 107.0 112.0 13:43:21 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:143.50 stddev:21.41 (14.9%) stddev-sans-first:21.79 13:43:21 INFO - PROCESS | 1955 | Values: 157.0 125.0 144.0 174.0 118.0 143.0 143.0 117.0 165.0 112.0 13:43:21 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | [#2] audio-dft Cycles:10 Average:196.30 Median:185.50 stddev:26.50 (14.3%) stddev-sans-first:27.85 13:43:21 INFO - PROCESS | 1955 | Values: 186.0 254.0 238.0 182.0 185.0 184.0 183.0 183.0 186.0 182.0 13:43:21 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | [#3] audio-fft Cycles:10 Average:80.00 Median:74.50 stddev:20.34 (27.3%) stddev-sans-first:21.57 13:43:21 INFO - PROCESS | 1955 | Values: 80.0 74.0 90.0 93.0 55.0 57.0 58.0 103.0 115.0 75.0 13:43:21 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:79.50 stddev:24.11 (30.3%) stddev-sans-first:25.53 13:43:21 INFO - PROCESS | 1955 | Values: 94.0 94.0 140.0 79.0 79.0 80.0 126.0 80.0 77.0 127.0 13:43:21 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:86.50 stddev:2.21 (2.6%) stddev-sans-first:2.26 13:43:21 INFO - PROCESS | 1955 | Values: 88.0 84.0 89.0 86.0 87.0 83.0 85.0 85.0 86.0 90.0 13:43:21 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 13:43:21 INFO - PROCESS | 1955 | Values: 92.0 94.0 93.0 94.0 92.0 93.0 93.0 93.0 93.0 92.0 13:43:21 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | [#7] imaging-desaturate Cycles:10 Average:91.90 Median:85.50 stddev:16.20 (18.9%) stddev-sans-first:17.08 13:43:21 INFO - PROCESS | 1955 | Values: 87.0 86.0 86.0 85.0 85.0 86.0 83.0 100.0 136.0 85.0 13:43:21 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:59.00 stddev:5.87 (10.0%) stddev-sans-first:6.15 13:43:21 INFO - PROCESS | 1955 | Values: 58.0 58.0 58.0 60.0 58.0 58.0 61.0 77.0 60.0 58.0 13:43:21 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:2.07 (3.1%) stddev-sans-first:1.99 13:43:21 INFO - PROCESS | 1955 | Values: 65.0 69.0 65.0 72.0 69.0 67.0 67.0 67.0 67.0 67.0 13:43:21 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:1.35 (1.6%) stddev-sans-first:1.41 13:43:21 INFO - PROCESS | 1955 | Values: 81.0 82.0 82.0 83.0 82.0 80.0 80.0 82.0 80.0 84.0 13:43:21 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:143.00 stddev:13.41 (9.4%) stddev-sans-first:14.00 13:43:21 INFO - PROCESS | 1955 | Values: 152.0 131.0 146.0 159.0 140.0 139.0 136.0 135.0 175.0 139.0 13:43:21 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:170.50 stddev:2.91 (1.7%) stddev-sans-first:2.00 13:43:21 INFO - PROCESS | 1955 | Values: 177.0 169.0 173.0 170.0 170.0 173.0 168.0 168.0 171.0 168.0 13:43:21 INFO - PROCESS | 1955 | 13:43:21 INFO - PROCESS | 1955 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:70.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 13:43:21 INFO - PROCESS | 1955 | Values: 70.0 68.0 69.0 70.0 70.0 69.0 68.0 70.0 70.0 67.0 13:43:21 INFO - PROCESS | 1955 | -------- Summary: end -------- 13:43:21 INFO - PROCESS | 1955 | 13:43:22 INFO - TEST-INFO | 1955: exit 0 13:43:22 INFO - TEST-OK | kraken | took 58832ms 13:43:22 INFO - SUITE-END | took 1174s 13:43:22 INFO - Completed test suite (00:19:34) 13:43:22 INFO - javascript benchmark 13:43:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2758.3104223944015, 3407.437772767492, 3433.3648275069113, 3443.8966830995046, 3486.808225547594, 5615.2700148980675, 5639.492445679888, 5651.6891570963635, 5675.978323901706, 5710.7430165642545, 5661.264035675356, 5677.290338707661, 5724.599278050528, 5828.562857785672, 5831.4751672349485, 4641.651876109288, 4743.454502732196, 5001.324821149153, 5087.7710503027265, 5211.478852114796, 5161.612879034069, 5194.454582268864, 5218.921716174261, 5223.0, 5228.843134705965, 5067.417247016585, 5137.974310128463, 5150.97424512875, 5152.819651312224, 5177.352830896138, 5141.691498510064, 5159.484051594848, 5162.948370516285, 5170.767315470813, 5175.146100893348, 5051.848444546669, 5059.139946209153, 5141.100307446182, 5147.742612869341, 5152.458991805881, 5574.358948720908, 5581.6371935824445, 5588.804391846266, 5589.664620122765, 5607.243022191993, 6076.756929722806, 6172.7530898764, 6174.104754810573, 6189.38106189382, 6192.783252586138, 5920.763169473216, 5990.880182396371, 6185.87628247437, 6240.1263823064355, 6241.563090583661, 5773.740181691834, 5774.48029677331, 5782.306123265193, 5784.566157538202, 5812.273465816773, 6247.187865577446, 6250.218722659668, 6262.499000079983, 6275.184226050585, 6297.2128483939505, 5947.881042379128, 6023.457065635116, 6029.231128814905, 6047.758089676452, 6070.0591408331775, 6112.083187521907, 6124.960759790135, 6152.846178845564, 6205.22434695663, 6218.595791273553, 6102.298235702951, 6150.07748837669, 6165.907511387333, 6175.104609831549, 6184.598001130003, 6233.719482623293, 6246.6876656167005, 6253.280872699698, 6253.78111766086, 6257.812265632038, 4783.5933945614315, 4864.975675121602, 4906.1414252505665, 4919.680220785637, 4935.901281974412, 4398.3842262083335, 4411.919079825463, 4459.687821852504, 4465.397171381822, 4466.486354069324, 5627.212190293362, 5691.573132015115, 5723.141528770634, 5755.740991655385, 5756.769729210785, 6265.248170219512, 6282.560220784592, 6294.0, 6308.589941653778, 6311.495080393557, 5659.858503537363, 5676.7161641918565, 5683.147527870769, 5687.1753595729215, 5727.198192253088, 5240.9475905241225, 5322.946770532322, 5336.866578335573, 5368.0, 5408.513233808976, 6260.0, 6260.060990851409, 6271.9686401568615, 6283.8114856554375, 6292.811215663537, 6223.502119830493, 6277.905831412624, 6298.0552917062805, 6302.401271879165, 6308.400701933309, 6169.136320914986, 6213.285472170758, 6239.344868788712, 6248.968755156195, 6289.7484100635465, 6167.383261673796, 6186.257649082139, 6186.783462578788, 6187.783427580193, 6197.442230199304, 5240.68555886648, 6274.717637706223, 6281.560290779602, 6286.119943207863, 6288.5283603728985, 4977.303177555217, 5986.820395388146, 6022.488088512526, 6023.909641355471, 6035.69821508914, 5997.31030931431, 6003.099535069775, 6039.849003774941, 6040.667763272886, 6058.3335833057445, 5900.144479050599, 5900.291964964232, 5901.9966605678, 5902.793402230901, 5915.615484993462, 6005.189299444519, 6007.681823813654, 6010.278766548042, 6020.187274718032, 6091.664958427329, 5969.791057312973, 5975.910361344497, 5992.64044157352, 6014.849628759316, 6023.27720673522], "value": 5652.035914682408, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.84664330735836, 487.82682147837517, 492.3033907021564, 507.22394736053826, 596.8209537138857, 38960.80519597402, 40377.79811100944, 40557.0, 40589.39115913256, 40628.59371406289, 44466.7776661117, 45102.77448612761, 45438.09123817521, 45455.863603409845, 45467.0906581869, 8368.832623347529, 8570.357223208253, 9454.290928180397, 9655.613775448974, 9690.951545242264, 11073.058790002859, 11342.546298148065, 11356.375399353032, 11389.943050284737, 11396.25924314921, 11363.977242048255, 11495.310281383145, 11499.712507187303, 11505.539778408895, 11517.251378660401, 8323.542205178743, 8514.829703405898, 8515.403921725481, 8517.318614510887, 11285.0, 9478.336516443851, 11118.944405278004, 11269.661910142628, 11319.603813866557, 11384.772304553862, 38177.618223817684, 38838.61161388378, 38859.8057009716, 38886.22227555461, 38920.61079389198, 2827.0529372660185, 2963.2147480917574, 3256.169676732418, 3683.963160368389, 3975.662068724162, 28357.291067723265, 28684.282892927637, 29537.26156846096, 29766.0, 30141.547876781864, 2752.4357506711076, 2773.237359726071, 2836.0357478457217, 2844.7866410019333, 2902.2454161917844, 495179.0, 495715.0, 496623.0, 498633.0, 499272.5036374795, 33887.83056084704, 34805.47791783125, 62529.0, 62929.96560275167, 62991.6850415745, 34951.0, 35300.64699353025, 35391.82304088463, 35433.0, 35468.645313546534, 12560.937195314147, 14808.777868331983, 14824.258787060604, 15044.022138560958, 15055.322510487054, 11337.319760814378, 11601.76796464066, 12360.134790564574, 12575.182613130117, 12581.811272830915, 8110.716124935599, 8181.67273309061, 8196.303314218358, 8229.876551851727, 8270.627821748036, 3394.8966585859694, 3416.8462419191196, 3427.5715535558056, 3430.3310854383653, 3462.23830757233, 999.715081201854, 1002.8445590933417, 1035.4266671956213, 1106.6956586938495, 1144.6508814811395, 29780.957666482, 29873.850630746707, 29985.550216746768, 30387.544186837215, 30525.236869078006, 984.7981163861391, 1051.7423231308378, 1104.3594715065242, 1181.9113566482376, 1237.9876201238053, 15421.074735515906, 15513.379464821506, 15518.767218491732, 15859.0, 16070.678586428206, 675154.0, 678943.0, 685942.0, 686595.0, 688486.0, 62029.68985155045, 62472.0, 62557.06164407537, 62658.373416265254, 62874.37125628777, 1347.2994043097535, 1459.4599998000594, 1486.0712054965647, 1492.5671555248857, 1494.0, 28705.856470717514, 28897.0, 29017.69420376046, 29679.25801854971, 29798.8510057457, 48525.27212091892, 49000.754996224794, 49046.50953490562, 49074.75462622664, 49106.0, 356809.0, 367009.0, 367052.0, 367092.0, 368796.0, 23637.881810590836, 25374.873125634254, 25677.743222567537, 26164.869175654, 26456.735432645426, 41340.586594134875, 42656.54005070041, 42896.0, 44477.55522444864, 44848.0, 37215.255694886495, 37667.81166094152, 37788.05529861776, 38408.615913840506, 38849.0, 35536.46695299521, 35943.64056359403, 36705.44941825821, 36753.63246367502, 37469.06327341838, 35450.256777738665, 35877.28245435129, 36097.63902361048, 36532.81733591422, 37202.8139859299, 31097.44512774307, 32542.67457325491, 32579.18552036218, 32626.858059967788, 32708.836455817567, 23798.286051418487, 24218.749999999578, 24243.0, 24324.39189020218, 25205.87397063003], "value": 18492.685582376158, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.3942168025197, 398.8783421056577, 398.94614227079336, 401.1375542583447, 409.2388158026071, 13720.456052365262, 18900.62198756024, 21062.052207650653, 21200.36398908033, 21215.363539093814, 14013.859861401383, 16071.357145714157, 20276.89861550694, 20554.89722551385, 20665.0, 5822.563307751914, 6106.419890110433, 6165.0444181152, 6165.938340616582, 6169.290531588857, 5775.740091695884, 6043.395660433944, 6072.271327440713, 6091.817245482643, 6130.785422510213, 3927.725059245854, 4161.667066634662, 5734.770609175628, 6076.149339092531, 6077.939220607804, 6000.249968753906, 6052.697365131726, 6058.909116363258, 6075.301340345851, 6098.908516372214, 5652.604317697763, 5829.36777702244, 5852.736626851802, 5858.531317494633, 5860.238169038041, 12771.616851494377, 13009.869901301056, 13175.60473185806, 13292.401841917137, 13301.201927884262, 2135.3273718778537, 2267.965980510294, 2488.216211893266, 2756.4073724149202, 2765.2119146043483, 8325.500469971821, 9138.360314777969, 9630.18143457807, 9962.800743985079, 10034.89965100347, 1682.8064772551068, 1710.2474911039228, 1753.1935309757528, 1769.2480695704403, 1841.0978620476005, 133589.0, 134118.3294083533, 134780.0, 138044.0, 139877.0, 11577.884221157681, 11608.129390295762, 11627.883721162849, 11672.824907626393, 11750.177487575787, 14895.255237238094, 15010.924945375422, 15017.098974061591, 15031.323590438456, 15042.849571504365, 8408.873866892001, 8607.311415086779, 8628.52543110135, 8689.826203475895, 8753.431026983226, 7784.143744188134, 7935.484193527518, 8476.0, 8509.787255318543, 8559.315254779603, 4462.598366147063, 4536.77316134192, 4548.590626843534, 4602.1025899949855, 4651.0, 1304.7260075384277, 1617.563257920355, 1895.3934740882785, 1931.51712071982, 1980.3068376537854, 780.9062912450429, 897.6858099665066, 942.8167649599845, 958.3148049144895, 1025.6769117727893, 18976.43070707881, 19417.611647767248, 20026.499337516678, 20197.889116098755, 20233.595328093357, 950.9919485345417, 955.5699935029264, 958.4872093429982, 974.0746291023556, 1031.5976769060073, 8906.510141942126, 10646.870625874855, 10917.126629869592, 10947.945260273807, 10964.890351096547, 600867.0, 617783.0, 619047.0, 620194.0, 625690.8715456394, 104612.0, 128230.71769282375, 137167.31416343054, 141246.0, 148032.0, 896.8878590547674, 935.9391639543544, 1014.852846337277, 1041.146260066738, 1041.8020576090519, 18058.548536286697, 18213.54466138357, 18235.81764182341, 18268.269269229615, 18333.633327333646, 52660.73669631627, 55237.89524209413, 55450.0, 56087.0, 56309.43690563042, 79711.0, 79773.77912543675, 79808.0, 80649.0, 83575.58212209144, 7920.495105929855, 8049.798755030937, 8084.272415482635, 8317.251447369767, 8363.201911588794, 8945.0, 11836.171467997157, 12386.5664701735, 12803.35983200855, 12845.871541284467, 6205.410486003822, 7450.850982980419, 10589.0, 10848.294860834021, 10984.780304394028, 8642.913570864463, 10858.511366988663, 10860.185486088732, 10965.95823396776, 11059.115270778479, 10483.58065677395, 11101.5559377624, 11324.6036388726, 11370.829437558277, 11475.540978360772, 6838.0, 8038.15599362082, 8059.153788852086, 8143.51138931666, 8350.582470876554, 7793.2596403341595, 7849.626315394669, 7863.410244231591, 8157.143499932659, 8345.207205315486], "value": 9216.833174984975, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.9861301386984, 1416.70957453722, 1632.126812155497, 1854.5997771682378, 2006.9297574584884, 7727.227277272277, 8485.151484851513, 8537.719342098688, 8733.475991440519, 8733.563321833899, 7453.4409919256, 8593.613287402066, 8600.35497337699, 8604.483730976146, 8606.741797746063, 2425.745296743843, 2450.277168235375, 2455.9631605525933, 2456.7666071723247, 2462.384403899025, 2395.5089206712582, 2447.5104979004273, 2449.1305586516796, 2451.6935383077116, 2458.864762438065, 2353.2822489140804, 2366.96449553256, 2372.264597974625, 2385.0817435287454, 2385.2605692235375, 2377.3699969508093, 2394.521095780842, 2394.832361734679, 2402.2072716003677, 2426.078090325665, 2372.1223147435385, 2377.358113309414, 2384.6899903012495, 2385.1175065225802, 2388.749181335952, 8448.450850694746, 8660.17728315809, 8762.474251544927, 8764.43031202976, 8774.947006359278, 5263.236830659571, 5390.245365648812, 5456.972715136439, 5459.617826752129, 5459.863503412406, 3033.0294305822144, 3380.323935212967, 3478.9826050869838, 3547.343741407848, 3553.1472446612884, 965.6427121964848, 968.5980318167951, 979.8285300072458, 987.6888780034266, 1005.653049697853, 11193.328400296008, 11293.435328233638, 11464.999999999916, 11498.31010139386, 11532.827007594893, 4452.777361131995, 4732.645051621143, 4732.763361831895, 4740.5733483986605, 4742.762861856893, 9084.954575227213, 9145.268378529701, 9151.267898568098, 9167.312451566158, 9170.08299170091, 4992.750362481861, 5230.712310822942, 5312.468753124734, 5315.388730296066, 5330.600204984642, 4358.193734159191, 4540.318952157203, 4740.336352910595, 4902.166631672624, 4910.558049775537, 3036.6659667436566, 3687.502187204747, 3751.0, 3767.830447629863, 3798.867039653599, 1203.4524291447372, 1210.673118258083, 1213.3266037349356, 1226.6197478781605, 1228.0543981134476, 661.3981277037968, 797.6490344248512, 867.7743786615525, 870.0168809245639, 1011.2870426349406, 4913.65604407688, 5760.251167348218, 5923.0, 6024.397560244028, 6110.358412366726, 901.6303315640556, 935.0275713258271, 963.7783309838776, 965.2278177458005, 995.0397866059287, 3452.4993875887853, 3832.9233415331537, 3940.566537680853, 4021.3766866135797, 4049.655779258796, 10136.543855526372, 10425.687229383131, 10698.304610200468, 10773.299735517166, 10851.348919064882, 10688.78622427547, 10854.131669466424, 10865.076468500267, 10867.510962006729, 10876.238663293652, 7796.610169491502, 7960.044794624682, 8181.3863960203225, 8215.876761848576, 8275.793105172419, 5867.090600956859, 5949.167116603592, 5989.610675306091, 6015.037593984942, 6064.787732429344, 8638.611262493077, 10008.84986725185, 10056.899431005597, 10116.949415252877, 10128.240381971234, 9939.552720127756, 10051.346662466916, 10136.645217417356, 10406.219533535166, 10421.114205292331, 7018.719251229893, 7038.929610703827, 7160.964195178991, 7167.139943206848, 7174.784756457315, 7692.653830577526, 8223.753287401387, 8301.584920753818, 8311.0, 8396.0, 7347.228541003332, 7359.0, 7391.519551229153, 7476.514026588255, 7519.022527071445, 7192.784216473514, 7279.963600182177, 7293.0, 7461.0, 7485.214052524624, 6918.5502942308585, 6993.825154371181, 6995.650217489004, 7020.859582808417, 7023.929760702327, 4709.293605959134, 4989.975050124726, 4994.425641051325, 5005.749712514433, 5048.596112310933, 4956.653034287565, 5035.16919708244, 5043.87390315245, 5084.669496482717, 5268.315119034501], "value": 4533.832800507488, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.26236500137185, 319.43778949049675, 324.8570628923275, 328.35642141402843, 329.64398449674354, 4575.771211439427, 4938.160512712839, 5175.3272074630295, 5328.547073498752, 5332.546733527645, 5163.845084647457, 5219.660722053064, 5220.738963051842, 5226.498246175062, 5247.504461228551, 3789.393697008479, 3887.6306750858766, 3926.1951299983434, 4037.37420699792, 4061.5938406159444, 3963.8810835674976, 4034.3257548117494, 4046.037671729209, 4052.3111071117833, 4059.8985025374304, 3211.020638705194, 3320.2695407010538, 3979.343408337621, 3988.222296652154, 4022.0, 3245.6267529234206, 3500.3174380995715, 3521.8239088045493, 3877.4908707619647, 4026.1545075534173, 3503.8598456061727, 3509.894703158909, 3514.6836784689244, 3550.5265314894286, 3554.2180720241504, 4636.930446043312, 5034.09386310464, 5059.721715305656, 5060.0, 5065.290859279704, 4408.911821763579, 4524.954750452519, 4584.426946631671, 4661.557152070582, 4678.95321046792, 4350.694132109987, 4834.0, 5503.010317519806, 5524.977879092381, 5573.804916827891, 3909.9052265365744, 3915.6882444381167, 3923.4899463069905, 3926.2736393767245, 3932.7443716158646, 5308.70802105884, 5400.892816972511, 5725.971370143123, 5768.990551566663, 5844.88310233793, 3332.5334453176574, 3963.128111815396, 3966.345552983725, 3994.701721940323, 4026.8993275168355, 3755.0, 4032.0, 4036.3340048891605, 4061.7156799023783, 4063.89840253996, 4392.516823149451, 4401.977990110029, 4618.49196588375, 4618.538146185422, 4636.907261854812, 4960.851174464772, 5132.9743351283005, 5140.588752899759, 5556.91664625031, 5562.193481945095, 1407.8873690104767, 1462.7293950619169, 1489.8286697029764, 1491.5898128014883, 1493.3056128900114, 844.0125053687201, 957.5212393803098, 991.7124034030195, 1002.0230275481348, 1004.2016596805557, 4506.639468842484, 4532.410786597788, 5039.521245481674, 5096.413912400121, 5105.923411148836, 5098.59211263098, 5563.304586926634, 5577.581681373913, 5582.525485333792, 5708.828735137869, 4900.852974410774, 5179.306760484527, 5182.378114626269, 5195.532402083831, 5206.219067139884, 2577.587585986233, 2660.467906418724, 2771.9743694832637, 3068.4170007698467, 3316.336732653479, 5516.7517461714315, 6128.0, 6518.543701940914, 6554.442872355903, 6576.539642224999, 4922.360093187935, 6050.818475445743, 6413.518986076063, 6467.223933127961, 6489.0, 5233.5551478124025, 5509.449055094458, 6433.710483028275, 6514.837129071811, 6517.967410162919, 5243.711595862264, 5963.850903727442, 6261.935470969855, 6265.780697675559, 6281.780137695158, 5236.9738151309, 5410.810621628224, 6107.389261073857, 6128.571000029955, 6164.4760195382105, 6105.0, 6179.918514260076, 6482.611043337415, 6503.642299673564, 6517.706703198272, 3964.6035396460125, 4123.422720819148, 4132.173565287015, 4149.211649786652, 4158.9584104159785, 5308.548773354154, 6233.065040244, 6248.8752024636005, 6253.343398943045, 6283.0, 4755.048990201904, 5048.697078175322, 5131.923021154611, 6060.545459090497, 6074.908876366946, 5332.626716129834, 5757.453041961007, 5995.0, 6026.276846778414, 6073.210482637229, 4899.706017638953, 5166.793328266827, 5893.233879595797, 5911.349751527243, 5915.378885217162, 4789.664723469324, 5122.97642431245, 5315.521603055744, 5497.8075767347955, 5519.558435325244, 5342.973285133549, 5372.570194384518, 5372.919406208832, 5388.595855310946, 5397.7840886365675], "value": 4171.98218575866, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.012450452789, 664.9567778094425, 714.4657071283517, 752.5522314223042, 753.1978442958252, 14048.789268160974, 14547.854521454783, 14553.708925821504, 14565.198914059722, 14587.416503339868, 13240.08535572346, 13800.1719896806, 14173.929130354334, 14216.857831421683, 14243.643908902282, 720.4164626652403, 923.2982932970923, 930.623097645453, 933.6965486217007, 939.5724945149974, 746.9878314883337, 911.7811725185974, 946.0303189231024, 946.857971304303, 948.0898337595917, 985.1232403161192, 987.279286121132, 987.9407235565889, 988.2439933450916, 990.9207263418946, 754.97357592484, 948.6347756113877, 983.6311383231289, 984.6307634637011, 988.8022395520925, 732.6739600877612, 732.809469537924, 734.0750654175723, 734.2547314475811, 736.333618075637, 14922.62693432662, 14976.0, 14992.0, 15016.399344026226, 15049.54851354461, 12326.445309961073, 12352.814707779391, 12385.690357741038, 12663.936680316632, 12761.744765104646, 9848.803023939552, 9971.850422243671, 10046.9497652512, 10071.043250891154, 10708.30396024256, 3482.3035392921515, 3531.2760884018717, 3563.982180089109, 3579.731520136, 3652.0322114639644, 73575.63212183905, 74704.0, 77642.0, 77661.05847353805, 77996.61001694955, 9643.517824108767, 9646.372985755903, 9679.903200968041, 9884.11043006133, 10005.04952029556, 22142.346512825203, 22147.335579932627, 22167.667484987738, 22180.334589962327, 22257.777422225896, 6955.965220173866, 7145.999560061596, 7253.891191632129, 7457.888131678029, 7555.546667199876, 3941.329973904386, 3988.521377434726, 4003.739756915791, 4051.817668204879, 4093.9181216375505, 3502.3695734767475, 3584.086058055231, 3587.121155316964, 3593.191531905353, 3604.675579197885, 640.4140211706236, 644.0693198328464, 650.1677852349001, 651.0527182948798, 658.0721183131761, 477.54496219849364, 506.3215291509322, 529.3198240261246, 535.6598559914482, 554.8418700670289, 8045.396595255379, 8130.715424960216, 8286.917130828615, 8314.542700151429, 8416.705415310435, 507.55588859747724, 547.690554836524, 575.8445219790633, 628.4375483941847, 637.1175921348872, 3547.769394989369, 3822.8853134406013, 3901.6293452122572, 3926.1951299983434, 4097.467329247238, 94827.52586237024, 95384.0, 100669.15313734146, 100965.0, 101678.0, 77945.0, 78782.6060869692, 78796.0, 79927.20072799314, 80699.73335451918, 61029.0, 61385.0, 61853.9999999991, 62032.68983655143, 64252.678736606016, 7515.210902855121, 7641.961790191013, 7773.844523109619, 7836.255555722198, 7844.450888437755, 40462.393064103475, 41736.0, 43644.0, 43695.344569832116, 43715.12569748651, 58328.0, 59099.11351329648, 59887.0, 59965.8006839852, 60612.39387606244, 9058.818823623622, 10820.67537973862, 11061.225714199929, 11152.330860148417, 11330.320180789178, 11789.174757766874, 11846.940765296464, 11880.34658093813, 11898.0, 12912.677183070498, 11348.773024539629, 11418.600348987746, 11522.366269854903, 11997.040236780862, 12314.014878809494, 11250.493727782106, 11314.321140731583, 11384.089272858317, 11619.535218591162, 11647.359395233343, 11048.281861679287, 11141.88858111441, 11183.776324473627, 11248.0, 11469.0, 9134.257189688624, 9167.724968250963, 9487.573059212215, 9628.037196280316, 9805.75485612837, 9453.291003174927, 9474.810503790024, 9506.049395060438, 9520.666776662783, 9694.32139750239], "value": 6800.288627981993, "unit": "score"}], "name": "dromaeo_css", "value": 7060.910008799146, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 108.0, 111.0, 111.0, 115.0, 161.0, 165.0, 107.0, 112.0], "value": 121.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 144.0, 174.0, 118.0, 143.0, 143.0, 117.0, 165.0, 112.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 254.0, 238.0, 182.0, 185.0, 184.0, 183.0, 183.0, 186.0, 182.0], "value": 196.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 74.0, 90.0, 93.0, 55.0, 57.0, 58.0, 103.0, 115.0, 75.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 140.0, 79.0, 79.0, 80.0, 126.0, 80.0, 77.0, 127.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 89.0, 86.0, 87.0, 83.0, 85.0, 85.0, 86.0, 90.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 93.0, 94.0, 92.0, 93.0, 93.0, 93.0, 93.0, 92.0], "value": 92.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 85.0, 85.0, 86.0, 83.0, 100.0, 136.0, 85.0], "value": 91.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 60.0, 58.0, 58.0, 61.0, 77.0, 60.0, 58.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 65.0, 72.0, 69.0, 67.0, 67.0, 67.0, 67.0, 67.0], "value": 67.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 83.0, 82.0, 80.0, 80.0, 82.0, 80.0, 84.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 131.0, 146.0, 159.0, 140.0, 139.0, 136.0, 135.0, 175.0, 139.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 169.0, 173.0, 170.0, 170.0, 173.0, 168.0, 168.0, 171.0, 168.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 70.0, 70.0, 69.0, 68.0, 70.0, 70.0, 67.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1500.8999999999999, "alertThreshold": 2.0}]} 13:43:22 INFO - Return code: 0 13:43:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:43:22 ERROR - # TBPL SUCCESS # 13:43:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:43:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:43:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:43:22 INFO - 2016-04-25 13:43:22.783 screenresolution[1959:19537] starting screenresolution argv=screenresolution get 13:43:22 INFO - 2016-04-25 13:43:22.785 screenresolution[1959:19537] Display 0: 1600x1200x32@60 13:43:22 INFO - 2016-04-25 13:43:22.791 screenresolution[1960:19540] starting screenresolution argv=screenresolution list 13:43:22 INFO - Available Modes on Display 0 13:43:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:43:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:43:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:43:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:43:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:43:23 INFO - Intel Iris: 13:43:23 INFO - Chipset Model: Intel Iris 13:43:23 INFO - Type: GPU 13:43:23 INFO - Bus: Built-In 13:43:23 INFO - VRAM (Dynamic, Max): 1536 MB 13:43:23 INFO - Vendor: Intel (0x8086) 13:43:23 INFO - Device ID: 0x0a2e 13:43:23 INFO - Revision ID: 0x0009 13:43:23 INFO - Displays: 13:43:23 INFO - Display: 13:43:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:43:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:43:23 INFO - Display Serial Number: 1600x1200 60 13:43:23 INFO - Main Display: Yes 13:43:23 INFO - Mirror: Off 13:43:23 INFO - Online: Yes 13:43:23 INFO - Rotation: Supported 13:43:23 INFO - Return code: 0 13:43:23 INFO - Running post-action listener: _resource_record_post_action 13:43:23 INFO - Running post-run listener: _resource_record_post_run 13:43:24 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 651264; Write bytes: 693776896; Read time: 10; Write time: 2067 13:43:24 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 373983744; Write bytes: 368687104; Read time: 28094; Write time: 855 13:43:24 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 651264; Write bytes: 295598592; Read time: 10; Write time: 1155 13:43:24 INFO - Running post-run listener: _upload_blobber_files 13:43:24 INFO - Blob upload gear active. 13:43:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:43:24 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 13:43:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:43:24 INFO - (blobuploader) - INFO - Open directory for files ... 13:43:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:43:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:43:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:25 INFO - (blobuploader) - INFO - Done attempting. 13:43:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:43:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:43:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:26 INFO - (blobuploader) - INFO - Done attempting. 13:43:26 INFO - (blobuploader) - INFO - Iteration through files over. 13:43:26 INFO - Return code: 0 13:43:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:43:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:43:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/37a491c33f67c23a0f78e02f895bf1c0f1db5f3dcc45705d9ae36f4eed5d6a65bfa37b38f5b906d81428617a9b02e30fe450f7ac8e4f230fbf22e17fb111ecbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/764f3ed11e048c91d5860341793057b71e66140a48d619e24cd583758d9694ca6a57973c4acf779ab4a45957f5c577d21f556d61e8f8baea3dca43e4857b1970"} 13:43:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:43:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:43:26 INFO - Contents: 13:43:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/37a491c33f67c23a0f78e02f895bf1c0f1db5f3dcc45705d9ae36f4eed5d6a65bfa37b38f5b906d81428617a9b02e30fe450f7ac8e4f230fbf22e17fb111ecbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/764f3ed11e048c91d5860341793057b71e66140a48d619e24cd583758d9694ca6a57973c4acf779ab4a45957f5c577d21f556d61e8f8baea3dca43e4857b1970"} 13:43:26 INFO - Running post-run listener: copy_logs_to_upload_dir 13:43:26 INFO - Copying logs to upload dir... 13:43:26 INFO - mkdir: /builds/slave/test/build/upload/logs 13:43:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.833690 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-25 13:43:26.840026) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 13:43:26.847488) ========= 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.cPvtyivwEb/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.vNLxHyw02A/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/37a491c33f67c23a0f78e02f895bf1c0f1db5f3dcc45705d9ae36f4eed5d6a65bfa37b38f5b906d81428617a9b02e30fe450f7ac8e4f230fbf22e17fb111ecbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/764f3ed11e048c91d5860341793057b71e66140a48d619e24cd583758d9694ca6a57973c4acf779ab4a45957f5c577d21f556d61e8f8baea3dca43e4857b1970"} build_url:https://queue.taskcluster.net/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011095 build_url: 'https://queue.taskcluster.net/v1/task/XvB7MrnQRZGwHjvWHRiGbg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/37a491c33f67c23a0f78e02f895bf1c0f1db5f3dcc45705d9ae36f4eed5d6a65bfa37b38f5b906d81428617a9b02e30fe450f7ac8e4f230fbf22e17fb111ecbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/764f3ed11e048c91d5860341793057b71e66140a48d619e24cd583758d9694ca6a57973c4acf779ab4a45957f5c577d21f556d61e8f8baea3dca43e4857b1970"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 13:43:26.874787) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:43:26.875082) ========= 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.cPvtyivwEb/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.vNLxHyw02A/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.005110 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:43:26.926541) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 13:43:26.926823) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 13:43:26.930194) ========= ========= Total master_lag: 0.18 =========