builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0146 starttime: 1465249815.98 results: success (0) buildid: 20160606125325 builduid: ab6de4c621424cea86326d1844440e03 revision: 5fe894994e955cf7f6d85337492beebe562ea6c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 14:50:15.975462) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 14:50:15.980306) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 14:50:15.980593) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 14:50:16.023872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:50:16.024214) ========= 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.66WHtbp6VC/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.yzrHO0tX9K/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-06 14:50:16-- 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% 25.3M=0s 2016-06-06 14:50:16 (25.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120214 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:50:16.165223) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:50:16.165505) ========= 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.66WHtbp6VC/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.yzrHO0tX9K/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.029740 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:50:16.215110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 14:50:16.215454) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5fe894994e955cf7f6d85337492beebe562ea6c5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5fe894994e955cf7f6d85337492beebe562ea6c5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.66WHtbp6VC/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.yzrHO0tX9K/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-06 14:50:16,295 truncating revision to first 12 chars 2016-06-06 14:50:16,296 Setting DEBUG logging. 2016-06-06 14:50:16,296 attempt 1/10 2016-06-06 14:50:16,296 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5fe894994e95?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 14:50:17,326 unpacking tar archive at: mozilla-beta-5fe894994e95/testing/mozharness/ program finished with exit code 0 elapsedTime=1.287852 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 14:50:17.524521) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 14:50:17.524823) ========= script_repo_revision: 5fe894994e955cf7f6d85337492beebe562ea6c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 14:50:17.528271) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 14:50:17.528542) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 14:50:17.546215) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-06-06 14:50:17.546605) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.66WHtbp6VC/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.yzrHO0tX9K/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 14:50:17 INFO - MultiFileLogger online at 20160606 14:50:17 in /builds/slave/test 14:50:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:50:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:50:17 INFO - {'append_to_log': False, 14:50:17 INFO - 'base_work_dir': '/builds/slave/test', 14:50:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:50:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:50:17 INFO - 'branch': 'Mozilla-Beta', 14:50:17 INFO - 'buildbot_json_path': 'buildprops.json', 14:50:17 INFO - 'config_files': ('talos/mac_config.py',), 14:50:17 INFO - 'default_actions': ('clobber', 14:50:17 INFO - 'read-buildbot-config', 14:50:17 INFO - 'download-and-extract', 14:50:17 INFO - 'populate-webroot', 14:50:17 INFO - 'create-virtualenv', 14:50:17 INFO - 'install', 14:50:17 INFO - 'run-tests'), 14:50:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:50:17 INFO - 'download_minidump_stackwalk': True, 14:50:17 INFO - 'download_symbols': 'ondemand', 14:50:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:50:17 INFO - 'tooltool.py': '/tools/tooltool.py', 14:50:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:50:17 INFO - '/tools/misc-python/virtualenv.py')}, 14:50:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:50:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:50:17 INFO - 'installer_path': 'installer.exe', 14:50:17 INFO - 'log_level': 'info', 14:50:17 INFO - 'log_name': 'talos', 14:50:17 INFO - 'log_to_console': True, 14:50:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:50:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:50:17 INFO - 'opt_config_files': (), 14:50:17 INFO - 'pip_index': False, 14:50:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:50:17 INFO - 'cmd': ('bash', 14:50:17 INFO - '-c', 14:50:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:50:17 INFO - 'enabled': True, 14:50:17 INFO - 'halt_on_failure': False, 14:50:17 INFO - 'name': 'check_screen_resolution'},), 14:50:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:50:17 INFO - 'cmd': ('bash', 14:50:17 INFO - '-c', 14:50:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:50:17 INFO - 'enabled': True, 14:50:17 INFO - 'halt_on_failure': False, 14:50:17 INFO - 'name': 'check_screen_resolution'},), 14:50:17 INFO - 'run_cmd_checks_enabled': True, 14:50:17 INFO - 'sps_profile': False, 14:50:17 INFO - 'sps_profile_interval': 0, 14:50:17 INFO - 'suite': 'dromaeojs', 14:50:17 INFO - 'system_bits': '32', 14:50:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:50:17 INFO - 'title': 't-yosemite-r7-0146', 14:50:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:50:17 INFO - 'use_talos_json': True, 14:50:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:50:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:50:17 INFO - 'work_dir': 'build'} 14:50:17 INFO - ##### 14:50:17 INFO - ##### Running clobber step. 14:50:17 INFO - ##### 14:50:17 INFO - Running pre-action listener: _resource_record_pre_action 14:50:17 INFO - Running main action method: clobber 14:50:17 INFO - rmtree: /builds/slave/test/build 14:50:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:50:19 INFO - Running post-action listener: _resource_record_post_action 14:50:19 INFO - ##### 14:50:19 INFO - ##### Running read-buildbot-config step. 14:50:19 INFO - ##### 14:50:19 INFO - Running pre-action listener: _resource_record_pre_action 14:50:19 INFO - Running main action method: read_buildbot_config 14:50:19 INFO - Using buildbot properties: 14:50:19 INFO - { 14:50:19 INFO - "project": "", 14:50:19 INFO - "product": "firefox", 14:50:19 INFO - "script_repo_revision": "production", 14:50:19 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:50:19 INFO - "repository": "", 14:50:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:50:19 INFO - "buildid": "20160606125325", 14:50:19 INFO - "pgo_build": "False", 14:50:19 INFO - "basedir": "/builds/slave/test", 14:50:19 INFO - "buildnumber": 0, 14:50:19 INFO - "slavename": "t-yosemite-r7-0146", 14:50:19 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 14:50:19 INFO - "platform": "yosemite_r7", 14:50:19 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:50:19 INFO - "branch": "mozilla-beta", 14:50:19 INFO - "repo_path": "releases/mozilla-beta", 14:50:19 INFO - "revision": "5fe894994e955cf7f6d85337492beebe562ea6c5", 14:50:19 INFO - "stage_platform": "macosx64", 14:50:19 INFO - "builduid": "ab6de4c621424cea86326d1844440e03", 14:50:19 INFO - "slavebuilddir": "test" 14:50:19 INFO - } 14:50:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 14:50:19 INFO - Running post-action listener: _resource_record_post_action 14:50:19 INFO - ##### 14:50:19 INFO - ##### Running download-and-extract step. 14:50:19 INFO - ##### 14:50:19 INFO - Running pre-action listener: _resource_record_pre_action 14:50:19 INFO - Running main action method: download_and_extract 14:50:19 INFO - mkdir: /builds/slave/test/build/tests 14:50:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:50:19 INFO - https://queue.taskcluster.net/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:50:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 14:50:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 14:50:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 14:50:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 14:50:31 INFO - Downloaded 1165 bytes. 14:50:31 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 14:50:31 INFO - Using the following test package requirements: 14:50:31 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 14:50:31 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:50:31 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 14:50:31 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:50:31 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 14:50:31 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:50:31 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:50:31 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 14:50:31 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 14:50:31 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:50:31 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 14:50:31 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:50:31 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 14:50:31 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:50:31 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 14:50:31 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:50:31 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 14:50:31 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 14:50:31 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')]} 14:50:31 INFO - https://queue.taskcluster.net/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:50:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:50:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:50:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 14:50:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 14:50:54 INFO - Downloaded 18292408 bytes. 14:50:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:50:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:50:57 INFO - Return code: 0 14:50:57 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:50:57 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')]} 14:50:57 INFO - https://queue.taskcluster.net/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:50:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:50:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:50:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 14:50:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 14:51:03 INFO - Downloaded 18292408 bytes. 14:51:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:51:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:51:07 INFO - Return code: 0 14:51: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')]} 14:51:07 INFO - https://queue.taskcluster.net/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:51:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 14:51:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 14:51:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 14:51:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 14:51:08 INFO - Downloaded 10840145 bytes. 14:51:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:51:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:51:08 INFO - Return code: 0 14:51:08 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')]} 14:51:08 INFO - https://queue.taskcluster.net/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 14:51:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:51:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:51:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 14:51:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 14:51:15 INFO - Downloaded 86246907 bytes. 14:51:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:51:15 INFO - mkdir: /builds/slave/test/properties 14:51:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:51:15 INFO - Writing to file /builds/slave/test/properties/build_url 14:51:15 INFO - Contents: 14:51:15 INFO - build_url:https://queue.taskcluster.net/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:51:16 INFO - Running post-action listener: _resource_record_post_action 14:51:16 INFO - Running post-action listener: set_extra_try_arguments 14:51:16 INFO - ##### 14:51:16 INFO - ##### Running populate-webroot step. 14:51:16 INFO - ##### 14:51:16 INFO - Running pre-action listener: _resource_record_pre_action 14:51:16 INFO - Running main action method: populate_webroot 14:51:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:51:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:51:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:51:16 INFO - '--tppagecycles', 14:51:16 INFO - '7'], 14:51:16 INFO - 'tests': ['tsvgm']}}, 14:51:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:51:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:51:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:51:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:51:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:51:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:51:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:16 INFO - 'talos_options': ['--disable-e10s'], 14:51:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:16 INFO - 'talos_options': ['--disable-e10s'], 14:51:16 INFO - 'tests': ['damp', 'tps']}, 14:51:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:16 INFO - 'tests': ['damp', 'tps']}, 14:51:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:51:16 INFO - 'tests': ['dromaeo_dom']}, 14:51:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:51:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:51:16 INFO - 'tests': ['a11yr', 14:51:16 INFO - 'ts_paint', 14:51:16 INFO - 'tpaint', 14:51:16 INFO - 'sessionrestore', 14:51:16 INFO - 'sessionrestore_no_auto_restore', 14:51:16 INFO - 'tabpaint']}, 14:51:16 INFO - 'other-e10s': {'tests': ['a11yr', 14:51:16 INFO - 'ts_paint', 14:51:16 INFO - 'tpaint', 14:51:16 INFO - 'sessionrestore', 14:51:16 INFO - 'sessionrestore_no_auto_restore', 14:51:16 INFO - 'tabpaint']}, 14:51:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:51:16 INFO - 'ts_paint', 14:51:16 INFO - 'tpaint', 14:51:16 INFO - 'sessionrestore', 14:51:16 INFO - 'sessionrestore_no_auto_restore', 14:51:16 INFO - 'tabpaint']}, 14:51:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:51:16 INFO - 'ts_paint', 14:51:16 INFO - 'tpaint', 14:51:16 INFO - 'sessionrestore', 14:51:16 INFO - 'sessionrestore_no_auto_restore', 14:51:16 INFO - 'tabpaint']}, 14:51:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:51:16 INFO - 'tests': ['a11yr', 14:51:16 INFO - 'ts_paint', 14:51:16 INFO - 'tpaint', 14:51:16 INFO - 'sessionrestore', 14:51:16 INFO - 'sessionrestore_no_auto_restore', 14:51:16 INFO - 'tabpaint']}, 14:51:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:51:16 INFO - 'tests': ['a11yr', 14:51:16 INFO - 'ts_paint', 14:51:16 INFO - 'tpaint', 14:51:16 INFO - 'sessionrestore', 14:51:16 INFO - 'sessionrestore_no_auto_restore', 14:51:16 INFO - 'tabpaint']}, 14:51:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:51:16 INFO - 'tests': ['tsvgx', 14:51:16 INFO - 'tsvgr_opacity', 14:51:16 INFO - 'tart', 14:51:16 INFO - 'tscrollx', 14:51:16 INFO - 'cart']}, 14:51:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:51:16 INFO - 'tsvgr_opacity', 14:51:16 INFO - 'tart', 14:51:16 INFO - 'tscrollx', 14:51:16 INFO - 'cart']}, 14:51:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:16 INFO - 'talos_options': ['--disable-e10s'], 14:51:16 INFO - 'tests': ['tp5o']}, 14:51:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:16 INFO - 'tests': ['tp5o']}, 14:51:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:16 INFO - 'talos_options': ['--disable-e10s', 14:51:16 INFO - '--xperf_path', 14:51:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:16 INFO - 'tests': ['tp5n']}, 14:51:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:16 INFO - 'talos_options': ['--xperf_path', 14:51:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:16 INFO - 'tests': ['tp5n']}}, 14:51:16 INFO - 'talos.zip': {'path': '', 14:51:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:51:16 INFO - Running post-action listener: _resource_record_post_action 14:51:16 INFO - ##### 14:51:16 INFO - ##### Running create-virtualenv step. 14:51:16 INFO - ##### 14:51:16 INFO - Running pre-action listener: _resource_record_pre_action 14:51:16 INFO - Running main action method: create_virtualenv 14:51:16 INFO - Creating virtualenv /builds/slave/test/build/venv 14:51:16 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 14:51:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:51:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:51:16 INFO - Using real prefix '/tools/python27' 14:51:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:51:17 INFO - Installing distribute.............................................................................................................................................................................................done. 14:51:19 INFO - Installing pip.................done. 14:51:19 INFO - Return code: 0 14:51:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:20 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 0x1087bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb234915e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865ce00>, '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 0x1084c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657b20>, '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.66WHtbp6VC/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.yzrHO0tX9K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 14:51:20 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 14:51:20 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 14:51:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.66WHtbp6VC/Render', 14:51:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:20 INFO - 'HOME': '/Users/cltbld', 14:51:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:20 INFO - 'LOGNAME': 'cltbld', 14:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:20 INFO - 'MOZ_NO_REMOTE': '1', 14:51:20 INFO - 'NO_EM_RESTART': '1', 14:51:20 INFO - 'PAGER': '/bin/cat', 14:51:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:20 INFO - 'PWD': '/builds/slave/test', 14:51:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:20 INFO - 'SHELL': '/bin/bash', 14:51:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yzrHO0tX9K/Listeners', 14:51:20 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 14:51:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:20 INFO - 'USER': 'cltbld', 14:51:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:20 INFO - 'XPC_FLAGS': '0x0', 14:51:20 INFO - 'XPC_SERVICE_NAME': '0', 14:51:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:20 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 14:51:20 INFO - Cleaning up... 14:51:20 INFO - Return code: 0 14:51:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:20 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 0x1087bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb234915e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865ce00>, '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 0x1084c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657b20>, '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.66WHtbp6VC/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.yzrHO0tX9K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 14:51:20 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 14:51:20 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 14:51:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.66WHtbp6VC/Render', 14:51:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:20 INFO - 'HOME': '/Users/cltbld', 14:51:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:20 INFO - 'LOGNAME': 'cltbld', 14:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:20 INFO - 'MOZ_NO_REMOTE': '1', 14:51:20 INFO - 'NO_EM_RESTART': '1', 14:51:20 INFO - 'PAGER': '/bin/cat', 14:51:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:20 INFO - 'PWD': '/builds/slave/test', 14:51:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:20 INFO - 'SHELL': '/bin/bash', 14:51:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yzrHO0tX9K/Listeners', 14:51:20 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 14:51:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:20 INFO - 'USER': 'cltbld', 14:51:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:20 INFO - 'XPC_FLAGS': '0x0', 14:51:20 INFO - 'XPC_SERVICE_NAME': '0', 14:51:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:20 INFO - Downloading/unpacking psutil>=0.7.1 14:51:20 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 14:51:20 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 14:51:20 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 14:51:20 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 14:51:20 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 14:51:20 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 14:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:51:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:23 INFO - Installing collected packages: psutil 14:51:23 INFO - Running setup.py install for psutil 14:51:23 INFO - building 'psutil._psutil_osx' extension 14:51:23 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 14:51:24 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 14:51:24 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 14:51:24 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 14:51:24 INFO - building 'psutil._psutil_posix' extension 14:51:24 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 14:51:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:51:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:51:24 INFO - ^ 14:51:24 INFO - 1 warning generated. 14:51:24 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 14:51:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:25 INFO - Successfully installed psutil 14:51:25 INFO - Cleaning up... 14:51:25 INFO - Return code: 0 14:51:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:25 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 0x1087bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb234915e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865ce00>, '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 0x1084c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657b20>, '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.66WHtbp6VC/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.yzrHO0tX9K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 14:51:25 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 14:51:25 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 14:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.66WHtbp6VC/Render', 14:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:25 INFO - 'HOME': '/Users/cltbld', 14:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:25 INFO - 'LOGNAME': 'cltbld', 14:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:25 INFO - 'MOZ_NO_REMOTE': '1', 14:51:25 INFO - 'NO_EM_RESTART': '1', 14:51:25 INFO - 'PAGER': '/bin/cat', 14:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:25 INFO - 'PWD': '/builds/slave/test', 14:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:25 INFO - 'SHELL': '/bin/bash', 14:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yzrHO0tX9K/Listeners', 14:51:25 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 14:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:25 INFO - 'USER': 'cltbld', 14:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:25 INFO - 'XPC_FLAGS': '0x0', 14:51:25 INFO - 'XPC_SERVICE_NAME': '0', 14:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:25 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 14:51:25 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 14:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:51:27 INFO - Installing collected packages: mozsystemmonitor 14:51:27 INFO - Running setup.py install for mozsystemmonitor 14:51:28 INFO - Successfully installed mozsystemmonitor 14:51:28 INFO - Cleaning up... 14:51:28 INFO - Return code: 0 14:51:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:51: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')]} 14:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:28 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 0x1087bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb234915e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865ce00>, '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 0x1084c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657b20>, '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.66WHtbp6VC/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.yzrHO0tX9K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 14:51:28 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 14:51:28 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 14:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.66WHtbp6VC/Render', 14:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:28 INFO - 'HOME': '/Users/cltbld', 14:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:28 INFO - 'LOGNAME': 'cltbld', 14:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:28 INFO - 'MOZ_NO_REMOTE': '1', 14:51:28 INFO - 'NO_EM_RESTART': '1', 14:51:28 INFO - 'PAGER': '/bin/cat', 14:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:28 INFO - 'PWD': '/builds/slave/test', 14:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:28 INFO - 'SHELL': '/bin/bash', 14:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yzrHO0tX9K/Listeners', 14:51:28 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 14:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:28 INFO - 'USER': 'cltbld', 14:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:28 INFO - 'XPC_FLAGS': '0x0', 14:51:28 INFO - 'XPC_SERVICE_NAME': '0', 14:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:28 INFO - Downloading/unpacking blobuploader==1.2.4 14:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:30 INFO - Downloading blobuploader-1.2.4.tar.gz 14:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:51:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:51:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:51:31 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 14:51:31 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 14:51:31 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 14:51:31 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 14:51:31 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 14:51:31 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 14:51:32 INFO - Downloading docopt-0.6.1.tar.gz 14:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:51:32 INFO - Installing collected packages: blobuploader, requests, docopt 14:51:32 INFO - Running setup.py install for blobuploader 14:51:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:51:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:51:32 INFO - Running setup.py install for requests 14:51:32 INFO - Running setup.py install for docopt 14:51:32 INFO - Successfully installed blobuploader requests docopt 14:51:32 INFO - Cleaning up... 14:51:33 INFO - Return code: 0 14:51:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51: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')]} 14:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:33 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 0x1087bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb234915e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865ce00>, '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 0x1084c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657b20>, '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.66WHtbp6VC/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.yzrHO0tX9K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 14:51:33 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 14:51:33 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 14:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.66WHtbp6VC/Render', 14:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:33 INFO - 'HOME': '/Users/cltbld', 14:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:33 INFO - 'LOGNAME': 'cltbld', 14:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:33 INFO - 'MOZ_NO_REMOTE': '1', 14:51:33 INFO - 'NO_EM_RESTART': '1', 14:51:33 INFO - 'PAGER': '/bin/cat', 14:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:33 INFO - 'PWD': '/builds/slave/test', 14:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:33 INFO - 'SHELL': '/bin/bash', 14:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yzrHO0tX9K/Listeners', 14:51:33 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 14:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:33 INFO - 'USER': 'cltbld', 14:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:33 INFO - 'XPC_FLAGS': '0x0', 14:51:33 INFO - 'XPC_SERVICE_NAME': '0', 14:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:51:33 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-cgVfgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:51:33 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-E9U8vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:51:33 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-R08CFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:51:33 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-GVxRdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:51:33 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-KLNKgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:51:33 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-924KiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:51:33 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-gwDcsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:51:34 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-DeOA9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:51:34 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-UtRUlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:51:34 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-0AnJeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:51:34 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-3Kgu5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:51:34 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-OxkFlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:51:34 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-6nZciL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:51:34 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-Nw1p5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:34 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-5Qd4ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:51:34 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-8j_uHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:51:35 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-5V20hS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:51:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:51:35 INFO - Running setup.py install for manifestparser 14:51:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:51:35 INFO - Running setup.py install for mozcrash 14:51:35 INFO - Running setup.py install for mozdebug 14:51:35 INFO - Running setup.py install for mozdevice 14:51:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:51:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:51:35 INFO - Running setup.py install for mozfile 14:51:35 INFO - Running setup.py install for mozhttpd 14:51:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Running setup.py install for mozinfo 14:51:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Running setup.py install for mozInstall 14:51:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Running setup.py install for mozleak 14:51:36 INFO - Running setup.py install for mozlog 14:51:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Running setup.py install for moznetwork 14:51:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Running setup.py install for mozprocess 14:51:36 INFO - Running setup.py install for mozprofile 14:51:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:51:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:51:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:51:37 INFO - Running setup.py install for mozrunner 14:51:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:51:37 INFO - Running setup.py install for mozscreenshot 14:51:37 INFO - Running setup.py install for moztest 14:51:37 INFO - Running setup.py install for mozversion 14:51:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:51:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:51:37 INFO - Cleaning up... 14:51:37 INFO - Return code: 0 14:51:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:37 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 0x1087bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb234915e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865ce00>, '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 0x1084c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657b20>, '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.66WHtbp6VC/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.yzrHO0tX9K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 14:51:37 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 14:51:37 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 14:51:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.66WHtbp6VC/Render', 14:51:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:37 INFO - 'HOME': '/Users/cltbld', 14:51:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:37 INFO - 'LOGNAME': 'cltbld', 14:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:37 INFO - 'MOZ_NO_REMOTE': '1', 14:51:37 INFO - 'NO_EM_RESTART': '1', 14:51:37 INFO - 'PAGER': '/bin/cat', 14:51:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:37 INFO - 'PWD': '/builds/slave/test', 14:51:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:37 INFO - 'SHELL': '/bin/bash', 14:51:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yzrHO0tX9K/Listeners', 14:51:37 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 14:51:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:37 INFO - 'USER': 'cltbld', 14:51:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:37 INFO - 'XPC_FLAGS': '0x0', 14:51:37 INFO - 'XPC_SERVICE_NAME': '0', 14:51:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:51:37 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-65_du7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:51:38 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-LMV3eP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:51:38 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-Yz9oGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:51:38 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-Cyd4TO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:51:38 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-Lz0Esc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:51:38 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-XjH6M7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:51:38 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-EAmIDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:51:38 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-Wa4cXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:51:38 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-TYFNWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:51:38 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-5Zlxnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:51:39 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)) 14:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:51:39 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-1EfcP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:51:39 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)) 14:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:51:39 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-yYqdym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:51:39 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)) 14:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:51:39 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-dZxTpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:51:39 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)) 14:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:51:39 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-2R3I9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:51:39 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)) 14:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:39 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-VXouNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:39 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)) 14:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:51:39 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-UUSuVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:51:39 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)) 14:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:51:39 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-_s0iZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:51:39 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)) 14:51:39 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)) 14:51:39 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)) 14:51:39 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)) 14:51:39 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)) 14:51:39 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)) 14:51:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:51:39 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 14:51:39 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 14:51:39 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 14:51:39 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 14:51:39 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 14:51:39 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 14:51:42 INFO - Downloading blessings-1.6.tar.gz 14:51:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:51:42 INFO - Installing collected packages: blessings 14:51:42 INFO - Running setup.py install for blessings 14:51:42 INFO - Successfully installed blessings 14:51:42 INFO - Cleaning up... 14:51:42 INFO - Return code: 0 14:51:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:51:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:51:43 INFO - Reading from file tmpfile_stdout 14:51:43 INFO - Current package versions: 14:51:43 INFO - blessings == 1.6 14:51:43 INFO - blobuploader == 1.2.4 14:51:43 INFO - docopt == 0.6.1 14:51:43 INFO - manifestparser == 1.1 14:51:43 INFO - mozInstall == 1.12 14:51:43 INFO - mozcrash == 0.17 14:51:43 INFO - mozdebug == 0.1 14:51:43 INFO - mozdevice == 0.48 14:51:43 INFO - mozfile == 1.2 14:51:43 INFO - mozhttpd == 0.7 14:51:43 INFO - mozinfo == 0.9 14:51:43 INFO - mozleak == 0.1 14:51:43 INFO - mozlog == 3.1 14:51:43 INFO - moznetwork == 0.27 14:51:43 INFO - mozprocess == 0.22 14:51:43 INFO - mozprofile == 0.28 14:51:43 INFO - mozrunner == 6.11 14:51:43 INFO - mozscreenshot == 0.1 14:51:43 INFO - mozsystemmonitor == 0.0 14:51:43 INFO - moztest == 0.7 14:51:43 INFO - mozversion == 1.4 14:51:43 INFO - psutil == 3.1.1 14:51:43 INFO - requests == 1.2.3 14:51:43 INFO - wsgiref == 0.1.2 14:51:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1087bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb234915e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865ce00>, '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 0x1084c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657b20>, '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.66WHtbp6VC/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.yzrHO0tX9K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 14:51:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:51:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.66WHtbp6VC/Render', 14:51:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:43 INFO - 'HOME': '/Users/cltbld', 14:51:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:43 INFO - 'LOGNAME': 'cltbld', 14:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:43 INFO - 'MOZ_NO_REMOTE': '1', 14:51:43 INFO - 'NO_EM_RESTART': '1', 14:51:43 INFO - 'PAGER': '/bin/cat', 14:51:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:43 INFO - 'PWD': '/builds/slave/test', 14:51:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:43 INFO - 'SHELL': '/bin/bash', 14:51:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yzrHO0tX9K/Listeners', 14:51:43 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 14:51:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:43 INFO - 'USER': 'cltbld', 14:51:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:43 INFO - 'XPC_FLAGS': '0x0', 14:51:43 INFO - 'XPC_SERVICE_NAME': '0', 14:51:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:51:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:51:43 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)) 14:51:43 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)) 14:51:43 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)) 14:51:43 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)) 14:51:43 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)) 14:51:43 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)) 14:51:43 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)) 14:51:43 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)) 14:51:43 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)) 14:51:43 INFO - Cleaning up... 14:51:43 INFO - Return code: 0 14:51:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:43 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 0x1087bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb234915e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865ce00>, '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 0x1084c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657b20>, '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.66WHtbp6VC/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.yzrHO0tX9K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 14:51:43 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 14:51:43 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 14:51:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.66WHtbp6VC/Render', 14:51:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:43 INFO - 'HOME': '/Users/cltbld', 14:51:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:43 INFO - 'LOGNAME': 'cltbld', 14:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:43 INFO - 'MOZ_NO_REMOTE': '1', 14:51:43 INFO - 'NO_EM_RESTART': '1', 14:51:43 INFO - 'PAGER': '/bin/cat', 14:51:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:43 INFO - 'PWD': '/builds/slave/test', 14:51:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:43 INFO - 'SHELL': '/bin/bash', 14:51:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yzrHO0tX9K/Listeners', 14:51:43 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 14:51:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:43 INFO - 'USER': 'cltbld', 14:51:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:43 INFO - 'XPC_FLAGS': '0x0', 14:51:43 INFO - 'XPC_SERVICE_NAME': '0', 14:51:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:43 INFO - Downloading/unpacking jsonschema 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:51:46 INFO - Downloading/unpacking functools32 (from jsonschema) 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51:46 INFO - Downloading functools32-3.2.3-2.tar.gz 14:51:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:51:46 INFO - warning: no files found matching '*.txt' 14:51:46 INFO - no previously-included directories found matching 'build' 14:51:46 INFO - no previously-included directories found matching 'dist' 14:51:46 INFO - no previously-included directories found matching '.git*' 14:51:46 INFO - Installing collected packages: jsonschema, functools32 14:51:46 INFO - Running setup.py install for functools32 14:51:46 INFO - warning: no files found matching '*.txt' 14:51:46 INFO - no previously-included directories found matching 'build' 14:51:46 INFO - no previously-included directories found matching 'dist' 14:51:46 INFO - no previously-included directories found matching '.git*' 14:51:46 INFO - Successfully installed jsonschema functools32 14:51:46 INFO - Cleaning up... 14:51:46 INFO - Return code: 0 14:51:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:51: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')]} 14:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1087bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb234915e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865ce00>, '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 0x1084c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657b20>, '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.66WHtbp6VC/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.yzrHO0tX9K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 14:51: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', 'flake8'] in /builds/slave/test/build 14:51: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 flake8 14:51:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.66WHtbp6VC/Render', 14:51:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:46 INFO - 'HOME': '/Users/cltbld', 14:51:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:46 INFO - 'LOGNAME': 'cltbld', 14:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:46 INFO - 'MOZ_NO_REMOTE': '1', 14:51:46 INFO - 'NO_EM_RESTART': '1', 14:51:46 INFO - 'PAGER': '/bin/cat', 14:51:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:46 INFO - 'PWD': '/builds/slave/test', 14:51:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:46 INFO - 'SHELL': '/bin/bash', 14:51:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yzrHO0tX9K/Listeners', 14:51:46 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 14:51:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:46 INFO - 'USER': 'cltbld', 14:51:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:46 INFO - 'XPC_FLAGS': '0x0', 14:51:46 INFO - 'XPC_SERVICE_NAME': '0', 14:51:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:47 INFO - Downloading/unpacking flake8 14:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:51:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:51:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:51:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:51:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:51:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:51:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:51:50 INFO - no previously-included directories found matching 'docs/_build' 14:51:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:51:50 INFO - Running setup.py install for pep8 14:51:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:51:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:51:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:51:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:51:51 INFO - no previously-included directories found matching 'docs/_build' 14:51:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:51:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:51:51 INFO - Cleaning up... 14:51:51 INFO - Return code: 0 14:51:51 INFO - Running post-action listener: _resource_record_post_action 14:51:51 INFO - Running post-action listener: _start_resource_monitoring 14:51:51 INFO - Starting resource monitoring. 14:51:51 INFO - ##### 14:51:51 INFO - ##### Running install step. 14:51:51 INFO - ##### 14:51:51 INFO - Running pre-action listener: _resource_record_pre_action 14:51:51 INFO - Running main action method: install 14:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:51:51 INFO - Reading from file tmpfile_stdout 14:51:51 INFO - Detecting whether we're running mozinstall >=1.0... 14:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:51:51 INFO - Reading from file tmpfile_stdout 14:51:51 INFO - Output received: 14:51:51 INFO - Usage: mozinstall [options] installer 14:51:51 INFO - Options: 14:51:51 INFO - -h, --help show this help message and exit 14:51:51 INFO - -d DEST, --destination=DEST 14:51:51 INFO - Directory to install application into. [default: 14:51:51 INFO - "/builds/slave/test"] 14:51:51 INFO - --app=APP Application being installed. [default: firefox] 14:51:51 INFO - mkdir: /builds/slave/test/build/application 14:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:52:13 INFO - Reading from file tmpfile_stdout 14:52:13 INFO - Output received: 14:52:13 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:52:13 INFO - Running post-action listener: _resource_record_post_action 14:52:13 INFO - ##### 14:52:13 INFO - ##### Running run-tests step. 14:52:13 INFO - ##### 14:52:13 INFO - Running pre-action listener: _resource_record_pre_action 14:52:13 INFO - Running main action method: run_tests 14:52:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:52:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:52:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:52:13 INFO - 2016-06-06 14:52:13.387 screenresolution[1641:7725] starting screenresolution argv=screenresolution get 14:52:13 INFO - 2016-06-06 14:52:13.390 screenresolution[1641:7725] Display 0: 1600x1200x32@60 14:52:13 INFO - 2016-06-06 14:52:13.396 screenresolution[1642:7727] starting screenresolution argv=screenresolution list 14:52:13 INFO - Available Modes on Display 0 14:52:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:52:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:52:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:52:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:52:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:52:13 INFO - Intel Iris: 14:52:13 INFO - Chipset Model: Intel Iris 14:52:13 INFO - Type: GPU 14:52:13 INFO - Bus: Built-In 14:52:13 INFO - VRAM (Dynamic, Max): 1536 MB 14:52:13 INFO - Vendor: Intel (0x8086) 14:52:13 INFO - Device ID: 0x0a2e 14:52:13 INFO - Revision ID: 0x0009 14:52:13 INFO - Displays: 14:52:13 INFO - Display: 14:52:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:52:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:52:13 INFO - Display Serial Number: 1600x1200 60 14:52:13 INFO - Main Display: Yes 14:52:13 INFO - Mirror: Off 14:52:13 INFO - Online: Yes 14:52:13 INFO - Rotation: Supported 14:52:13 INFO - Return code: 0 14:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:52:13 INFO - Python 2.7.3 14:52:13 INFO - Return code: 0 14:52:13 INFO - grabbing minidump binary from tooltool 14:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:13 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 0x10865ce00>, '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 0x1084c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:52:13 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 14:52:13 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 14:52:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:52:13 INFO - Return code: 0 14:52:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:52:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:52:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:52:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:52:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:52:14 INFO - Return code: 0 14:52:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--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 14:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0146 --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 14:52:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.66WHtbp6VC/Render', 14:52:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:14 INFO - 'HOME': '/Users/cltbld', 14:52:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:14 INFO - 'LOGNAME': 'cltbld', 14:52:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:52:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:14 INFO - 'MOZ_NO_REMOTE': '1', 14:52:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:52:14 INFO - 'NO_EM_RESTART': '1', 14:52:14 INFO - 'PAGER': '/bin/cat', 14:52:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:14 INFO - 'PWD': '/builds/slave/test', 14:52:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:52:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:14 INFO - 'SHELL': '/bin/bash', 14:52:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yzrHO0tX9K/Listeners', 14:52:14 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 14:52:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:14 INFO - 'USER': 'cltbld', 14:52:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:14 INFO - 'XPC_FLAGS': '0x0', 14:52:14 INFO - 'XPC_SERVICE_NAME': '0', 14:52:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--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 14:52:15 INFO - mozversion application_buildid: 20160606125325 14:52:15 INFO - mozversion application_changeset: 5fe894994e955cf7f6d85337492beebe562ea6c5 14:52:15 INFO - mozversion application_display_name: Firefox 14:52:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:52:15 INFO - mozversion application_name: Firefox 14:52:15 INFO - mozversion application_remotingname: firefox 14:52:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:52:15 INFO - mozversion application_vendor: Mozilla 14:52:15 INFO - mozversion application_version: 48.0 14:52:15 INFO - mozversion platform_buildid: 20160606125325 14:52:15 INFO - mozversion platform_changeset: 5fe894994e955cf7f6d85337492beebe562ea6c5 14:52:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:52:15 INFO - mozversion platform_version: 48.0 14:52:15 INFO - using testdate: 1465249935 14:52:15 INFO - actual date: 1465249935 14:52:15 INFO - starting webserver on 'localhost:49275' 14:52:15 INFO - SUITE-START | Running 2 tests 14:52:15 INFO - TEST-START | dromaeo_css 14:52:15 INFO - operating with platform_type : mac_ 14:52:15 INFO - Initialising browser for dromaeo_css test... 14:52:15 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmp4C7I4_/profile http://localhost:49275/getInfo.html) 14:52:17 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 14:52:17 INFO - PROCESS | 1660 | colorDepth:24 14:52:17 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 14:52:17 INFO - PROCESS | 1660 | __metrics 14:52:17 INFO - PROCESS | 1660 | 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" 14:52:17 ERROR - PROCESS | 1660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:52:18 INFO - TEST-INFO | 1660: exit 0 14:52:18 INFO - Browser initialized. 14:52:18 INFO - Running cycle 1/1 for dromaeo_css test... 14:52:18 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmp4C7I4_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:52:29 INFO - PROCESS | 1663 | RSS: Main: 161206272 14:52:29 INFO - PROCESS | 1663 | 14:53:21 INFO - PROCESS | 1663 | 1465250001215 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] 14:55:31 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 14:55:32 INFO - PROCESS | 1663 | RSS: Main: 296574976 14:55:32 INFO - PROCESS | 1663 | 14:58:35 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 14:58:36 INFO - PROCESS | 1663 | RSS: Main: 303906816 14:58:36 INFO - PROCESS | 1663 | 15:01:38 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 15:01:38 INFO - PROCESS | 1663 | RSS: Main: 308830208 15:01:38 INFO - PROCESS | 1663 | 15:04:40 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 15:04:41 INFO - PROCESS | 1663 | RSS: Main: 307535872 15:04:41 INFO - PROCESS | 1663 | 15:07:44 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 15:07:45 INFO - PROCESS | 1663 | RSS: Main: 270893056 15:07:45 INFO - PROCESS | 1663 | 15:10:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 15:10:47 INFO - PROCESS | 1663 | RSS: Main: 315498496 15:10:47 INFO - PROCESS | 1663 | 15:10:47 INFO - PROCESS | 1663 | __start_tp_report 15:10:47 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 15:10:47 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 15:10:47 INFO - PROCESS | 1663 | |i|pagename|runs| 15:10:47 INFO - PROCESS | 1663 | |0;dojo.html;3469.3408252432037;3550.538430004099;3561.6999795074807;3563.4476656118295;3620.348337299285;5775.191473193751;5788.884222315562;5796.942030579693;5798.507126894208;5832.650040997543;5763.423657634235;5811.389804070564;5814.767409303633;5828;5839.532837373011;5213.087709650815;5232.712200828972;5234;5294;5347.866303342428;5292.444293349201;5342;5352.2239275305055;5354.14333706607;5356.9732151339185;5257.8948421031555;5306.973465132669;5335.706536140511;5342.973285133569;5357.785688572452;5302.681839089648;5311.707856067915;5314.5748340132695;5338.546223571001;5339.866503337409;5125.154349532323;5191.935653191124;5254.65844720092;5269.420363759983;5277.445868183824;5555.444455554412;5656.830295091154;5669.603127781057;5672.8865422691315;5707.914381284284;4660.720356778605;6293.590916590407;6304.1804565406665;6322.525810564226;6325.9051114233325;6173.32093469718;6223.097650840648;6304.936950630481;6323.114763933053;6338.968305158444;5907.645541267538;5935.703214839241;5945.64326140433;5977;6009.278886533644;6363.1091647168505;6371.490280777527;6386.680665966683;6406.8718625627225;6414.358564143642;6128.111423843607;6136.304638670889;6258.280297765724;6272.153259309935;6289.433950944437;6306.369363063657;6319.52603554726;6321.1150438938585;6345.841353966095;6434.549581529248;6243.500519958392;6322.525810564226;6328.177336946167;6340.904886426707;6344.968275158594;6161.199044124235;6217.378262173746;6288.213973253343;6327.082573026977;6342.682865856688;4978.90042199154;5028.622853286018;5033.043721692867;5036.219385995177;5038.622103342264;4517.390152329459;4535.160995215896;4538.1377538267625;4547.613452856478;4567.200739870509;5766.163906233573;5809.738561764646;5877.35349111606;5882.794102206402;5897.52819774417;6219.284782250099;6296.087067375205;6309.968450157719;6320.178376810985;6328.367163283635;5911.645301281937;5925.614835035709;5928.258967629046;5935.40645935403;5965.821025369246;5378.757955891994;5460.6996615186545;5462.2079798429;5483.506484416342;5498.477644623755;5398.838034858961;6314.273858506239;6371;6499;6523.7716679915975;6279.748810047547;6311.842203944754;6315.242170939517;6324.304326523987;6331.27190373113;6407.743690252338;6458.67706614658;6467.741290348334;6469.805905822833;6476.967615161894;6129.509639228761;6172.814815555541;6247.3440288769025;6293.622382657055;6306.810795676137;6318.4313411793155;6332.050192471166;6340.556161068866;6355.173827402408;6356.046593011085;6246.312905580474;6249.906251406142;6256.812295631138;6257.2804127525915;6270.905936410866;6039;6112.816615501542;6203.472704820141;6228.875422491434;6230.470410015199;4775.641826863069;5049.419316778471;6076.1493390924425;6090.725917333819;6106.57253992234;6060.484858787053;6175.505959523317;6223.968880155751;6234.251889773256;6237.875242495215;5983.461488466059;5989.071693887455;5992.101184822312;5992.850178745566;6137.3862613738265 15:10:47 INFO - PROCESS | 1663 | |1;ext.html;518.9481051894811;531.4472948133941;567.3163837575721;579.953603711703;629.8614304852931;27194;33584.32831343375;34872.95381138563;39328.21343573127;41024;44065.77967110168;44431;44516.3322550162;44517.7774111129;44604.330935036;9658.179054780352;9883.802323953516;9895.158911492532;9897.950510247474;9931.304808663397;9199.540022998857;11858.940705296462;12166.661667216644;12167.2699638022;12172.208806427554;11821.822672659917;11879.168458207885;11914;11931.522739090426;11971.401429928468;11823.408829558532;11931.224470409396;11938.164328496965;11939;11946.522139114424;11673.474693638807;11775.470103845348;11779.882201177965;11780.175387722777;11786.998105161072;42538.936526586775;42945.141097178195;43044.354334685006;43046;43084.78457607723;3347.615024272191;3374.5444365010653;3494.6155922848466;3537.2218112015316;3741.8129093545485;28357;29575;29711.70288297111;30069;30194.84902575495;2757.420941602266;2773.72262773723;2810.4379124175043;2823.265950852793;2829.2502486841004;519566;520640;520991;521578;523049;37263.25473490515;63070.68464657739;65841.67079164574;65916.37459939749;66099.66950165314;32877.50683739746;37117.81441092777;37125;37158;37162.81418592944;16310.510684679479;16515.83484165167;16521.91739041297;16526.752098718527;16528.75206871898;12970.675733106747;13166.605001849959;13898.88808895286;13965.79051314231;14080.859191407955;8370.204830541088;8432.620532075949;8443.57782110892;8476.830463390697;8503.23470887623;3249.5125731140047;3330.533725278463;3518.5777706674853;3535.3459609971724;3552.6980206682206;921.9262459003263;1039.9785243440547;1088.9292196007393;1187.3410257307105;1206.6922934651607;26834.194974150807;30964;31560;31919.320005547335;32245.677543224738;1143.9656810295705;1163.947622356996;1209.8245754365569;1218.0377501773676;1289.6904742861834;16013.359465621477;16182.433614823425;16192.271347789378;16531.91734041346;16544.586385340222;519890.80109199183;623448;624908;625905;627308;64088.35911640824;64696.67651661712;64715;64773;65016.34983650198;1503.646643038885;1540.106738091904;1544.4825983295498;1559.4230134849724;1605.2214675881955;28474;29676;30001;30536.236594085327;30659.773609055388;52405.7379713099;53230.73384633052;53319.73340133274;53411.19883201677;53467;403680;404456;405470;405625;405811;24603.753962460145;27688.892444302;28266.85866570654;28271;28592.42815143727;43319;45337;45702.77148614236;46245.53754462412;48800.267995979375;38126;38167;39349.60650393459;39360.80319598383;40147.79926100468;37860.05349866275;38766.41850372303;39447.408288876264;39597.60402396054;39756.403653945796;39160.2167956645;39990.40014399728;40645;41458.58541414668;41465.37801933034;32398.83800580982;34215.65784342125;35197.82401087978;35288.647113529565;35621.82189089038;21390.7860921395;24321;25067;25500.57744514268;26393 15:10:47 INFO - PROCESS | 1663 | |2;jquery.html;389.8363385294895;402.35422147453335;419.46518189308637;420.71391453811435;421.201822546275;20403;20792.584148317044;21420.678689819666;21507;21541.4614634634;20950.37148885536;21119.894400528014;21901.452463688416;21902.45243868904;21905.890470547623;5858.267716535423;6078.848028799272;6273.843153921142;6286.119943207932;6288.622682639033;6128.601640893327;6200.78297259596;6224.782132625359;6238.251409830827;6239.875202495948;5922.466977971982;6220.346863579327;6228.813135605939;6228.96885515574;6230.688465576725;5904.084866845646;6109.602875813081;6194.194754681863;6198.876022479548;6208.2239720034995;5419.566434685215;5436.293281873332;5448.91826622601;5456.181572764078;5456.836294911159;20586.58826823455;27293.45413091727;27477.587836182473;27981.720182798115;28890.411027393486;2165.1880544795704;2180.7241518437568;2229.565234779219;2321.3964369263945;2961.9040954846846;14923.626909327246;16015.839841601668;16141;16197.352105915867;16225.675486490321;1801.1714611278828;1817.4365946556477;1830.0941034188163;1883.4255552056618;1914.904254787255;85991;96804.0319596802;118268;119724.00689982821;122880;11388.715282118013;11671.708207294885;11840.585579504848;11842.348670823016;11992.76014479723;14666.85333146655;14814.555563333117;14848.480303189337;14928.850711492963;14984.70030599382;9310.255179585616;9346.252299815998;9399.295052870926;9414.140202516935;9423.717288481357;8165.79585510367;9272.933612634499;9589.308116375245;9616.615335386647;9726.70819875405;6962.512624116364;7083.362497375261;7098.396636285974;7106.928930710626;7113.92886071143;1737.3137610643726;1913.1964574878584;1975.2987689370354;2005.6089062632645;2015;754.5435011817881;922.8200500902394;954.3176628710505;994.2394068537575;1140.2816225777708;21441.78558214429;22181;22280.66579001316;22388.552228955654;22413;1023.6110278094426;1027.8869324374314;1031.582209205273;1050.9947450262853;1051.8422236664408;11606.651800446;11937.940310298392;12042.87957120435;12053.397330133459;12077.033837293171;642670;643598;649824;654637;661575;71972.64013679897;99723.50138249263;112522;112911.43544282226;113783;1011.7925825205815;1020.8570800087994;1022.4172221833484;1046.0376453662648;1053.6312290698347;18101.004444755665;18360.357387491375;18492.81507184911;18530.44408667742;18581.34965276209;50495;51249.487505124474;51810.74094629503;52446.73776631092;52550.47449525456;50761.23858142057;76904.89606031256;86441.27117457741;86561.70157447517;86726.56636716776;7204;8189.918100818915;8403.537805420761;8589.957050214709;8744.344174186834;7902.920970790218;9909.900900990899;10004.599356090299;13338.13302135358;13916.165030098227;11469.942650286695;11557.82663260035;11694.2983420995;11859.94070029679;12092.395380230777;5284.9471505284455;9550.713478595653;9829.115379615869;11269.267497612629;11762.529498819951;11512.712182195177;11791.35147566892;11823.881761182278;12010;12088.879111209128;8437.367197460093;8650.09174036717;8745.562721863755;8756.51839148853;9019.729408117766;8461.280791132822;10732.248742587944;11683.299002059903;11913.344766037952;12028.97753690946 15:10:47 INFO - PROCESS | 1663 | |3;mootools.html;1483.7774333849927;1634.7384418493043;1660.5931546771035;1948.3862583286264;2018.4751964489237;8111.797205069876;8689.304855611552;8794.91205087949;8834.514101724402;8836.602352894128;8510.872336914952;8778.341624378165;8785.165409286108;8785.560721963891;8795.032546419889;2516.2954372775607;2540.4284036091917;2541.961870571943;2543.834650747705;2544.402065514612;2460.1143588308196;2513.158092039169;2517.0812653381477;2517.3203235126507;2521.0924067335745;2492.1651246832334;2526.406294520786;2527.229195095495;2528.8356256843244;2537.251510804317;2499.8625075620835;2534.1130604288537;2540.593505039194;2551.3366524703524;2551.6682831232006;2467.7655622715815;2526.93682657935;2527.330257481769;2533.1640558615795;2534.936626584332;7433.962830185815;8654.00478944923;8867.556622168866;8910.50992195429;8960.283177345862;4612.838550650711;4668.883277918046;5540.445955404468;5620.775168993236;5636.408177141382;3617.855285788565;3691.557013158438;3724.42271447926;3725.4598083278042;3745.906352341186;909.7452713240303;1026.5380578739523;1050.4537640426936;1059.4649701900569;1069.3209811769505;12010.399480025964;12094.69763255908;12114.0914431418;12152.696182595506;12152.756944861054;4112.403701463271;4602.907941841145;4769.73766442842;4772.475027746945;4807.086653535817;9305.953470232605;9413;9434.339596228336;9434.622615095457;9437.764055898657;5272.472752724697;5376.784928602812;5418.403975562764;5454.3454785426;5459.099248624012;4318.546552611993;4600.3099535070005;4850.078485087893;4995.325631039763;5032.899342013213;3529.6646818552194;3896.4350169225304;3904.6876249899938;3937.8031098444962;4008.9198216036098;1055.2191378380096;1056.5298442193305;1118.78743038824;1247.7442124364484;1256.7674980128522;962.4465932088937;983.2085171437062;988.5798535622332;999.4552968632113;1005.3314545826943;5978.5814992950945;6015.849603759853;6130.233720784902;6146.6004709693725;6267.592606480564;464.5308238678891;480.9827215439321;489.41270475428917;493.91850344693444;495.35603715170856;3456.879009234715;3941.625545573166;4031.4355990161403;4103.384492326175;4124.587541245852;10615.787684246427;11037.668869933916;11136.276142050741;11141;11168.329900206014;10873.83689244662;10902.836457452986;10969.451527423756;10981.901809819114;11027.44862756859;8100.756977290691;8392.28665563434;8475.406721529556;8553.973523177134;8592.398532102692;5928.3775203603;5972.163897054503;6077.270727512727;6104.603200791934;6250.843728906813;9424.481653509123;9500.192483638692;9657.71026869195;9664.323497355117;9673.322867399214;9341.57962891658;9797.657082002095;9824.950875245579;9856.753581160528;9946.900530994597;7001.36987671112;7172.13934327884;7479.513831600929;7610.124835643972;7759.650815713194;7034.718611255493;8344.791380215544;8386.11945745688;8414.87377689323;8435.451695639764;7347.926520734724;7389.371903388273;7521.661525231487;7573.9242607573215;7607;7428.591427471541;7434.591097489473;7440.73957411488;7531.8117047074265;7538.547687138789;7109.253528379652;7121.109861267341;7165.068541089833;7176.892346614701;7180.281971802987;4957.281194226889;4977.975110124571;5062.82280120194;5064;5105.33630628016;5036.445990940921;5094.974525127351;5100.2349647553165;5174;5385.165299378603 15:10:47 INFO - PROCESS | 1663 | |4;prototype.html;319.99040028799135;324.1264791387211;343.3270789253064;343.3339321715871;343.7799808122802;5396.51431371176;6750.426213771829;6842.281560436151;6850.623215723133;6863.0734850795125;6438.323975982513;6582.506312026593;6592.835179120524;6701.765438209663;6745.797626071226;5029.798808047673;5055.140626093573;5073.112205364065;5086.109930762121;5122.231665250205;5077.263796749469;5083.085044691954;5085.466026067265;5098.643094983353;5100.285959965608;4805.351277577517;4872.366592343008;4994.1260279451135;5033.647644664875;5048.242763585473;4954.479779623124;4983.626228032912;4998.350214472095;5008.39899212095;5037.0681423936685;4317.913641727179;4321.719088259253;4323.351497275403;4325.697201195918;4327.956720432787;5079.3650793650795;6432.228132624068;6435.774747883802;6451.612903225821;6459.515536334794;5888.852778680524;5937.584369094165;5937.821865344046;5942.168096466498;5948.524118070544;5893.734781934823;7157.212706602321;7230.457715671346;7252.564846109198;7256.927430725678;4786.473487916326;4831.710097394168;4839.395075615548;4840.080384726891;4841.49164337743;7622.047244094489;7644.464887457824;7646;7648.426368022365;7655.119661238973;4896.2410826321975;4900.509949005071;4911.722952032497;4915.827946021872;4917.975410122998;4982.103221420107;4983.700977941335;4993.625478089158;4994.800207991712;4997.375328083989;5714.085746280575;5929.110633405024;5934.910976335358;5935.554833387513;5935.762569497172;5830.62100963436;6480.189976252968;6627.834304142339;7242.565446073252;7253.3834624057545;1635;1712.332190445727;1741.1294352823588;1747.6417334446407;1750.5973626065822;1044.4020648407948;1078.9730256743487;1079.2930630437077;1084.7505073833063;1099.769048499824;5266.552343050884;6583.210014798159;6614.966925165343;6619.139511863524;6623.668816559153;7325.597092159983;7325.7802265932105;7339.816504587428;7361.852762944818;7362.9631851840395;6567.8358041048405;6592.17597800275;6602.603843769293;6613.371729685672;6614.86770264592;3822.4839646647347;3901.044244160142;3953.031507280735;3963.6630886374983;4003.3594624859884;6288.496920246461;7792.220777922163;7838.176991415933;7881.802954926173;7906.407019473562;7722.15056343813;7749.418793590503;7779.338756205786;7793.454458187985;7797;7868.370530357558;7880.05439347282;7882.7241046563095;7899.486533375312;7908.169642187602;7264.636768161465;7536.020317358928;7537.660805263886;7546.6981320748755;7568.205338439385;6633.436157926631;7383.593902335423;7394.593297368697;7412.96293518529;7422;7836.529808211526;7841.137474877873;7841.803954901173;7850.293473587404;7869.213078692085;4685.648576356719;4747.0774336393815;4761.40482439695;4763.16644587189;4766.737829419415;6381.904271435839;6943.479239057192;7495.737649182252;7515.774526764206;7517.6992920284765;7235.963820180866;7237.565746055254;7257.963710181415;7258.927410725825;7279.636018199175;5981.790637327673;6271.749130034747;7183.461240407095;7261.636918154177;7263.273672632695;5856.238688970407;6710.429613482908;6970.546914450544;7037;7090.751823686146;6939.583624982517;6953.6523173842115;7236.96381518089;7265.891011634935;7268.709251629875;6946.166460024628;6954.652267386711;6982;7049.048378468841;7065.82335441618 15:10:47 INFO - PROCESS | 1663 | |5;yui.html;707.7063018847178;717.8097804081917;752.1087511299114;764.9961750191248;818.4557269415839;15388.286765437026;15632.2965466554;15906.443274485366;15970.84029159708;15976.920115399422;14697.191654459;14748.852511474883;14750.041247318917;14752.926235368808;14755.92622036891;800.655718041242;811.7118422959853;814.3688641302979;952.8094381123768;980.4901451245348;799.4563696686251;801.4309840013568;963.6916186820185;1001.9749506262365;1002.1231422505308;1038.0605551975436;1040.0379648824844;1040.630576145465;1043.3635482355758;1044.0968562193686;1038.2472707287232;1039.1998161415743;1039.4231201683062;1040.8126537223334;1042.713253855192;620.6772478311298;639.8784230996142;730.5178582135818;761.8133557278502;764.1250767870812;15421.92289038559;15540.300686469136;15587.298571564306;15611.297491612904;15613.453529126426;13176.209427434289;13241.470341186341;13510.594682159453;13581.52464663742;13617.282483862013;10141.492925353776;10199.592016319339;10471.528781204865;10584.364938103738;10601.575936962512;3520.436730123168;3524.788512689247;3536.5932917714536;3617.439296908983;3794.9620503794886;83464;83886.58056709738;84148.73776893351;84350.8912277198;84597;8246.793830154174;9665.951670241604;9915.16569434657;10088.243381746399;10806.94596527028;23031.309060728207;23166.3050108497;23343.88328058349;23379.649305260435;23386.64920026201;7735.729249476241;7834;7847;7876;8095.190480951976;4147.605977432139;4257.297545904891;4276.615104640598;4339.153864996296;4348.499922508889;3808.409696497047;3850.7882066486613;3867.8066096695616;3869.2068126034096;3873.86441474547;684.5276759036249;695.1935754524727;699.4579201119071;707.0631413377193;712.1027505343201;562.9268195134688;567.9829605111853;608.248812716295;612.2713970375239;613.9785107521216;8100.554469504234;8389.412741108186;8502.404831661725;8554.230119289294;8567.100454452317;543.5325619966825;591.2845456996996;607.1530215349562;628.5505863307757;629.9842503937347;3987.641112299907;4036.0515278909434;4053.4730485036757;4063.227986682521;4075.917551480878;98485;99989.50005249926;100620;100950;103060;83962.74055889166;84459.57770211232;85882.57058714666;86935;87851;57294.14058789121;58899.70550147307;71042;72456;72768.27231727721;8618.095100014409;8681.365327474046;8847.911520884967;8856.158664926821;8881.689140880038;49215.50784492109;50682.74658626683;50735.492645074555;51042;52744;60083.699581501816;62046;71399.28600714135;71728;72145.6392718033;10942.438985721197;11115.666530004113;11122.499487522919;11440.599579014695;11729.824052639387;11885.46515406826;11986.940065299967;12105.13191362041;12106.213096148722;12622.495100195889;11123.99884010443;11477.311361318347;11548.191626586058;11665.35840528779;11692.0061794745;11445.141614378788;11542.422878856192;11773.234739741889;11804.291742495478;11987.041036716868;11473;11536.134789890624;11584.362860042442;11670.533178672758;11707.531698731955;8019.799505012421;9926.503674816086;10009.849852252368;10016.899831001889;10249.897501024894;9838.950805246215;9879.802403952024;9966.152877005536;9975.850362244428;9989.800203995734 15:10:47 INFO - PROCESS | 1663 | __end_tp_report 15:10:47 INFO - PROCESS | 1663 | __start_cc_report 15:10:47 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1183 15:10:47 INFO - PROCESS | 1663 | __end_cc_report 15:10:47 INFO - PROCESS | 1663 | __startTimestamp1465251047962__endTimestamp 15:10:47 INFO - PROCESS | 1663 | 15:10:47 INFO - PROCESS | 1663 | ------- Summary: start ------- 15:10:47 INFO - PROCESS | 1663 | Number of tests: 6 15:10:47 INFO - PROCESS | 1663 | 15:10:47 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5816.02 Median:6009.28 stddev:640.00 (10.7%) stddev-sans-first:614.92 15:10:47 INFO - PROCESS | 1663 | Values: 3469.3 3550.5 3561.7 3563.4 3620.3 5775.2 5788.9 5796.9 5798.5 5832.7 5763.4 5811.4 5814.8 5828.0 5839.5 5213.1 5232.7 5234.0 5294.0 5347.9 5292.4 5342.0 5352.2 5354.1 5357.0 5257.9 5307.0 5335.7 5343.0 5357.8 5302.7 5311.7 5314.6 5338.5 5339.9 5125.2 5191.9 5254.7 5269.4 5277.4 5555.4 5656.8 5669.6 5672.9 5707.9 4660.7 6293.6 6304.2 6322.5 6325.9 6173.3 6223.1 6304.9 6323.1 6339.0 5907.6 5935.7 5945.6 5977.0 6009.3 6363.1 6371.5 6386.7 6406.9 6414.4 6128.1 6136.3 6258.3 6272.2 6289.4 6306.4 6319.5 6321.1 6345.8 6434.5 6243.5 6322.5 6328.2 6340.9 6345.0 6161.2 6217.4 6288.2 6327.1 6342.7 4978.9 5028.6 5033.0 5036.2 5038.6 4517.4 4535.2 4538.1 4547.6 4567.2 5766.2 5809.7 5877.4 5882.8 5897.5 6219.3 6296.1 6310.0 6320.2 6328.4 5911.6 5925.6 5928.3 5935.4 5965.8 5378.8 5460.7 5462.2 5483.5 5498.5 5398.8 6314.3 6371.0 6499.0 6523.8 6279.7 6311.8 6315.2 6324.3 6331.3 6407.7 6458.7 6467.7 6469.8 6477.0 6129.5 6172.8 6247.3 6293.6 6306.8 6318.4 6332.1 6340.6 6355.2 6356.0 6246.3 6249.9 6256.8 6257.3 6270.9 6039.0 6112.8 6203.5 6228.9 6230.5 4775.6 5049.4 6076.1 6090.7 6106.6 6060.5 6175.5 6224.0 6234.3 6237.9 5983.5 5989.1 5992.1 5992.9 6137.4 15:10:47 INFO - PROCESS | 1663 | 15:10:47 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:64832.26 Median:35243.24 stddev:138015.99 (391.6%) stddev-sans-first:138318.69 15:10:47 INFO - PROCESS | 1663 | Values: 518.9 531.4 567.3 580.0 629.9 27194.0 33584.3 34873.0 39328.2 41024.0 44065.8 44431.0 44516.3 44517.8 44604.3 9658.2 9883.8 9895.2 9898.0 9931.3 9199.5 11858.9 12166.7 12167.3 12172.2 11821.8 11879.2 11914.0 11931.5 11971.4 11823.4 11931.2 11938.2 11939.0 11946.5 11673.5 11775.5 11779.9 11780.2 11787.0 42538.9 42945.1 43044.4 43046.0 43084.8 3347.6 3374.5 3494.6 3537.2 3741.8 28357.0 29575.0 29711.7 30069.0 30194.8 2757.4 2773.7 2810.4 2823.3 2829.3 519566.0 520640.0 520991.0 521578.0 523049.0 37263.3 63070.7 65841.7 65916.4 66099.7 32877.5 37117.8 37125.0 37158.0 37162.8 16310.5 16515.8 16521.9 16526.8 16528.8 12970.7 13166.6 13898.9 13965.8 14080.9 8370.2 8432.6 8443.6 8476.8 8503.2 3249.5 3330.5 3518.6 3535.3 3552.7 921.9 1040.0 1088.9 1187.3 1206.7 26834.2 30964.0 31560.0 31919.3 32245.7 1144.0 1163.9 1209.8 1218.0 1289.7 16013.4 16182.4 16192.3 16531.9 16544.6 519890.8 623448.0 624908.0 625905.0 627308.0 64088.4 64696.7 64715.0 64773.0 65016.3 1503.6 1540.1 1544.5 1559.4 1605.2 28474.0 29676.0 30001.0 30536.2 30659.8 52405.7 53230.7 53319.7 53411.2 53467.0 403680.0 404456.0 405470.0 405625.0 405811.0 24603.8 27688.9 28266.9 28271.0 28592.4 43319.0 45337.0 45702.8 46245.5 48800.3 38126.0 38167.0 39349.6 39360.8 40147.8 37860.1 38766.4 39447.4 39597.6 39756.4 39160.2 39990.4 40645.0 41458.6 41465.4 32398.8 34215.7 35197.8 35288.6 35621.8 21390.8 24321.0 25067.0 25500.6 26393.0 15:10:47 INFO - PROCESS | 1663 | 15:10:47 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:35892.96 Median:14807.43 stddev:107376.84 (725.2%) stddev-sans-first:107644.97 15:10:47 INFO - PROCESS | 1663 | Values: 389.8 402.4 419.5 420.7 421.2 20403.0 20792.6 21420.7 21507.0 21541.5 20950.4 21119.9 21901.5 21902.5 21905.9 5858.3 6078.8 6273.8 6286.1 6288.6 6128.6 6200.8 6224.8 6238.3 6239.9 5922.5 6220.3 6228.8 6229.0 6230.7 5904.1 6109.6 6194.2 6198.9 6208.2 5419.6 5436.3 5448.9 5456.2 5456.8 20586.6 27293.5 27477.6 27981.7 28890.4 2165.2 2180.7 2229.6 2321.4 2961.9 14923.6 16015.8 16141.0 16197.4 16225.7 1801.2 1817.4 1830.1 1883.4 1914.9 85991.0 96804.0 118268.0 119724.0 122880.0 11388.7 11671.7 11840.6 11842.3 11992.8 14666.9 14814.6 14848.5 14928.9 14984.7 9310.3 9346.3 9399.3 9414.1 9423.7 8165.8 9272.9 9589.3 9616.6 9726.7 6962.5 7083.4 7098.4 7106.9 7113.9 1737.3 1913.2 1975.3 2005.6 2015.0 754.5 922.8 954.3 994.2 1140.3 21441.8 22181.0 22280.7 22388.6 22413.0 1023.6 1027.9 1031.6 1051.0 1051.8 11606.7 11937.9 12042.9 12053.4 12077.0 642670.0 643598.0 649824.0 654637.0 661575.0 71972.6 99723.5 112522.0 112911.4 113783.0 1011.8 1020.9 1022.4 1046.0 1053.6 18101.0 18360.4 18492.8 18530.4 18581.3 50495.0 51249.5 51810.7 52446.7 52550.5 50761.2 76904.9 86441.3 86561.7 86726.6 7204.0 8189.9 8403.5 8590.0 8744.3 7902.9 9909.9 10004.6 13338.1 13916.2 11469.9 11557.8 11694.3 11859.9 12092.4 5284.9 9550.7 9829.1 11269.3 11762.5 11512.7 11791.4 11823.9 12010.0 12088.9 8437.4 8650.1 8745.6 8756.5 9019.7 8461.3 10732.2 11683.3 11913.3 12029.0 15:10:47 INFO - PROCESS | 1663 | 15:10:47 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5741.17 Median:5063.41 stddev:3198.96 (63.2%) stddev-sans-first:3191.94 15:10:47 INFO - PROCESS | 1663 | Values: 1483.8 1634.7 1660.6 1948.4 2018.5 8111.8 8689.3 8794.9 8834.5 8836.6 8510.9 8778.3 8785.2 8785.6 8795.0 2516.3 2540.4 2542.0 2543.8 2544.4 2460.1 2513.2 2517.1 2517.3 2521.1 2492.2 2526.4 2527.2 2528.8 2537.3 2499.9 2534.1 2540.6 2551.3 2551.7 2467.8 2526.9 2527.3 2533.2 2534.9 7434.0 8654.0 8867.6 8910.5 8960.3 4612.8 4668.9 5540.4 5620.8 5636.4 3617.9 3691.6 3724.4 3725.5 3745.9 909.7 1026.5 1050.5 1059.5 1069.3 12010.4 12094.7 12114.1 12152.7 12152.8 4112.4 4602.9 4769.7 4772.5 4807.1 9306.0 9413.0 9434.3 9434.6 9437.8 5272.5 5376.8 5418.4 5454.3 5459.1 4318.5 4600.3 4850.1 4995.3 5032.9 3529.7 3896.4 3904.7 3937.8 4008.9 1055.2 1056.5 1118.8 1247.7 1256.8 962.4 983.2 988.6 999.5 1005.3 5978.6 6015.8 6130.2 6146.6 6267.6 464.5 481.0 489.4 493.9 495.4 3456.9 3941.6 4031.4 4103.4 4124.6 10615.8 11037.7 11136.3 11141.0 11168.3 10873.8 10902.8 10969.5 10981.9 11027.4 8100.8 8392.3 8475.4 8554.0 8592.4 5928.4 5972.2 6077.3 6104.6 6250.8 9424.5 9500.2 9657.7 9664.3 9673.3 9341.6 9797.7 9825.0 9856.8 9946.9 7001.4 7172.1 7479.5 7610.1 7759.7 7034.7 8344.8 8386.1 8414.9 8435.5 7347.9 7389.4 7521.7 7573.9 7607.0 7428.6 7434.6 7440.7 7531.8 7538.5 7109.3 7121.1 7165.1 7176.9 7180.3 4957.3 4978.0 5062.8 5064.0 5105.3 5036.4 5095.0 5100.2 5174.0 5385.2 15:10:47 INFO - PROCESS | 1663 | 15:10:47 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5876.31 Median:6524.01 stddev:1851.16 (28.4%) stddev-sans-first:1808.77 15:10:47 INFO - PROCESS | 1663 | Values: 320.0 324.1 343.3 343.3 343.8 5396.5 6750.4 6842.3 6850.6 6863.1 6438.3 6582.5 6592.8 6701.8 6745.8 5029.8 5055.1 5073.1 5086.1 5122.2 5077.3 5083.1 5085.5 5098.6 5100.3 4805.4 4872.4 4994.1 5033.6 5048.2 4954.5 4983.6 4998.4 5008.4 5037.1 4317.9 4321.7 4323.4 4325.7 4328.0 5079.4 6432.2 6435.8 6451.6 6459.5 5888.9 5937.6 5937.8 5942.2 5948.5 5893.7 7157.2 7230.5 7252.6 7256.9 4786.5 4831.7 4839.4 4840.1 4841.5 7622.0 7644.5 7646.0 7648.4 7655.1 4896.2 4900.5 4911.7 4915.8 4918.0 4982.1 4983.7 4993.6 4994.8 4997.4 5714.1 5929.1 5934.9 5935.6 5935.8 5830.6 6480.2 6627.8 7242.6 7253.4 1635.0 1712.3 1741.1 1747.6 1750.6 1044.4 1079.0 1079.3 1084.8 1099.8 5266.6 6583.2 6615.0 6619.1 6623.7 7325.6 7325.8 7339.8 7361.9 7363.0 6567.8 6592.2 6602.6 6613.4 6614.9 3822.5 3901.0 3953.0 3963.7 4003.4 6288.5 7792.2 7838.2 7881.8 7906.4 7722.2 7749.4 7779.3 7793.5 7797.0 7868.4 7880.1 7882.7 7899.5 7908.2 7264.6 7536.0 7537.7 7546.7 7568.2 6633.4 7383.6 7394.6 7413.0 7422.0 7836.5 7841.1 7841.8 7850.3 7869.2 4685.6 4747.1 4761.4 4763.2 4766.7 6381.9 6943.5 7495.7 7515.8 7517.7 7236.0 7237.6 7258.0 7258.9 7279.6 5981.8 6271.7 7183.5 7261.6 7263.3 5856.2 6710.4 6970.5 7037.0 7090.8 6939.6 6953.7 7237.0 7265.9 7268.7 6946.2 6954.7 6982.0 7049.0 7065.8 15:10:47 INFO - PROCESS | 1663 | 15:10:47 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:19003.95 Median:4202.45 stddev:26942.39 (641.1%) stddev-sans-first:26982.94 15:10:47 INFO - PROCESS | 1663 | Values: 707.7 717.8 752.1 765.0 818.5 15388.3 15632.3 15906.4 15970.8 15976.9 14697.2 14748.9 14750.0 14752.9 14755.9 800.7 811.7 814.4 952.8 980.5 799.5 801.4 963.7 1002.0 1002.1 1038.1 1040.0 1040.6 1043.4 1044.1 1038.2 1039.2 1039.4 1040.8 1042.7 620.7 639.9 730.5 761.8 764.1 15421.9 15540.3 15587.3 15611.3 15613.5 13176.2 13241.5 13510.6 13581.5 13617.3 10141.5 10199.6 10471.5 10584.4 10601.6 3520.4 3524.8 3536.6 3617.4 3795.0 83464.0 83886.6 84148.7 84350.9 84597.0 8246.8 9666.0 9915.2 10088.2 10806.9 23031.3 23166.3 23343.9 23379.6 23386.6 7735.7 7834.0 7847.0 7876.0 8095.2 4147.6 4257.3 4276.6 4339.2 4348.5 3808.4 3850.8 3867.8 3869.2 3873.9 684.5 695.2 699.5 707.1 712.1 562.9 568.0 608.2 612.3 614.0 8100.6 8389.4 8502.4 8554.2 8567.1 543.5 591.3 607.2 628.6 630.0 3987.6 4036.1 4053.5 4063.2 4075.9 98485.0 99989.5 100620.0 100950.0 103060.0 83962.7 84459.6 85882.6 86935.0 87851.0 57294.1 58899.7 71042.0 72456.0 72768.3 8618.1 8681.4 8847.9 8856.2 8881.7 49215.5 50682.7 50735.5 51042.0 52744.0 60083.7 62046.0 71399.3 71728.0 72145.6 10942.4 11115.7 11122.5 11440.6 11729.8 11885.5 11986.9 12105.1 12106.2 12622.5 11124.0 11477.3 11548.2 11665.4 11692.0 11445.1 11542.4 11773.2 11804.3 11987.0 11473.0 11536.1 11584.4 11670.5 11707.5 8019.8 9926.5 10009.8 10016.9 10249.9 9839.0 9879.8 9966.2 9975.9 9989.8 15:10:47 INFO - PROCESS | 1663 | -------- Summary: end -------- 15:10:47 INFO - PROCESS | 1663 | 15:10:48 INFO - TEST-INFO | 1663: exit 0 15:10:48 INFO - TEST-OK | dromaeo_css | took 1113444ms 15:10:48 INFO - TEST-START | kraken 15:10:48 INFO - operating with platform_type : mac_ 15:10:48 INFO - Initialising browser for kraken test... 15:10:48 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpBZOjYn/profile http://localhost:49275/getInfo.html) 15:10:50 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 15:10:50 INFO - PROCESS | 1669 | colorDepth:24 15:10:50 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 15:10:50 INFO - PROCESS | 1669 | __metrics 15:10:50 INFO - PROCESS | 1669 | 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" 15:10:50 ERROR - PROCESS | 1669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:10:51 INFO - TEST-INFO | 1669: exit 0 15:10:51 INFO - Browser initialized. 15:10:51 INFO - Running cycle 1/1 for kraken test... 15:10:51 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpBZOjYn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:03 INFO - PROCESS | 1672 | RSS: Main: 161832960 15:11:03 INFO - PROCESS | 1672 | 15:11:05 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 15:11:06 INFO - PROCESS | 1672 | RSS: Main: 223858688 15:11:06 INFO - PROCESS | 1672 | 15:11:09 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 15:11:09 INFO - PROCESS | 1672 | RSS: Main: 239128576 15:11:09 INFO - PROCESS | 1672 | 15:11:12 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 15:11:13 INFO - PROCESS | 1672 | RSS: Main: 323825664 15:11:13 INFO - PROCESS | 1672 | 15:11:15 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 15:11:16 INFO - PROCESS | 1672 | RSS: Main: 230285312 15:11:16 INFO - PROCESS | 1672 | 15:11:18 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:11:18 INFO - PROCESS | 1672 | RSS: Main: 232509440 15:11:18 INFO - PROCESS | 1672 | 15:11:21 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 15:11:22 INFO - PROCESS | 1672 | RSS: Main: 269500416 15:11:22 INFO - PROCESS | 1672 | 15:11:25 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 15:11:25 INFO - PROCESS | 1672 | RSS: Main: 270602240 15:11:25 INFO - PROCESS | 1672 | 15:11:28 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 15:11:28 INFO - PROCESS | 1672 | RSS: Main: 269504512 15:11:28 INFO - PROCESS | 1672 | 15:11:30 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:11:31 INFO - PROCESS | 1672 | RSS: Main: 259350528 15:11:31 INFO - PROCESS | 1672 | 15:11:33 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:11:33 INFO - PROCESS | 1672 | RSS: Main: 267145216 15:11:33 INFO - PROCESS | 1672 | 15:11:35 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:11:36 INFO - PROCESS | 1672 | RSS: Main: 271380480 15:11:36 INFO - PROCESS | 1672 | 15:11:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:11:39 INFO - PROCESS | 1672 | RSS: Main: 277647360 15:11:39 INFO - PROCESS | 1672 | 15:11:42 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:11:43 INFO - PROCESS | 1672 | RSS: Main: 274841600 15:11:43 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 15:11:45 INFO - PROCESS | 1672 | RSS: Main: 336023552 15:11:45 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | __start_tp_report 15:11:45 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 15:11:45 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 15:11:45 INFO - PROCESS | 1672 | |i|pagename|runs| 15:11:45 INFO - PROCESS | 1672 | |0;ai-astar;113;112;122;112;114;111;113;114;113;135 15:11:45 INFO - PROCESS | 1672 | |1;audio-beat-detection;156;119;140;165;116;136;140;115;165;118 15:11:45 INFO - PROCESS | 1672 | |2;audio-dft;184;181;195;261;208;183;182;183;183;184 15:11:45 INFO - PROCESS | 1672 | |3;audio-fft;69;82;97;191;56;55;56;58;133;57 15:11:45 INFO - PROCESS | 1672 | |4;audio-oscillator;89;88;144;77;79;79;127;80;81;125 15:11:45 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;87;84;87;83;87;84;87;84;87;83 15:11:45 INFO - PROCESS | 1672 | |6;imaging-darkroom;92;92;93;93;93;93;93;93;93;92 15:11:45 INFO - PROCESS | 1672 | |7;imaging-desaturate;84;84;84;86;86;84;84;84;86;86 15:11:45 INFO - PROCESS | 1672 | |8;json-parse-financial;58;64;62;62;61;63;63;80;60;57 15:11:45 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;61;63;65;77;77;70;65;75;95;97 15:11:45 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;80;78;81;78;80;78;96;102;108;86 15:11:45 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;129;123;136;140;142;111;129;145;171;135 15:11:45 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;166;165;177;217;202;162;163;163;158;160 15:11:45 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;65;68;67;65;66;64;67;66;66;65 15:11:45 INFO - PROCESS | 1672 | __end_tp_report 15:11:45 INFO - PROCESS | 1672 | __start_cc_report 15:11:45 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1892 15:11:45 INFO - PROCESS | 1672 | __end_cc_report 15:11:45 INFO - PROCESS | 1672 | __startTimestamp1465251105352__endTimestamp 15:11:45 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | ------- Summary: start ------- 15:11:45 INFO - PROCESS | 1672 | Number of tests: 14 15:11:45 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:115.90 Median:113.50 stddev:7.37 (6.5%) stddev-sans-first:7.74 15:11:45 INFO - PROCESS | 1672 | Values: 113.0 112.0 122.0 112.0 114.0 111.0 113.0 114.0 113.0 135.0 15:11:45 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:140.00 stddev:19.88 (14.2%) stddev-sans-first:19.86 15:11:45 INFO - PROCESS | 1672 | Values: 156.0 119.0 140.0 165.0 116.0 136.0 140.0 115.0 165.0 118.0 15:11:45 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:194.40 Median:184.00 stddev:24.86 (13.5%) stddev-sans-first:26.08 15:11:45 INFO - PROCESS | 1672 | Values: 184.0 181.0 195.0 261.0 208.0 183.0 182.0 183.0 183.0 184.0 15:11:45 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:85.40 Median:57.50 stddev:44.77 (77.9%) stddev-sans-first:47.10 15:11:45 INFO - PROCESS | 1672 | Values: 69.0 82.0 97.0 191.0 56.0 55.0 56.0 58.0 133.0 57.0 15:11:45 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:79.50 stddev:25.01 (31.5%) stddev-sans-first:26.37 15:11:45 INFO - PROCESS | 1672 | Values: 89.0 88.0 144.0 77.0 79.0 79.0 127.0 80.0 81.0 125.0 15:11:45 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:85.30 Median:87.00 stddev:1.83 (2.1%) stddev-sans-first:1.83 15:11:45 INFO - PROCESS | 1672 | Values: 87.0 84.0 87.0 83.0 87.0 84.0 87.0 84.0 87.0 83.0 15:11:45 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:93.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 15:11:45 INFO - PROCESS | 1672 | Values: 92.0 92.0 93.0 93.0 93.0 93.0 93.0 93.0 93.0 92.0 15:11:45 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.03 (1.2%) stddev-sans-first:1.05 15:11:45 INFO - PROCESS | 1672 | Values: 84.0 84.0 84.0 86.0 86.0 84.0 84.0 84.0 86.0 86.0 15:11:45 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:62.50 stddev:6.38 (10.2%) stddev-sans-first:6.50 15:11:45 INFO - PROCESS | 1672 | Values: 58.0 64.0 62.0 62.0 61.0 63.0 63.0 80.0 60.0 57.0 15:11:45 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:74.50 Median:76.00 stddev:12.71 (16.7%) stddev-sans-first:12.51 15:11:45 INFO - PROCESS | 1672 | Values: 61.0 63.0 65.0 77.0 77.0 70.0 65.0 75.0 95.0 97.0 15:11:45 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:80.00 stddev:11.18 (14.0%) stddev-sans-first:11.59 15:11:45 INFO - PROCESS | 1672 | Values: 80.0 78.0 81.0 78.0 80.0 78.0 96.0 102.0 108.0 86.0 15:11:45 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:138.00 stddev:15.81 (11.5%) stddev-sans-first:16.56 15:11:45 INFO - PROCESS | 1672 | Values: 129.0 123.0 136.0 140.0 142.0 111.0 129.0 145.0 171.0 135.0 15:11:45 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:165.50 stddev:20.06 (12.1%) stddev-sans-first:21.10 15:11:45 INFO - PROCESS | 1672 | Values: 166.0 165.0 177.0 217.0 202.0 162.0 163.0 163.0 158.0 160.0 15:11:45 INFO - PROCESS | 1672 | 15:11:45 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.22 15:11:45 INFO - PROCESS | 1672 | Values: 65.0 68.0 67.0 65.0 66.0 64.0 67.0 66.0 66.0 65.0 15:11:45 INFO - PROCESS | 1672 | -------- Summary: end -------- 15:11:45 INFO - PROCESS | 1672 | 15:11:46 INFO - TEST-INFO | 1672: exit 0 15:11:46 INFO - TEST-OK | kraken | took 57614ms 15:11:46 INFO - SUITE-END | took 1171s 15:11:46 INFO - Completed test suite (00:19:31) 15:11:46 INFO - javascript benchmark 15:11:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3469.3408252432037, 3550.538430004099, 3561.6999795074807, 3563.4476656118295, 3620.348337299285, 5775.191473193751, 5788.884222315562, 5796.942030579693, 5798.507126894208, 5832.650040997543, 5763.423657634235, 5811.389804070564, 5814.767409303633, 5828.0, 5839.532837373011, 5213.087709650815, 5232.712200828972, 5234.0, 5294.0, 5347.866303342428, 5292.444293349201, 5342.0, 5352.2239275305055, 5354.14333706607, 5356.9732151339185, 5257.8948421031555, 5306.973465132669, 5335.706536140511, 5342.973285133569, 5357.785688572452, 5302.681839089648, 5311.707856067915, 5314.5748340132695, 5338.546223571001, 5339.866503337409, 5125.154349532323, 5191.935653191124, 5254.65844720092, 5269.420363759983, 5277.445868183824, 5555.444455554412, 5656.830295091154, 5669.603127781057, 5672.8865422691315, 5707.914381284284, 4660.720356778605, 6293.590916590407, 6304.1804565406665, 6322.525810564226, 6325.9051114233325, 6173.32093469718, 6223.097650840648, 6304.936950630481, 6323.114763933053, 6338.968305158444, 5907.645541267538, 5935.703214839241, 5945.64326140433, 5977.0, 6009.278886533644, 6363.1091647168505, 6371.490280777527, 6386.680665966683, 6406.8718625627225, 6414.358564143642, 6128.111423843607, 6136.304638670889, 6258.280297765724, 6272.153259309935, 6289.433950944437, 6306.369363063657, 6319.52603554726, 6321.1150438938585, 6345.841353966095, 6434.549581529248, 6243.500519958392, 6322.525810564226, 6328.177336946167, 6340.904886426707, 6344.968275158594, 6161.199044124235, 6217.378262173746, 6288.213973253343, 6327.082573026977, 6342.682865856688, 4978.90042199154, 5028.622853286018, 5033.043721692867, 5036.219385995177, 5038.622103342264, 4517.390152329459, 4535.160995215896, 4538.1377538267625, 4547.613452856478, 4567.200739870509, 5766.163906233573, 5809.738561764646, 5877.35349111606, 5882.794102206402, 5897.52819774417, 6219.284782250099, 6296.087067375205, 6309.968450157719, 6320.178376810985, 6328.367163283635, 5911.645301281937, 5925.614835035709, 5928.258967629046, 5935.40645935403, 5965.821025369246, 5378.757955891994, 5460.6996615186545, 5462.2079798429, 5483.506484416342, 5498.477644623755, 5398.838034858961, 6314.273858506239, 6371.0, 6499.0, 6523.7716679915975, 6279.748810047547, 6311.842203944754, 6315.242170939517, 6324.304326523987, 6331.27190373113, 6407.743690252338, 6458.67706614658, 6467.741290348334, 6469.805905822833, 6476.967615161894, 6129.509639228761, 6172.814815555541, 6247.3440288769025, 6293.622382657055, 6306.810795676137, 6318.4313411793155, 6332.050192471166, 6340.556161068866, 6355.173827402408, 6356.046593011085, 6246.312905580474, 6249.906251406142, 6256.812295631138, 6257.2804127525915, 6270.905936410866, 6039.0, 6112.816615501542, 6203.472704820141, 6228.875422491434, 6230.470410015199, 4775.641826863069, 5049.419316778471, 6076.1493390924425, 6090.725917333819, 6106.57253992234, 6060.484858787053, 6175.505959523317, 6223.968880155751, 6234.251889773256, 6237.875242495215, 5983.461488466059, 5989.071693887455, 5992.101184822312, 5992.850178745566, 6137.3862613738265], "value": 5778.161243979083, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.9481051894811, 531.4472948133941, 567.3163837575721, 579.953603711703, 629.8614304852931, 27194.0, 33584.32831343375, 34872.95381138563, 39328.21343573127, 41024.0, 44065.77967110168, 44431.0, 44516.3322550162, 44517.7774111129, 44604.330935036, 9658.179054780352, 9883.802323953516, 9895.158911492532, 9897.950510247474, 9931.304808663397, 9199.540022998857, 11858.940705296462, 12166.661667216644, 12167.2699638022, 12172.208806427554, 11821.822672659917, 11879.168458207885, 11914.0, 11931.522739090426, 11971.401429928468, 11823.408829558532, 11931.224470409396, 11938.164328496965, 11939.0, 11946.522139114424, 11673.474693638807, 11775.470103845348, 11779.882201177965, 11780.175387722777, 11786.998105161072, 42538.936526586775, 42945.141097178195, 43044.354334685006, 43046.0, 43084.78457607723, 3347.615024272191, 3374.5444365010653, 3494.6155922848466, 3537.2218112015316, 3741.8129093545485, 28357.0, 29575.0, 29711.70288297111, 30069.0, 30194.84902575495, 2757.420941602266, 2773.72262773723, 2810.4379124175043, 2823.265950852793, 2829.2502486841004, 519566.0, 520640.0, 520991.0, 521578.0, 523049.0, 37263.25473490515, 63070.68464657739, 65841.67079164574, 65916.37459939749, 66099.66950165314, 32877.50683739746, 37117.81441092777, 37125.0, 37158.0, 37162.81418592944, 16310.510684679479, 16515.83484165167, 16521.91739041297, 16526.752098718527, 16528.75206871898, 12970.675733106747, 13166.605001849959, 13898.88808895286, 13965.79051314231, 14080.859191407955, 8370.204830541088, 8432.620532075949, 8443.57782110892, 8476.830463390697, 8503.23470887623, 3249.5125731140047, 3330.533725278463, 3518.5777706674853, 3535.3459609971724, 3552.6980206682206, 921.9262459003263, 1039.9785243440547, 1088.9292196007393, 1187.3410257307105, 1206.6922934651607, 26834.194974150807, 30964.0, 31560.0, 31919.320005547335, 32245.677543224738, 1143.9656810295705, 1163.947622356996, 1209.8245754365569, 1218.0377501773676, 1289.6904742861834, 16013.359465621477, 16182.433614823425, 16192.271347789378, 16531.91734041346, 16544.586385340222, 519890.80109199183, 623448.0, 624908.0, 625905.0, 627308.0, 64088.35911640824, 64696.67651661712, 64715.0, 64773.0, 65016.34983650198, 1503.646643038885, 1540.106738091904, 1544.4825983295498, 1559.4230134849724, 1605.2214675881955, 28474.0, 29676.0, 30001.0, 30536.236594085327, 30659.773609055388, 52405.7379713099, 53230.73384633052, 53319.73340133274, 53411.19883201677, 53467.0, 403680.0, 404456.0, 405470.0, 405625.0, 405811.0, 24603.753962460145, 27688.892444302, 28266.85866570654, 28271.0, 28592.42815143727, 43319.0, 45337.0, 45702.77148614236, 46245.53754462412, 48800.267995979375, 38126.0, 38167.0, 39349.60650393459, 39360.80319598383, 40147.79926100468, 37860.05349866275, 38766.41850372303, 39447.408288876264, 39597.60402396054, 39756.403653945796, 39160.2167956645, 39990.40014399728, 40645.0, 41458.58541414668, 41465.37801933034, 32398.83800580982, 34215.65784342125, 35197.82401087978, 35288.647113529565, 35621.82189089038, 21390.7860921395, 24321.0, 25067.0, 25500.57744514268, 26393.0], "value": 19466.737296546897, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.8363385294895, 402.35422147453335, 419.46518189308637, 420.71391453811435, 421.201822546275, 20403.0, 20792.584148317044, 21420.678689819666, 21507.0, 21541.4614634634, 20950.37148885536, 21119.894400528014, 21901.452463688416, 21902.45243868904, 21905.890470547623, 5858.267716535423, 6078.848028799272, 6273.843153921142, 6286.119943207932, 6288.622682639033, 6128.601640893327, 6200.78297259596, 6224.782132625359, 6238.251409830827, 6239.875202495948, 5922.466977971982, 6220.346863579327, 6228.813135605939, 6228.96885515574, 6230.688465576725, 5904.084866845646, 6109.602875813081, 6194.194754681863, 6198.876022479548, 6208.2239720034995, 5419.566434685215, 5436.293281873332, 5448.91826622601, 5456.181572764078, 5456.836294911159, 20586.58826823455, 27293.45413091727, 27477.587836182473, 27981.720182798115, 28890.411027393486, 2165.1880544795704, 2180.7241518437568, 2229.565234779219, 2321.3964369263945, 2961.9040954846846, 14923.626909327246, 16015.839841601668, 16141.0, 16197.352105915867, 16225.675486490321, 1801.1714611278828, 1817.4365946556477, 1830.0941034188163, 1883.4255552056618, 1914.904254787255, 85991.0, 96804.0319596802, 118268.0, 119724.00689982821, 122880.0, 11388.715282118013, 11671.708207294885, 11840.585579504848, 11842.348670823016, 11992.76014479723, 14666.85333146655, 14814.555563333117, 14848.480303189337, 14928.850711492963, 14984.70030599382, 9310.255179585616, 9346.252299815998, 9399.295052870926, 9414.140202516935, 9423.717288481357, 8165.79585510367, 9272.933612634499, 9589.308116375245, 9616.615335386647, 9726.70819875405, 6962.512624116364, 7083.362497375261, 7098.396636285974, 7106.928930710626, 7113.92886071143, 1737.3137610643726, 1913.1964574878584, 1975.2987689370354, 2005.6089062632645, 2015.0, 754.5435011817881, 922.8200500902394, 954.3176628710505, 994.2394068537575, 1140.2816225777708, 21441.78558214429, 22181.0, 22280.66579001316, 22388.552228955654, 22413.0, 1023.6110278094426, 1027.8869324374314, 1031.582209205273, 1050.9947450262853, 1051.8422236664408, 11606.651800446, 11937.940310298392, 12042.87957120435, 12053.397330133459, 12077.033837293171, 642670.0, 643598.0, 649824.0, 654637.0, 661575.0, 71972.64013679897, 99723.50138249263, 112522.0, 112911.43544282226, 113783.0, 1011.7925825205815, 1020.8570800087994, 1022.4172221833484, 1046.0376453662648, 1053.6312290698347, 18101.004444755665, 18360.357387491375, 18492.81507184911, 18530.44408667742, 18581.34965276209, 50495.0, 51249.487505124474, 51810.74094629503, 52446.73776631092, 52550.47449525456, 50761.23858142057, 76904.89606031256, 86441.27117457741, 86561.70157447517, 86726.56636716776, 7204.0, 8189.918100818915, 8403.537805420761, 8589.957050214709, 8744.344174186834, 7902.920970790218, 9909.900900990899, 10004.599356090299, 13338.13302135358, 13916.165030098227, 11469.942650286695, 11557.82663260035, 11694.2983420995, 11859.94070029679, 12092.395380230777, 5284.9471505284455, 9550.713478595653, 9829.115379615869, 11269.267497612629, 11762.529498819951, 11512.712182195177, 11791.35147566892, 11823.881761182278, 12010.0, 12088.879111209128, 8437.367197460093, 8650.09174036717, 8745.562721863755, 8756.51839148853, 9019.729408117766, 8461.280791132822, 10732.248742587944, 11683.299002059903, 11913.344766037952, 12028.97753690946], "value": 9980.411679374209, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.7774333849927, 1634.7384418493043, 1660.5931546771035, 1948.3862583286264, 2018.4751964489237, 8111.797205069876, 8689.304855611552, 8794.91205087949, 8834.514101724402, 8836.602352894128, 8510.872336914952, 8778.341624378165, 8785.165409286108, 8785.560721963891, 8795.032546419889, 2516.2954372775607, 2540.4284036091917, 2541.961870571943, 2543.834650747705, 2544.402065514612, 2460.1143588308196, 2513.158092039169, 2517.0812653381477, 2517.3203235126507, 2521.0924067335745, 2492.1651246832334, 2526.406294520786, 2527.229195095495, 2528.8356256843244, 2537.251510804317, 2499.8625075620835, 2534.1130604288537, 2540.593505039194, 2551.3366524703524, 2551.6682831232006, 2467.7655622715815, 2526.93682657935, 2527.330257481769, 2533.1640558615795, 2534.936626584332, 7433.962830185815, 8654.00478944923, 8867.556622168866, 8910.50992195429, 8960.283177345862, 4612.838550650711, 4668.883277918046, 5540.445955404468, 5620.775168993236, 5636.408177141382, 3617.855285788565, 3691.557013158438, 3724.42271447926, 3725.4598083278042, 3745.906352341186, 909.7452713240303, 1026.5380578739523, 1050.4537640426936, 1059.4649701900569, 1069.3209811769505, 12010.399480025964, 12094.69763255908, 12114.0914431418, 12152.696182595506, 12152.756944861054, 4112.403701463271, 4602.907941841145, 4769.73766442842, 4772.475027746945, 4807.086653535817, 9305.953470232605, 9413.0, 9434.339596228336, 9434.622615095457, 9437.764055898657, 5272.472752724697, 5376.784928602812, 5418.403975562764, 5454.3454785426, 5459.099248624012, 4318.546552611993, 4600.3099535070005, 4850.078485087893, 4995.325631039763, 5032.899342013213, 3529.6646818552194, 3896.4350169225304, 3904.6876249899938, 3937.8031098444962, 4008.9198216036098, 1055.2191378380096, 1056.5298442193305, 1118.78743038824, 1247.7442124364484, 1256.7674980128522, 962.4465932088937, 983.2085171437062, 988.5798535622332, 999.4552968632113, 1005.3314545826943, 5978.5814992950945, 6015.849603759853, 6130.233720784902, 6146.6004709693725, 6267.592606480564, 464.5308238678891, 480.9827215439321, 489.41270475428917, 493.91850344693444, 495.35603715170856, 3456.879009234715, 3941.625545573166, 4031.4355990161403, 4103.384492326175, 4124.587541245852, 10615.787684246427, 11037.668869933916, 11136.276142050741, 11141.0, 11168.329900206014, 10873.83689244662, 10902.836457452986, 10969.451527423756, 10981.901809819114, 11027.44862756859, 8100.756977290691, 8392.28665563434, 8475.406721529556, 8553.973523177134, 8592.398532102692, 5928.3775203603, 5972.163897054503, 6077.270727512727, 6104.603200791934, 6250.843728906813, 9424.481653509123, 9500.192483638692, 9657.71026869195, 9664.323497355117, 9673.322867399214, 9341.57962891658, 9797.657082002095, 9824.950875245579, 9856.753581160528, 9946.900530994597, 7001.36987671112, 7172.13934327884, 7479.513831600929, 7610.124835643972, 7759.650815713194, 7034.718611255493, 8344.791380215544, 8386.11945745688, 8414.87377689323, 8435.451695639764, 7347.926520734724, 7389.371903388273, 7521.661525231487, 7573.9242607573215, 7607.0, 7428.591427471541, 7434.591097489473, 7440.73957411488, 7531.8117047074265, 7538.547687138789, 7109.253528379652, 7121.109861267341, 7165.068541089833, 7176.892346614701, 7180.281971802987, 4957.281194226889, 4977.975110124571, 5062.82280120194, 5064.0, 5105.33630628016, 5036.445990940921, 5094.974525127351, 5100.2349647553165, 5174.0, 5385.165299378603], "value": 4569.186028578052, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.99040028799135, 324.1264791387211, 343.3270789253064, 343.3339321715871, 343.7799808122802, 5396.51431371176, 6750.426213771829, 6842.281560436151, 6850.623215723133, 6863.0734850795125, 6438.323975982513, 6582.506312026593, 6592.835179120524, 6701.765438209663, 6745.797626071226, 5029.798808047673, 5055.140626093573, 5073.112205364065, 5086.109930762121, 5122.231665250205, 5077.263796749469, 5083.085044691954, 5085.466026067265, 5098.643094983353, 5100.285959965608, 4805.351277577517, 4872.366592343008, 4994.1260279451135, 5033.647644664875, 5048.242763585473, 4954.479779623124, 4983.626228032912, 4998.350214472095, 5008.39899212095, 5037.0681423936685, 4317.913641727179, 4321.719088259253, 4323.351497275403, 4325.697201195918, 4327.956720432787, 5079.3650793650795, 6432.228132624068, 6435.774747883802, 6451.612903225821, 6459.515536334794, 5888.852778680524, 5937.584369094165, 5937.821865344046, 5942.168096466498, 5948.524118070544, 5893.734781934823, 7157.212706602321, 7230.457715671346, 7252.564846109198, 7256.927430725678, 4786.473487916326, 4831.710097394168, 4839.395075615548, 4840.080384726891, 4841.49164337743, 7622.047244094489, 7644.464887457824, 7646.0, 7648.426368022365, 7655.119661238973, 4896.2410826321975, 4900.509949005071, 4911.722952032497, 4915.827946021872, 4917.975410122998, 4982.103221420107, 4983.700977941335, 4993.625478089158, 4994.800207991712, 4997.375328083989, 5714.085746280575, 5929.110633405024, 5934.910976335358, 5935.554833387513, 5935.762569497172, 5830.62100963436, 6480.189976252968, 6627.834304142339, 7242.565446073252, 7253.3834624057545, 1635.0, 1712.332190445727, 1741.1294352823588, 1747.6417334446407, 1750.5973626065822, 1044.4020648407948, 1078.9730256743487, 1079.2930630437077, 1084.7505073833063, 1099.769048499824, 5266.552343050884, 6583.210014798159, 6614.966925165343, 6619.139511863524, 6623.668816559153, 7325.597092159983, 7325.7802265932105, 7339.816504587428, 7361.852762944818, 7362.9631851840395, 6567.8358041048405, 6592.17597800275, 6602.603843769293, 6613.371729685672, 6614.86770264592, 3822.4839646647347, 3901.044244160142, 3953.031507280735, 3963.6630886374983, 4003.3594624859884, 6288.496920246461, 7792.220777922163, 7838.176991415933, 7881.802954926173, 7906.407019473562, 7722.15056343813, 7749.418793590503, 7779.338756205786, 7793.454458187985, 7797.0, 7868.370530357558, 7880.05439347282, 7882.7241046563095, 7899.486533375312, 7908.169642187602, 7264.636768161465, 7536.020317358928, 7537.660805263886, 7546.6981320748755, 7568.205338439385, 6633.436157926631, 7383.593902335423, 7394.593297368697, 7412.96293518529, 7422.0, 7836.529808211526, 7841.137474877873, 7841.803954901173, 7850.293473587404, 7869.213078692085, 4685.648576356719, 4747.0774336393815, 4761.40482439695, 4763.16644587189, 4766.737829419415, 6381.904271435839, 6943.479239057192, 7495.737649182252, 7515.774526764206, 7517.6992920284765, 7235.963820180866, 7237.565746055254, 7257.963710181415, 7258.927410725825, 7279.636018199175, 5981.790637327673, 6271.749130034747, 7183.461240407095, 7261.636918154177, 7263.273672632695, 5856.238688970407, 6710.429613482908, 6970.546914450544, 7037.0, 7090.751823686146, 6939.583624982517, 6953.6523173842115, 7236.96381518089, 7265.891011634935, 7268.709251629875, 6946.166460024628, 6954.652267386711, 6982.0, 7049.048378468841, 7065.82335441618], "value": 5259.832290812617, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.7063018847178, 717.8097804081917, 752.1087511299114, 764.9961750191248, 818.4557269415839, 15388.286765437026, 15632.2965466554, 15906.443274485366, 15970.84029159708, 15976.920115399422, 14697.191654459, 14748.852511474883, 14750.041247318917, 14752.926235368808, 14755.92622036891, 800.655718041242, 811.7118422959853, 814.3688641302979, 952.8094381123768, 980.4901451245348, 799.4563696686251, 801.4309840013568, 963.6916186820185, 1001.9749506262365, 1002.1231422505308, 1038.0605551975436, 1040.0379648824844, 1040.630576145465, 1043.3635482355758, 1044.0968562193686, 1038.2472707287232, 1039.1998161415743, 1039.4231201683062, 1040.8126537223334, 1042.713253855192, 620.6772478311298, 639.8784230996142, 730.5178582135818, 761.8133557278502, 764.1250767870812, 15421.92289038559, 15540.300686469136, 15587.298571564306, 15611.297491612904, 15613.453529126426, 13176.209427434289, 13241.470341186341, 13510.594682159453, 13581.52464663742, 13617.282483862013, 10141.492925353776, 10199.592016319339, 10471.528781204865, 10584.364938103738, 10601.575936962512, 3520.436730123168, 3524.788512689247, 3536.5932917714536, 3617.439296908983, 3794.9620503794886, 83464.0, 83886.58056709738, 84148.73776893351, 84350.8912277198, 84597.0, 8246.793830154174, 9665.951670241604, 9915.16569434657, 10088.243381746399, 10806.94596527028, 23031.309060728207, 23166.3050108497, 23343.88328058349, 23379.649305260435, 23386.64920026201, 7735.729249476241, 7834.0, 7847.0, 7876.0, 8095.190480951976, 4147.605977432139, 4257.297545904891, 4276.615104640598, 4339.153864996296, 4348.499922508889, 3808.409696497047, 3850.7882066486613, 3867.8066096695616, 3869.2068126034096, 3873.86441474547, 684.5276759036249, 695.1935754524727, 699.4579201119071, 707.0631413377193, 712.1027505343201, 562.9268195134688, 567.9829605111853, 608.248812716295, 612.2713970375239, 613.9785107521216, 8100.554469504234, 8389.412741108186, 8502.404831661725, 8554.230119289294, 8567.100454452317, 543.5325619966825, 591.2845456996996, 607.1530215349562, 628.5505863307757, 629.9842503937347, 3987.641112299907, 4036.0515278909434, 4053.4730485036757, 4063.227986682521, 4075.917551480878, 98485.0, 99989.50005249926, 100620.0, 100950.0, 103060.0, 83962.74055889166, 84459.57770211232, 85882.57058714666, 86935.0, 87851.0, 57294.14058789121, 58899.70550147307, 71042.0, 72456.0, 72768.27231727721, 8618.095100014409, 8681.365327474046, 8847.911520884967, 8856.158664926821, 8881.689140880038, 49215.50784492109, 50682.74658626683, 50735.492645074555, 51042.0, 52744.0, 60083.699581501816, 62046.0, 71399.28600714135, 71728.0, 72145.6392718033, 10942.438985721197, 11115.666530004113, 11122.499487522919, 11440.599579014695, 11729.824052639387, 11885.46515406826, 11986.940065299967, 12105.13191362041, 12106.213096148722, 12622.495100195889, 11123.99884010443, 11477.311361318347, 11548.191626586058, 11665.35840528779, 11692.0061794745, 11445.141614378788, 11542.422878856192, 11773.234739741889, 11804.291742495478, 11987.041036716868, 11473.0, 11536.134789890624, 11584.362860042442, 11670.533178672758, 11707.531698731955, 8019.799505012421, 9926.503674816086, 10009.849852252368, 10016.899831001889, 10249.897501024894, 9838.950805246215, 9879.802403952024, 9966.152877005536, 9975.850362244428, 9989.800203995734], "value": 7167.773622610758, "unit": "score"}], "name": "dromaeo_css", "value": 7604.613349472887, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 122.0, 112.0, 114.0, 111.0, 113.0, 114.0, 113.0, 135.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 119.0, 140.0, 165.0, 116.0, 136.0, 140.0, 115.0, 165.0, 118.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 195.0, 261.0, 208.0, 183.0, 182.0, 183.0, 183.0, 184.0], "value": 194.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 82.0, 97.0, 191.0, 56.0, 55.0, 56.0, 58.0, 133.0, 57.0], "value": 85.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 144.0, 77.0, 79.0, 79.0, 127.0, 80.0, 81.0, 125.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 83.0, 87.0, 84.0, 87.0, 84.0, 87.0, 83.0], "value": 85.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 92.0], "value": 92.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 86.0, 86.0, 84.0, 84.0, 84.0, 86.0, 86.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 64.0, 62.0, 62.0, 61.0, 63.0, 63.0, 80.0, 60.0, 57.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 65.0, 77.0, 77.0, 70.0, 65.0, 75.0, 95.0, 97.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 81.0, 78.0, 80.0, 78.0, 96.0, 102.0, 108.0, 86.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 123.0, 136.0, 140.0, 142.0, 111.0, 129.0, 145.0, 171.0, 135.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 177.0, 217.0, 202.0, 162.0, 163.0, 163.0, 158.0, 160.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 67.0, 65.0, 66.0, 64.0, 67.0, 66.0, 66.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1491.9, "alertThreshold": 2.0}]} 15:11:46 INFO - Return code: 0 15:11:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:11:46 ERROR - # TBPL SUCCESS # 15:11:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:11:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:11:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:11:46 INFO - 2016-06-06 15:11:46.689 screenresolution[1676:10040] starting screenresolution argv=screenresolution get 15:11:46 INFO - 2016-06-06 15:11:46.691 screenresolution[1676:10040] Display 0: 1600x1200x32@60 15:11:46 INFO - 2016-06-06 15:11:46.697 screenresolution[1677:10043] starting screenresolution argv=screenresolution list 15:11:46 INFO - Available Modes on Display 0 15:11:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:11:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:11:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:11:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:11:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:11:46 INFO - Intel Iris: 15:11:46 INFO - Chipset Model: Intel Iris 15:11:46 INFO - Type: GPU 15:11:46 INFO - Bus: Built-In 15:11:46 INFO - VRAM (Dynamic, Max): 1536 MB 15:11:46 INFO - Vendor: Intel (0x8086) 15:11:46 INFO - Device ID: 0x0a2e 15:11:46 INFO - Revision ID: 0x0009 15:11:46 INFO - Displays: 15:11:46 INFO - Display: 15:11:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:11:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:11:46 INFO - Display Serial Number: 1600x1200 60 15:11:46 INFO - Main Display: Yes 15:11:46 INFO - Mirror: Off 15:11:46 INFO - Online: Yes 15:11:46 INFO - Rotation: Supported 15:11:46 INFO - Return code: 0 15:11:46 INFO - Running post-action listener: _resource_record_post_action 15:11:46 INFO - Running post-run listener: _resource_record_post_run 15:11:47 INFO - Total resource usage - Wall time: 1195s; CPU: 52.0%; Read bytes: 37918208; Write bytes: 493670912; Read time: 392; Write time: 1627 15:11:47 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 200122880; Write bytes: 194646016; Read time: 17636; Write time: 379 15:11:48 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 30838272; Write bytes: 298127872; Read time: 306; Write time: 1246 15:11:48 INFO - Running post-run listener: _upload_blobber_files 15:11:48 INFO - Blob upload gear active. 15:11:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:11:48 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 15:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:11:48 INFO - (blobuploader) - INFO - Open directory for files ... 15:11:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:11:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:11:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:49 INFO - (blobuploader) - INFO - Done attempting. 15:11:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:11:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:11:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:50 INFO - (blobuploader) - INFO - Done attempting. 15:11:50 INFO - (blobuploader) - INFO - Iteration through files over. 15:11:50 INFO - Return code: 0 15:11:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:11:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:11:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71ae1f05015a9ab01e98ffc35322a57ce57bf18532a84c0e4cbb3e14d8792b29fbb61a6e35eefd5cfb9f625c3b15c26474c75f077e41e81c8e11ca63faabd1ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b2cd1cf06eb67277822ea3e9f203545ccb48158bada06b3f9c000e77792002264d25a51d7a2deaf9be66fdf7f67fa34b88903896d146454980941edc5c2f11a7"} 15:11:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:11:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:11:50 INFO - Contents: 15:11:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71ae1f05015a9ab01e98ffc35322a57ce57bf18532a84c0e4cbb3e14d8792b29fbb61a6e35eefd5cfb9f625c3b15c26474c75f077e41e81c8e11ca63faabd1ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b2cd1cf06eb67277822ea3e9f203545ccb48158bada06b3f9c000e77792002264d25a51d7a2deaf9be66fdf7f67fa34b88903896d146454980941edc5c2f11a7"} 15:11:50 INFO - Running post-run listener: copy_logs_to_upload_dir 15:11:50 INFO - Copying logs to upload dir... 15:11:50 INFO - mkdir: /builds/slave/test/build/upload/logs 15:11:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1292.522721 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-06-06 15:11:50.107829) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 15:11:50.111285) ========= 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.66WHtbp6VC/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.yzrHO0tX9K/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71ae1f05015a9ab01e98ffc35322a57ce57bf18532a84c0e4cbb3e14d8792b29fbb61a6e35eefd5cfb9f625c3b15c26474c75f077e41e81c8e11ca63faabd1ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b2cd1cf06eb67277822ea3e9f203545ccb48158bada06b3f9c000e77792002264d25a51d7a2deaf9be66fdf7f67fa34b88903896d146454980941edc5c2f11a7"} build_url:https://queue.taskcluster.net/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011405 build_url: 'https://queue.taskcluster.net/v1/task/VaDceZ4mTa2XQB_ypjLXQQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71ae1f05015a9ab01e98ffc35322a57ce57bf18532a84c0e4cbb3e14d8792b29fbb61a6e35eefd5cfb9f625c3b15c26474c75f077e41e81c8e11ca63faabd1ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b2cd1cf06eb67277822ea3e9f203545ccb48158bada06b3f9c000e77792002264d25a51d7a2deaf9be66fdf7f67fa34b88903896d146454980941edc5c2f11a7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 15:11:50.143132) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 15:11:50.143455) ========= 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.66WHtbp6VC/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.yzrHO0tX9K/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.005120 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 15:11:50.193084) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 15:11:50.193428) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 15:11:50.193804) ========= ========= Total master_lag: 0.17 =========