builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0134 starttime: 1466697079.4 results: success (0) buildid: 20160623064524 builduid: 3aa0692813ad40a1939d3c721e4e1f25 revision: b52a29cf207d80cbc566c5d28063e303f93c2bd5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 08:51:19.397985) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 08:51:19.398496) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 08:51:19.398817) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 08:51:19.424545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:51:19.426103) ========= 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.kmTo8IZecM/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.RQNfeAQX49/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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-23 08:51:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.3M=0s 2016-06-23 08:51:19 (29.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.310514 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:51:19.759432) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:51:19.759807) ========= 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.kmTo8IZecM/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.RQNfeAQX49/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.027640 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:51:19.808324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 08:51:19.808725) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b52a29cf207d80cbc566c5d28063e303f93c2bd5 --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 b52a29cf207d80cbc566c5d28063e303f93c2bd5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kmTo8IZecM/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.RQNfeAQX49/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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-23 08:51:19,883 truncating revision to first 12 chars 2016-06-23 08:51:19,883 Setting DEBUG logging. 2016-06-23 08:51:19,883 attempt 1/10 2016-06-23 08:51:19,883 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b52a29cf207d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 08:51:20,864 unpacking tar archive at: mozilla-beta-b52a29cf207d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.262603 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 08:51:21.093088) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 08:51:21.093462) ========= script_repo_revision: b52a29cf207d80cbc566c5d28063e303f93c2bd5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 08:51:21.093914) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 08:51:21.094262) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 08:51:21.112474) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-23 08:51:21.112790) ========= /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.kmTo8IZecM/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.RQNfeAQX49/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 08:51:21 INFO - MultiFileLogger online at 20160623 08:51:21 in /builds/slave/test 08:51:21 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 08:51:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:51:21 INFO - {'append_to_log': False, 08:51:21 INFO - 'base_work_dir': '/builds/slave/test', 08:51:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:51:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:51:21 INFO - 'branch': 'Mozilla-Beta', 08:51:21 INFO - 'buildbot_json_path': 'buildprops.json', 08:51:21 INFO - 'config_files': ('talos/mac_config.py',), 08:51:21 INFO - 'default_actions': ('clobber', 08:51:21 INFO - 'read-buildbot-config', 08:51:21 INFO - 'download-and-extract', 08:51:21 INFO - 'populate-webroot', 08:51:21 INFO - 'create-virtualenv', 08:51:21 INFO - 'install', 08:51:21 INFO - 'run-tests'), 08:51:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:51:21 INFO - 'download_minidump_stackwalk': True, 08:51:21 INFO - 'download_symbols': 'ondemand', 08:51:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:51:21 INFO - 'tooltool.py': '/tools/tooltool.py', 08:51:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:51:21 INFO - '/tools/misc-python/virtualenv.py')}, 08:51:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:51:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:51:21 INFO - 'installer_path': 'installer.exe', 08:51:21 INFO - 'log_level': 'info', 08:51:21 INFO - 'log_name': 'talos', 08:51:21 INFO - 'log_to_console': True, 08:51:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:51:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:51:21 INFO - 'opt_config_files': (), 08:51:21 INFO - 'pip_index': False, 08:51:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:51:21 INFO - 'cmd': ('bash', 08:51:21 INFO - '-c', 08:51:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:51:21 INFO - 'enabled': True, 08:51:21 INFO - 'halt_on_failure': False, 08:51:21 INFO - 'name': 'check_screen_resolution'},), 08:51:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:51:21 INFO - 'cmd': ('bash', 08:51:21 INFO - '-c', 08:51:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:51:21 INFO - 'enabled': True, 08:51:21 INFO - 'halt_on_failure': False, 08:51:21 INFO - 'name': 'check_screen_resolution'},), 08:51:21 INFO - 'run_cmd_checks_enabled': True, 08:51:21 INFO - 'sps_profile': False, 08:51:21 INFO - 'sps_profile_interval': 0, 08:51:21 INFO - 'suite': 'dromaeojs', 08:51:21 INFO - 'system_bits': '32', 08:51:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:51:21 INFO - 'title': 't-yosemite-r7-0134', 08:51:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:51:21 INFO - 'use_talos_json': True, 08:51:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:51:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:51:21 INFO - 'work_dir': 'build'} 08:51:21 INFO - ##### 08:51:21 INFO - ##### Running clobber step. 08:51:21 INFO - ##### 08:51:21 INFO - Running pre-action listener: _resource_record_pre_action 08:51:21 INFO - Running main action method: clobber 08:51:21 INFO - rmtree: /builds/slave/test/build 08:51:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:51:22 INFO - Running post-action listener: _resource_record_post_action 08:51:22 INFO - ##### 08:51:22 INFO - ##### Running read-buildbot-config step. 08:51:22 INFO - ##### 08:51:22 INFO - Running pre-action listener: _resource_record_pre_action 08:51:22 INFO - Running main action method: read_buildbot_config 08:51:22 INFO - Using buildbot properties: 08:51:22 INFO - { 08:51:22 INFO - "project": "", 08:51:22 INFO - "product": "firefox", 08:51:22 INFO - "script_repo_revision": "production", 08:51:22 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:51:22 INFO - "repository": "", 08:51:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:51:22 INFO - "buildid": "20160623064524", 08:51:22 INFO - "pgo_build": "False", 08:51:22 INFO - "basedir": "/builds/slave/test", 08:51:22 INFO - "buildnumber": 38, 08:51:22 INFO - "slavename": "t-yosemite-r7-0134", 08:51:22 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:51:22 INFO - "platform": "yosemite_r7", 08:51:22 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:51:22 INFO - "branch": "mozilla-beta", 08:51:22 INFO - "repo_path": "releases/mozilla-beta", 08:51:22 INFO - "revision": "b52a29cf207d80cbc566c5d28063e303f93c2bd5", 08:51:22 INFO - "stage_platform": "macosx64", 08:51:22 INFO - "builduid": "3aa0692813ad40a1939d3c721e4e1f25", 08:51:22 INFO - "slavebuilddir": "test" 08:51:22 INFO - } 08:51:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 08:51:22 INFO - Running post-action listener: _resource_record_post_action 08:51:22 INFO - ##### 08:51:22 INFO - ##### Running download-and-extract step. 08:51:22 INFO - ##### 08:51:22 INFO - Running pre-action listener: _resource_record_pre_action 08:51:22 INFO - Running main action method: download_and_extract 08:51:22 INFO - mkdir: /builds/slave/test/build/tests 08:51:22 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')]} 08:51:22 INFO - https://queue.taskcluster.net/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:51:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:51:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:51:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/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 08:51:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/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 08:51:23 INFO - Downloaded 1165 bytes. 08:51:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 08:51:23 INFO - Using the following test package requirements: 08:51:23 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:51:23 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:51:23 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 08:51:23 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:51:23 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 08:51:23 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:51:23 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:51:23 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 08:51:23 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:51:23 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:51:23 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 08:51:23 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:51:23 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 08:51:23 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:51:23 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 08:51:23 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:51:23 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 08:51:23 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 08:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:23 INFO - https://queue.taskcluster.net/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:51:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:51:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:51:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/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 08:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/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 08:51:24 INFO - Downloaded 18301215 bytes. 08:51:24 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'] 08:51:24 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 08:51:27 INFO - Return code: 0 08:51:27 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 08:51:27 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')]} 08:51:27 INFO - https://queue.taskcluster.net/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:51:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:51:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:51:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/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 08:51:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/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 08:51:29 INFO - Downloaded 18301215 bytes. 08:51:29 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'] 08:51:29 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 08:51:33 INFO - Return code: 0 08: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')]} 08:51:33 INFO - https://queue.taskcluster.net/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:51:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:51:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:51:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/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 08:51:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/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 08:51:34 INFO - Downloaded 10840145 bytes. 08:51:34 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'] 08:51:34 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 08:51:34 INFO - Return code: 0 08:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:34 INFO - https://queue.taskcluster.net/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 08:51:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:51:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:51:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 08:51:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GU4-UeugQUWqtmm6TC6AMw/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 08:51:37 INFO - Downloaded 86246968 bytes. 08:51:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:51:37 INFO - mkdir: /builds/slave/test/properties 08:51:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:51:37 INFO - Writing to file /builds/slave/test/properties/build_url 08:51:37 INFO - Contents: 08:51:37 INFO - build_url:https://queue.taskcluster.net/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:51:38 INFO - Running post-action listener: _resource_record_post_action 08:51:38 INFO - Running post-action listener: set_extra_try_arguments 08:51:38 INFO - ##### 08:51:38 INFO - ##### Running populate-webroot step. 08:51:38 INFO - ##### 08:51:38 INFO - Running pre-action listener: _resource_record_pre_action 08:51:38 INFO - Running main action method: populate_webroot 08:51:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:51:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:51:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:51:38 INFO - '--tppagecycles', 08:51:38 INFO - '7'], 08:51:38 INFO - 'tests': ['tsvgm']}}, 08:51:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:51:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:51:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:51:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:51:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:51:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:51:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:38 INFO - 'talos_options': ['--disable-e10s'], 08:51:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:38 INFO - 'talos_options': ['--disable-e10s'], 08:51:38 INFO - 'tests': ['damp', 'tps']}, 08:51:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:38 INFO - 'tests': ['damp', 'tps']}, 08:51:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:51:38 INFO - 'tests': ['dromaeo_dom']}, 08:51:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:51:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:51:38 INFO - 'tests': ['a11yr', 08:51:38 INFO - 'ts_paint', 08:51:38 INFO - 'tpaint', 08:51:38 INFO - 'sessionrestore', 08:51:38 INFO - 'sessionrestore_no_auto_restore', 08:51:38 INFO - 'tabpaint']}, 08:51:38 INFO - 'other-e10s': {'tests': ['a11yr', 08:51:38 INFO - 'ts_paint', 08:51:38 INFO - 'tpaint', 08:51:38 INFO - 'sessionrestore', 08:51:38 INFO - 'sessionrestore_no_auto_restore', 08:51:38 INFO - 'tabpaint']}, 08:51:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:51:38 INFO - 'ts_paint', 08:51:38 INFO - 'tpaint', 08:51:38 INFO - 'sessionrestore', 08:51:38 INFO - 'sessionrestore_no_auto_restore', 08:51:38 INFO - 'tabpaint']}, 08:51:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:51:38 INFO - 'ts_paint', 08:51:38 INFO - 'tpaint', 08:51:38 INFO - 'sessionrestore', 08:51:38 INFO - 'sessionrestore_no_auto_restore', 08:51:38 INFO - 'tabpaint']}, 08:51:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:51:38 INFO - 'tests': ['a11yr', 08:51:38 INFO - 'ts_paint', 08:51:38 INFO - 'tpaint', 08:51:38 INFO - 'sessionrestore', 08:51:38 INFO - 'sessionrestore_no_auto_restore', 08:51:38 INFO - 'tabpaint']}, 08:51:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:51:38 INFO - 'tests': ['a11yr', 08:51:38 INFO - 'ts_paint', 08:51:38 INFO - 'tpaint', 08:51:38 INFO - 'sessionrestore', 08:51:38 INFO - 'sessionrestore_no_auto_restore', 08:51:38 INFO - 'tabpaint']}, 08:51:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:51:38 INFO - 'tests': ['tsvgx', 08:51:38 INFO - 'tsvgr_opacity', 08:51:38 INFO - 'tart', 08:51:38 INFO - 'tscrollx', 08:51:38 INFO - 'cart']}, 08:51:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:51:38 INFO - 'tsvgr_opacity', 08:51:38 INFO - 'tart', 08:51:38 INFO - 'tscrollx', 08:51:38 INFO - 'cart']}, 08:51:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:38 INFO - 'talos_options': ['--disable-e10s'], 08:51:38 INFO - 'tests': ['tp5o']}, 08:51:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:38 INFO - 'tests': ['tp5o']}, 08:51:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:38 INFO - 'talos_options': ['--disable-e10s', 08:51:38 INFO - '--xperf_path', 08:51:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:38 INFO - 'tests': ['tp5n']}, 08:51:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:38 INFO - 'talos_options': ['--xperf_path', 08:51:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:38 INFO - 'tests': ['tp5n']}}, 08:51:38 INFO - 'talos.zip': {'path': '', 08:51:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:51:38 INFO - Running post-action listener: _resource_record_post_action 08:51:38 INFO - ##### 08:51:38 INFO - ##### Running create-virtualenv step. 08:51:38 INFO - ##### 08:51:38 INFO - Running pre-action listener: _resource_record_pre_action 08:51:38 INFO - Running main action method: create_virtualenv 08:51:38 INFO - Creating virtualenv /builds/slave/test/build/venv 08:51:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:51:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:51:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:51:38 INFO - Using real prefix '/tools/python27' 08:51:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:51:39 INFO - Installing distribute.............................................................................................................................................................................................done. 08:51:42 INFO - Installing pip.................done. 08:51:42 INFO - Return code: 0 08:51:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101885a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101895420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa179594c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724e00>, '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 0x10158ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10171fb20>, '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.kmTo8IZecM/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.RQNfeAQX49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 08:51:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:51:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kmTo8IZecM/Render', 08:51:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:42 INFO - 'HOME': '/Users/cltbld', 08:51:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:42 INFO - 'LOGNAME': 'cltbld', 08:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:42 INFO - 'MOZ_NO_REMOTE': '1', 08:51:42 INFO - 'NO_EM_RESTART': '1', 08:51:42 INFO - 'PAGER': '/bin/cat', 08:51:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:42 INFO - 'PWD': '/builds/slave/test', 08:51:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:42 INFO - 'SHELL': '/bin/bash', 08:51:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQNfeAQX49/Listeners', 08:51:42 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 08:51:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:42 INFO - 'USER': 'cltbld', 08:51:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:42 INFO - 'XPC_FLAGS': '0x0', 08:51:42 INFO - 'XPC_SERVICE_NAME': '0', 08:51:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:51:42 INFO - Cleaning up... 08:51:42 INFO - Return code: 0 08:51:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101885a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101895420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa179594c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724e00>, '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 0x10158ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10171fb20>, '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.kmTo8IZecM/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.RQNfeAQX49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 08:51:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:51:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kmTo8IZecM/Render', 08:51:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:42 INFO - 'HOME': '/Users/cltbld', 08:51:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:42 INFO - 'LOGNAME': 'cltbld', 08:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:42 INFO - 'MOZ_NO_REMOTE': '1', 08:51:42 INFO - 'NO_EM_RESTART': '1', 08:51:42 INFO - 'PAGER': '/bin/cat', 08:51:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:42 INFO - 'PWD': '/builds/slave/test', 08:51:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:42 INFO - 'SHELL': '/bin/bash', 08:51:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQNfeAQX49/Listeners', 08:51:42 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 08:51:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:42 INFO - 'USER': 'cltbld', 08:51:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:42 INFO - 'XPC_FLAGS': '0x0', 08:51:42 INFO - 'XPC_SERVICE_NAME': '0', 08:51:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:42 INFO - Downloading/unpacking psutil>=0.7.1 08:51:42 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 08:51:42 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 08:51:42 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 08:51:42 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 08:51:42 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 08:51:42 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 08:51:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:51:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:45 INFO - Installing collected packages: psutil 08:51:45 INFO - Running setup.py install for psutil 08:51:45 INFO - building 'psutil._psutil_osx' extension 08:51:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:51:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:51:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:51:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:51:46 INFO - building 'psutil._psutil_posix' extension 08:51:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:51:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:51:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:51:46 INFO - ^ 08:51:46 INFO - 1 warning generated. 08:51:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:51:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:46 INFO - Successfully installed psutil 08:51:46 INFO - Cleaning up... 08:51:47 INFO - Return code: 0 08:51:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101885a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101895420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa179594c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724e00>, '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 0x10158ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10171fb20>, '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.kmTo8IZecM/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.RQNfeAQX49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 08:51:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:51:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kmTo8IZecM/Render', 08:51:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:47 INFO - 'HOME': '/Users/cltbld', 08:51:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:47 INFO - 'LOGNAME': 'cltbld', 08:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:47 INFO - 'MOZ_NO_REMOTE': '1', 08:51:47 INFO - 'NO_EM_RESTART': '1', 08:51:47 INFO - 'PAGER': '/bin/cat', 08:51:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:47 INFO - 'PWD': '/builds/slave/test', 08:51:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:47 INFO - 'SHELL': '/bin/bash', 08:51:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQNfeAQX49/Listeners', 08:51:47 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 08:51:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:47 INFO - 'USER': 'cltbld', 08:51:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:47 INFO - 'XPC_FLAGS': '0x0', 08:51:47 INFO - 'XPC_SERVICE_NAME': '0', 08:51:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08: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 08: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 08: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 08: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 08: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 08: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 08:51:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:51:49 INFO - Installing collected packages: mozsystemmonitor 08:51:49 INFO - Running setup.py install for mozsystemmonitor 08:51:49 INFO - Successfully installed mozsystemmonitor 08:51:49 INFO - Cleaning up... 08:51:50 INFO - Return code: 0 08:51:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:50 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 0x101885a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101895420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa179594c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724e00>, '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 0x10158ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10171fb20>, '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.kmTo8IZecM/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.RQNfeAQX49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 08:51:50 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 08:51:50 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 08:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kmTo8IZecM/Render', 08:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:50 INFO - 'HOME': '/Users/cltbld', 08:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:50 INFO - 'LOGNAME': 'cltbld', 08:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:50 INFO - 'MOZ_NO_REMOTE': '1', 08:51:50 INFO - 'NO_EM_RESTART': '1', 08:51:50 INFO - 'PAGER': '/bin/cat', 08:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:50 INFO - 'PWD': '/builds/slave/test', 08:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:50 INFO - 'SHELL': '/bin/bash', 08:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQNfeAQX49/Listeners', 08:51:50 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 08:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:50 INFO - 'USER': 'cltbld', 08:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:50 INFO - 'XPC_FLAGS': '0x0', 08:51:50 INFO - 'XPC_SERVICE_NAME': '0', 08:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:50 INFO - Downloading/unpacking blobuploader==1.2.4 08: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 08: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 08: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 08: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 08: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 08: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 08:51:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:51:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:51:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:51:53 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 08:51:53 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 08:51:53 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 08:51:53 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 08:51:53 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 08:51:53 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 08:51:53 INFO - Downloading docopt-0.6.1.tar.gz 08:51:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:51:54 INFO - Installing collected packages: blobuploader, requests, docopt 08:51:54 INFO - Running setup.py install for blobuploader 08:51:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:51:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:51:54 INFO - Running setup.py install for requests 08:51:54 INFO - Running setup.py install for docopt 08:51:54 INFO - Successfully installed blobuploader requests docopt 08:51:54 INFO - Cleaning up... 08:51:54 INFO - Return code: 0 08:51:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101885a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101895420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa179594c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724e00>, '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 0x10158ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10171fb20>, '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.kmTo8IZecM/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.RQNfeAQX49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 08:51:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:51:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kmTo8IZecM/Render', 08:51:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:54 INFO - 'HOME': '/Users/cltbld', 08:51:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:54 INFO - 'LOGNAME': 'cltbld', 08:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:54 INFO - 'MOZ_NO_REMOTE': '1', 08:51:54 INFO - 'NO_EM_RESTART': '1', 08:51:54 INFO - 'PAGER': '/bin/cat', 08:51:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:54 INFO - 'PWD': '/builds/slave/test', 08:51:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:54 INFO - 'SHELL': '/bin/bash', 08:51:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQNfeAQX49/Listeners', 08:51:54 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 08:51:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:54 INFO - 'USER': 'cltbld', 08:51:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:54 INFO - 'XPC_FLAGS': '0x0', 08:51:54 INFO - 'XPC_SERVICE_NAME': '0', 08:51:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:55 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-ZcQLid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:55 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-jR92Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:55 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-S4gyrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:55 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-YBdXM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:55 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-qEtLF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:55 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-XU6X6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:55 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-vj7EFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:55 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-pgqT8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:55 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-GrGySQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:56 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-f6fC0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:56 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-eerBKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:56 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-BvmT6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:56 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-nGJW8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:56 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-bMH3oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:56 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-wnhoOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:56 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-jvN4yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:56 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Q0R8Oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:51:56 INFO - Running setup.py install for manifestparser 08:51:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:51:57 INFO - Running setup.py install for mozcrash 08:51:57 INFO - Running setup.py install for mozdebug 08:51:57 INFO - Running setup.py install for mozdevice 08:51:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:51:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:51:57 INFO - Running setup.py install for mozfile 08:51:57 INFO - Running setup.py install for mozhttpd 08:51:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:51:57 INFO - Running setup.py install for mozinfo 08:51:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:51:57 INFO - Running setup.py install for mozInstall 08:51:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:51:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:51:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:51:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:51:58 INFO - Running setup.py install for mozleak 08:51:58 INFO - Running setup.py install for mozlog 08:51:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:51:58 INFO - Running setup.py install for moznetwork 08:51:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:51:58 INFO - Running setup.py install for mozprocess 08:51:58 INFO - Running setup.py install for mozprofile 08:51:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:51:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:51:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:51:58 INFO - Running setup.py install for mozrunner 08:51:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:51:59 INFO - Running setup.py install for mozscreenshot 08:51:59 INFO - Running setup.py install for moztest 08:51:59 INFO - Running setup.py install for mozversion 08:51:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:51:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:51:59 INFO - Cleaning up... 08:51:59 INFO - Return code: 0 08:51:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:59 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')]} 08:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:59 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')]} 08:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:59 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 0x101885a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101895420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa179594c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724e00>, '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 0x10158ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10171fb20>, '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.kmTo8IZecM/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.RQNfeAQX49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 08:51:59 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 08:51:59 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 08:51:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kmTo8IZecM/Render', 08:51:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:59 INFO - 'HOME': '/Users/cltbld', 08:51:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:59 INFO - 'LOGNAME': 'cltbld', 08:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:59 INFO - 'MOZ_NO_REMOTE': '1', 08:51:59 INFO - 'NO_EM_RESTART': '1', 08:51:59 INFO - 'PAGER': '/bin/cat', 08:51:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:59 INFO - 'PWD': '/builds/slave/test', 08:51:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:59 INFO - 'SHELL': '/bin/bash', 08:51:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQNfeAQX49/Listeners', 08:51:59 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 08:51:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:59 INFO - 'USER': 'cltbld', 08:51:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:59 INFO - 'XPC_FLAGS': '0x0', 08:51:59 INFO - 'XPC_SERVICE_NAME': '0', 08:51:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:59 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-jmCFUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:59 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-cgd0QV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:59 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-YnuDc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:00 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)) 08:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:00 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Ghm8CZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:00 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)) 08:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:00 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-TdGgRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:00 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)) 08:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:00 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-ejBzIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:00 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)) 08:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:00 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-EIABcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:00 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)) 08:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:00 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-X7_IOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:00 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-X2bFmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:00 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-rOiLnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:00 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Eki93x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:00 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-TVW40i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:01 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)) 08:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:01 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-EirrZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:01 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)) 08:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:01 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-mhyZjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:01 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)) 08:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:01 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-2ApQQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:01 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)) 08:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:01 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-gyOdx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:01 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)) 08:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:01 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-7tKDK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:01 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)) 08:52:01 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)) 08:52:01 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)) 08:52:01 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)) 08:52:01 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)) 08:52:01 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)) 08:52:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:52:01 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 08:52:01 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 08:52:01 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 08:52:01 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 08:52:01 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 08:52:01 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 08:52:03 INFO - Downloading blessings-1.6.tar.gz 08:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:52:04 INFO - Installing collected packages: blessings 08:52:04 INFO - Running setup.py install for blessings 08:52:04 INFO - Successfully installed blessings 08:52:04 INFO - Cleaning up... 08:52:04 INFO - Return code: 0 08:52:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:52:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:04 INFO - Reading from file tmpfile_stdout 08:52:04 INFO - Current package versions: 08:52:04 INFO - blessings == 1.6 08:52:04 INFO - blobuploader == 1.2.4 08:52:04 INFO - docopt == 0.6.1 08:52:04 INFO - manifestparser == 1.1 08:52:04 INFO - mozInstall == 1.12 08:52:04 INFO - mozcrash == 0.17 08:52:04 INFO - mozdebug == 0.1 08:52:04 INFO - mozdevice == 0.48 08:52:04 INFO - mozfile == 1.2 08:52:04 INFO - mozhttpd == 0.7 08:52:04 INFO - mozinfo == 0.9 08:52:04 INFO - mozleak == 0.1 08:52:04 INFO - mozlog == 3.1 08:52:04 INFO - moznetwork == 0.27 08:52:04 INFO - mozprocess == 0.22 08:52:04 INFO - mozprofile == 0.28 08:52:04 INFO - mozrunner == 6.11 08:52:04 INFO - mozscreenshot == 0.1 08:52:04 INFO - mozsystemmonitor == 0.0 08:52:04 INFO - moztest == 0.7 08:52:04 INFO - mozversion == 1.4 08:52:04 INFO - psutil == 3.1.1 08:52:04 INFO - requests == 1.2.3 08:52:04 INFO - wsgiref == 0.1.2 08:52:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:04 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 0x101885a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101895420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa179594c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724e00>, '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 0x10158ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10171fb20>, '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.kmTo8IZecM/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.RQNfeAQX49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 08:52:04 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 08:52:04 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 08:52:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kmTo8IZecM/Render', 08:52:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:04 INFO - 'HOME': '/Users/cltbld', 08:52:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:04 INFO - 'LOGNAME': 'cltbld', 08:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:04 INFO - 'MOZ_NO_REMOTE': '1', 08:52:04 INFO - 'NO_EM_RESTART': '1', 08:52:04 INFO - 'PAGER': '/bin/cat', 08:52:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:04 INFO - 'PWD': '/builds/slave/test', 08:52:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:04 INFO - 'SHELL': '/bin/bash', 08:52:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQNfeAQX49/Listeners', 08:52:04 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 08:52:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:04 INFO - 'USER': 'cltbld', 08:52:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:04 INFO - 'XPC_FLAGS': '0x0', 08:52:04 INFO - 'XPC_SERVICE_NAME': '0', 08:52:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:52:04 INFO - Cleaning up... 08:52:04 INFO - Return code: 0 08:52:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101885a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101895420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa179594c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724e00>, '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 0x10158ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10171fb20>, '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.kmTo8IZecM/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.RQNfeAQX49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 08:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:52:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kmTo8IZecM/Render', 08:52:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:04 INFO - 'HOME': '/Users/cltbld', 08:52:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:04 INFO - 'LOGNAME': 'cltbld', 08:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:04 INFO - 'MOZ_NO_REMOTE': '1', 08:52:04 INFO - 'NO_EM_RESTART': '1', 08:52:04 INFO - 'PAGER': '/bin/cat', 08:52:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:04 INFO - 'PWD': '/builds/slave/test', 08:52:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:04 INFO - 'SHELL': '/bin/bash', 08:52:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQNfeAQX49/Listeners', 08:52:04 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 08:52:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:04 INFO - 'USER': 'cltbld', 08:52:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:04 INFO - 'XPC_FLAGS': '0x0', 08:52:04 INFO - 'XPC_SERVICE_NAME': '0', 08:52:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:05 INFO - Downloading/unpacking jsonschema 08:52:05 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 08:52:05 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 08:52:05 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 08:52:05 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 08:52:05 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 08:52:05 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 08:52:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:52:07 INFO - Downloading/unpacking functools32 (from jsonschema) 08:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:07 INFO - Downloading functools32-3.2.3-2.tar.gz 08:52:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:52:08 INFO - warning: no files found matching '*.txt' 08:52:08 INFO - no previously-included directories found matching 'build' 08:52:08 INFO - no previously-included directories found matching 'dist' 08:52:08 INFO - no previously-included directories found matching '.git*' 08:52:08 INFO - Installing collected packages: jsonschema, functools32 08:52:08 INFO - Running setup.py install for functools32 08:52:08 INFO - warning: no files found matching '*.txt' 08:52:08 INFO - no previously-included directories found matching 'build' 08:52:08 INFO - no previously-included directories found matching 'dist' 08:52:08 INFO - no previously-included directories found matching '.git*' 08:52:08 INFO - Successfully installed jsonschema functools32 08:52:08 INFO - Cleaning up... 08:52:08 INFO - Return code: 0 08:52:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:52: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')]} 08:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52: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')]} 08:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:08 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 0x101885a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101895420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa179594c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724e00>, '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 0x10158ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10171fb20>, '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.kmTo8IZecM/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.RQNfeAQX49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 08:52:08 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 08:52:08 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 08:52:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kmTo8IZecM/Render', 08:52:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:08 INFO - 'HOME': '/Users/cltbld', 08:52:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:08 INFO - 'LOGNAME': 'cltbld', 08:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:08 INFO - 'MOZ_NO_REMOTE': '1', 08:52:08 INFO - 'NO_EM_RESTART': '1', 08:52:08 INFO - 'PAGER': '/bin/cat', 08:52:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:08 INFO - 'PWD': '/builds/slave/test', 08:52:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:08 INFO - 'SHELL': '/bin/bash', 08:52:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQNfeAQX49/Listeners', 08:52:08 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 08:52:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:08 INFO - 'USER': 'cltbld', 08:52:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:08 INFO - 'XPC_FLAGS': '0x0', 08:52:08 INFO - 'XPC_SERVICE_NAME': '0', 08:52:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:08 INFO - Downloading/unpacking flake8 08:52:08 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 08:52:08 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 08:52:08 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 08:52:08 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 08:52:08 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 08:52:08 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 08:52:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:52:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:52:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:52:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:52:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:52:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:52:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:52:12 INFO - no previously-included directories found matching 'docs/_build' 08:52:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:52:12 INFO - Running setup.py install for pep8 08:52:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:52:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:52:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:52:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:52:12 INFO - no previously-included directories found matching 'docs/_build' 08:52:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:52:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:52:12 INFO - Cleaning up... 08:52:12 INFO - Return code: 0 08:52:12 INFO - Running post-action listener: _resource_record_post_action 08:52:12 INFO - Running post-action listener: _start_resource_monitoring 08:52:12 INFO - Starting resource monitoring. 08:52:12 INFO - ##### 08:52:12 INFO - ##### Running install step. 08:52:12 INFO - ##### 08:52:12 INFO - Running pre-action listener: _resource_record_pre_action 08:52:12 INFO - Running main action method: install 08:52:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:12 INFO - Reading from file tmpfile_stdout 08:52:12 INFO - Detecting whether we're running mozinstall >=1.0... 08:52:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:52:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:52:13 INFO - Reading from file tmpfile_stdout 08:52:13 INFO - Output received: 08:52:13 INFO - Usage: mozinstall [options] installer 08:52:13 INFO - Options: 08:52:13 INFO - -h, --help show this help message and exit 08:52:13 INFO - -d DEST, --destination=DEST 08:52:13 INFO - Directory to install application into. [default: 08:52:13 INFO - "/builds/slave/test"] 08:52:13 INFO - --app=APP Application being installed. [default: firefox] 08:52:13 INFO - mkdir: /builds/slave/test/build/application 08:52:13 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'] 08:52:13 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 08:52:35 INFO - Reading from file tmpfile_stdout 08:52:35 INFO - Output received: 08:52:35 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:52:35 INFO - Running post-action listener: _resource_record_post_action 08:52:35 INFO - ##### 08:52:35 INFO - ##### Running run-tests step. 08:52:35 INFO - ##### 08:52:35 INFO - Running pre-action listener: _resource_record_pre_action 08:52:35 INFO - Running main action method: run_tests 08:52:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:52:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:52:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:52:35 INFO - 2016-06-23 08:52:35.152 screenresolution[1644:7652] starting screenresolution argv=screenresolution get 08:52:35 INFO - 2016-06-23 08:52:35.155 screenresolution[1644:7652] Display 0: 1600x1200x32@60 08:52:35 INFO - 2016-06-23 08:52:35.161 screenresolution[1645:7654] starting screenresolution argv=screenresolution list 08:52:35 INFO - Available Modes on Display 0 08:52:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:52:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:52:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:52:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:52:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:52:35 INFO - Intel Iris: 08:52:35 INFO - Chipset Model: Intel Iris 08:52:35 INFO - Type: GPU 08:52:35 INFO - Bus: Built-In 08:52:35 INFO - VRAM (Dynamic, Max): 1536 MB 08:52:35 INFO - Vendor: Intel (0x8086) 08:52:35 INFO - Device ID: 0x0a2e 08:52:35 INFO - Revision ID: 0x0009 08:52:35 INFO - Displays: 08:52:35 INFO - Display: 08:52:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:52:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:52:35 INFO - Display Serial Number: 1600x1200 60 08:52:35 INFO - Main Display: Yes 08:52:35 INFO - Mirror: Off 08:52:35 INFO - Online: Yes 08:52:35 INFO - Rotation: Supported 08:52:35 INFO - Return code: 0 08:52:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:52:35 INFO - Python 2.7.3 08:52:35 INFO - Return code: 0 08:52:35 INFO - grabbing minidump binary from tooltool 08:52:35 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')]} 08:52:35 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 0x101724e00>, '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 0x10158ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10171fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:52:35 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 08:52:35 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 08:52:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:52:35 INFO - Return code: 0 08:52:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:52:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:52:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:52:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:52:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:52:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:52:36 INFO - Return code: 0 08:52:36 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/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--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 08:52:36 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/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0134 --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 08:52:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kmTo8IZecM/Render', 08:52:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:36 INFO - 'HOME': '/Users/cltbld', 08:52:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:36 INFO - 'LOGNAME': 'cltbld', 08:52:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:52:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:36 INFO - 'MOZ_NO_REMOTE': '1', 08:52:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:52:36 INFO - 'NO_EM_RESTART': '1', 08:52:36 INFO - 'PAGER': '/bin/cat', 08:52:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:36 INFO - 'PWD': '/builds/slave/test', 08:52:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:52:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:36 INFO - 'SHELL': '/bin/bash', 08:52:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQNfeAQX49/Listeners', 08:52:36 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 08:52:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:36 INFO - 'USER': 'cltbld', 08:52:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:36 INFO - 'XPC_FLAGS': '0x0', 08:52:36 INFO - 'XPC_SERVICE_NAME': '0', 08:52:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:36 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/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--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 08:52:36 INFO - mozversion application_buildid: 20160623064524 08:52:36 INFO - mozversion application_changeset: b52a29cf207d80cbc566c5d28063e303f93c2bd5 08:52:36 INFO - mozversion application_display_name: Firefox 08:52:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:52:36 INFO - mozversion application_name: Firefox 08:52:36 INFO - mozversion application_remotingname: firefox 08:52:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:52:36 INFO - mozversion application_vendor: Mozilla 08:52:36 INFO - mozversion application_version: 48.0 08:52:36 INFO - mozversion platform_buildid: 20160623064524 08:52:36 INFO - mozversion platform_changeset: b52a29cf207d80cbc566c5d28063e303f93c2bd5 08:52:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:52:36 INFO - mozversion platform_version: 48.0 08:52:36 INFO - using testdate: 1466697156 08:52:36 INFO - actual date: 1466697156 08:52:36 INFO - starting webserver on 'localhost:49273' 08:52:36 INFO - SUITE-START | Running 2 tests 08:52:36 INFO - TEST-START | dromaeo_css 08:52:36 INFO - operating with platform_type : mac_ 08:52:36 INFO - Initialising browser for dromaeo_css test... 08:52:36 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpVfBoea/profile http://localhost:49273/getInfo.html) 08:52:39 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 08:52:39 INFO - PROCESS | 1663 | colorDepth:24 08:52:39 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 08:52:39 INFO - PROCESS | 1663 | __metrics 08:52:39 INFO - PROCESS | 1663 | 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" 08:52:39 ERROR - PROCESS | 1663 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:52:39 INFO - TEST-INFO | 1663: exit 0 08:52:39 INFO - Browser initialized. 08:52:39 INFO - Running cycle 1/1 for dromaeo_css test... 08:52:39 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpVfBoea/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:51 INFO - PROCESS | 1666 | RSS: Main: 161746944 08:52:51 INFO - PROCESS | 1666 | 08:53:43 INFO - PROCESS | 1666 | 1466697223083 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] 08:55:53 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 08:55:54 INFO - PROCESS | 1666 | RSS: Main: 255348736 08:55:54 INFO - PROCESS | 1666 | 08:58:57 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 08:58:57 INFO - PROCESS | 1666 | RSS: Main: 300732416 08:58:57 INFO - PROCESS | 1666 | 09:01:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 09:02:00 INFO - PROCESS | 1666 | RSS: Main: 305651712 09:02:00 INFO - PROCESS | 1666 | 09:05:02 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 09:05:03 INFO - PROCESS | 1666 | RSS: Main: 301236224 09:05:03 INFO - PROCESS | 1666 | 09:08:06 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 09:08:06 INFO - PROCESS | 1666 | RSS: Main: 270802944 09:08:06 INFO - PROCESS | 1666 | 09:11:09 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 09:11:09 INFO - PROCESS | 1666 | RSS: Main: 317231104 09:11:09 INFO - PROCESS | 1666 | 09:11:09 INFO - PROCESS | 1666 | __start_tp_report 09:11:09 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 09:11:09 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 09:11:09 INFO - PROCESS | 1666 | |i|pagename|runs| 09:11:09 INFO - PROCESS | 1666 | |0;dojo.html;3509.403401421758;3545.716342692585;3566.447200683895;3583.838727257273;3638.6179451157627;5753.798617048405;5759.078547432407;5797.072468405056;5798.507126894208;5830.358660547342;5778.768849246025;5836.766529338832;5843.4156584341545;5848.912266316009;5851.122331650244;5245.291885595443;5256.08018596744;5286.31277933868;5336.932613477301;5369.6509726867625;5302.973485132569;5327.307450031491;5339.332583427072;5342.919856202141;5343.572514198855;5266.3943646480575;5274.709890955995;5320.600954928376;5348.545373643245;5350.759215835296;5349.7592608332525;5363.973180134074;5374.193870919394;5386.326709161355;5408.161734931092;5175.7670904809;5238.869028274324;5298.814541491068;5318.840434786963;5339.759710812984;5668.518175955049;5696.51579615729;5724;5728.341240757324;5730.283714535683;6333.7466501339895;6333.936660633381;6346.587471814363;6358.77744278948;6368.267649220353;6216.409441103088;6285;6327.778527751552;6343.429091381798;6390.456811171056;5966.433188847052;5992.161097446361;5994.490468310155;6009.519238460913;6023.27720673522;5064.645474816727;6362.491000719931;6364.395382438661;6376.968115159394;6387.648679322589;6096.847578810565;6133.701927635063;6207.875842483125;6220.160278362454;6276.592021518587;6160.383961603804;6182.319944806068;6183.103449999725;6196.566240363131;6198.163247961467;6038.698065096815;6106.969465152646;6117.082437634391;6131.356207598227;6131.356207598227;6197.4732147767945;6271.372862713783;6339.397757213057;6389.137466442064;6399.840003999844;4954.256861470736;4978.278149668277;5002.799888004512;5003.399592048978;5036.294918711384;3890.3580909149673;4548.2722764358205;4555.840545580889;4564.406627138451;4587.724736515753;5681.34664513578;5791.160281759206;5826.592138550345;5914.792982245687;5935.643861368331;6292.528060395489;6308.653024083719;6309.211348581427;6315.905261421082;6320.178376811077;5852.707364631837;5875.089361149029;5876.1479585459865;5887.146363777314;5908.822735317947;4514.954850451519;5392.649477783932;5414.891702166014;5483.862903427446;5508.862278442991;6253.468455181361;6403.295637479873;6418.935810641927;6420.0048992406255;6420.550561460746;6166.81499555014;6314.179156709598;6344.587601805868;6345.904811427925;6345.936540634534;6410.1987251593555;6430.678466076584;6451.838704032437;6452.54832161763;6452.7418903245225;6304.495640348853;6310.936890631035;6324.936750632619;6345.524085693499;6345.96827015862;6228.22147231596;6239.188905442264;6325.746970121144;6347.047942808431;6356.650384228912;6128.601640893327;6207.81376558704;6282.968585157045;6295.433410993032;6298.527610429144;5173.92239116406;6219.346968568235;6265.122882796321;6272.655003974825;6279.497640188682;5885.941140588539;6062.605930614496;6089.939100609115;6104.145419641165;6137.907931381123;6107.694615269308;6152.323244443197;6181.350958149509;6260.843478913063;6271.372862713874;6127.29536103336;6161.6919154041225;6165.784197553064;6174.8147555573405;6181.84545386369 09:11:09 INFO - PROCESS | 1666 | |1;ext.html;535.617033820818;557.7796770275742;583.0321666034383;606.5996442348052;611.0559186057541;26161.869190654044;39412.605873941255;40160.79919600405;40259.79220623379;40352.39471407927;46295;46909.29636055462;47006.52993470073;47042.52957470424;47148;9058.637654493845;9850.458224797634;10008.749781255454;10011.799764004716;10018.749531261741;9092.40899341544;11921.105917056213;12119.757604847899;12137.968272696788;12142.817857732141;11890.524379024828;12033.578824741136;12033.759324813498;12045.578404755835;12049.096317776159;12047.578334758286;12146.271223726604;12150.21023633461;12161.452734626962;12165.391730413532;12032.81950770739;12177.208481448677;12179.817302740466;12183.939080304543;12218.572349967797;39841.203175936316;42104.78947605273;43258.91852703676;43856.56143438556;44011;3327.2014716468116;3432;3540.451230059345;3574.910627234314;3970.7617542947514;27328.863355683294;29846.25384365408;29894.551581726293;30243;30634.54048189279;2764.25365151408;2794.552871540544;2815.7465828075365;2834.2489240351324;2922.21100302917;439090;443127;443135;444086;444293.99999999674;37489.25021499609;37632.247355053296;37709;66472;68071.65964170148;32157.03528894137;36738.44892326617;36874.89375318745;36921.44617830735;36948.261034779156;15833.208339582974;15968.121753303447;15998.200089995453;16022.75965860513;16028.519144425685;13026.28355440441;13253.66865828362;13385.19688818674;13578.45686172542;13605.387757550934;8411.915880841236;8434.831303373898;8480.957595212109;8507.106753790888;8559.95720021396;3546.858125674944;3552.484889691032;3585.0858031202397;3587.6232995535615;3612.096975756061;949.4445749236774;1034.8085604163255;1046.6912260883057;1069.2996087562658;1175.9118066145074;30062.947796827444;30479.39041219163;31041.689583104333;31341.68658313433;31746.523802142987;899.2760827533767;1142.8514293142005;1159.431878379588;1187.5962172861268;1204.2052245518091;11588.536458541565;15327.61680957985;15610;15722.606934826721;15972.840271597135;498639;499763;506708;508386;509172;58556.7072164645;59031.11453328204;59038.81922361615;59074.704626476596;59122.704386478654;1421.7085497472992;1555.6810853774948;1591.8169410517708;1597.209381356236;1605.0048969638665;30317.090487285415;30842.383152337276;31279.37441251208;31321.686783131878;31865.522017170224;53215.20177197268;54095.72952135214;54221.72889135529;54231;54248.45751542434;593853;612483;613355.9332203311;614932;615085;38036.42945355766;46085;46193.30710039285;46396.30405543987;46579.83550411267;49651.75174124106;49769.75115124546;50031.74984125056;50660.74669626628;51900.74049629728;39182;39920.80039599783;41013;41367;42028.78985605053;39488.2102357957;40285.79857100813;40502;40992.97517561966;41549.792251038554;32764.50853237251;39213.60786392214;40264.79867600643;40556.59443405646;40676.59323406728;33670.83164584259;34988.82505587456;34997.12507187239;35393.1151721209;35438;26095.217143485726;26396.472070558866;26535.734642654097;26689.199324020312;26713.732862671124 09:11:09 INFO - PROCESS | 1666 | |2;jquery.html;409.9262132816092;411.36033467957316;413.03968273763496;416.1116017303058;422.2926597948436;15640.687186256268;20478.18087276509;21253.256136035223;21298.254561090347;21332.4666883328;16925.407610733626;17020.659586808255;20505.974701264913;20862.68705969408;21075.789242107614;5914.556408269386;6203;6235.563510554263;6238.282597501277;6249.375062493737;5357.4374690657505;5942.2869255689375;6084.726187321581;6243.968780156093;6244.9687751561405;6202.9689851550675;6228.657423841687;6234.8441288967915;6238.064290356438;6240.344763799803;5416;5693.060644993571;6212.751489940397;6223.222097237845;6230.719617617218;4675.2052151134385;5391.975524650304;5424.674519528841;5433.701146436944;5448.972755136199;26878.5968210477;26981.730182698313;27135.86432067847;27476;27490.450190996067;2187.8359123065675;2438.5488684593406;2457.31195265326;2544.020552087441;2914.562815577659;11702.833599096755;15191.848081519154;15211.391544338214;15422.845771542365;15800.762988555181;1782.9554261143446;1815.7730283714536;1824.1153040775214;1847.7320788485729;1869.5045812859603;53938.73030634822;80498.37757300936;98311;111020.22449438748;111287.44356278247;11005.284656497302;11319.037881780141;11514.136439767051;11639.6508104757;11655.358955257543;14380.640483987774;14401.135931844123;14423.134611923319;14435.855641443452;14447.638809029859;8131.918680813116;8527.573621318908;8550.102239264788;8668.956655216683;9045.649320090186;7626.733064342721;9146.222571081533;9248.751418558542;9271.258299336037;9419.670311539063;6789.796306110726;6849.315068493211;6909.032735417046;6929.341712537301;6953.374196322356;1800.7388928605278;1812.5519964162604;1912.9043547822553;1924.8845069295887;1939.6896496560482;959.8848138223458;999.3604093380243;1045.6915210013065;1072.9195310351754;1095.5145538412617;17813.109344532983;20287.898560507103;21037.15851365959;22019;22128.889355553118;1011.3022014809758;1015.2791518022287;1039;1054.9683509494728;1105.2815669814686;11577.247478913843;11791.233569817934;11806.763864722829;11827.349495777815;11842.526298948118;605360;612809;621001;627291;627962;86680.1331986672;111951;112099;115637;116085;1059.6171995545733;1064.5475672839013;1078.9568417263222;1083.7236504691252;1087.6845714742635;15515.84484155144;18664.906675466536;18760.718589220898;19481.738991448736;19825.702614461083;48840.755796220794;50021.749891250314;50465.49534504608;50866.49133508765;53525.66185845385;66574;66992;69243;69494.65252673705;71100.28899711143;7925.326347260317;8071.192880711882;8071.838563228585;8239.217274358927;8393.118722534045;7473.439492038227;9768.876579193484;12418;12780.297083660487;12848.229106253655;11018.614348497764;11120.165987550805;11252.381119038531;11314.717132071764;11472.483738231633;9675.129238368581;9782.75543111428;10984.780304394028;11270.49282782293;11276.3797991108;9570.521473926137;11074.446277686244;11299.491522881326;11592.362420066976;11664.183507154758;8282.337413006824;8284.420090593601;8357.456765310235;8444.36667249971;8610.311175105851;7039.8944015840825;9862.2603304751;10946.288491248044;11412.543498259976;11462 09:11:09 INFO - PROCESS | 1666 | |3;mootools.html;1448.1311213272045;1622.8721038877977;1654.197714108657;1916.492129585659;2022.9190832366696;8123.147069557693;8312.459690120153;8316.75049748507;8330.333573314136;8330.625121869516;8163.632636531355;8378.287845533121;8503.149685031494;8519.148085191478;8519.78700532487;2087.6242276390244;2470.950580988379;2507.4734305795805;2508.209913877132;2508.586083296254;2460.6801115854914;2489.9253022409266;2504.5491811474017;2514.5599520084;2518.4711210645696;2467.5558399488086;2494.9126780562683;2495.413577809213;2501.7498250175017;2505.24842547236;2453.9018439262495;2487.6517287579754;2498.912972856813;2499.9375015624573;2500.3874050857567;2474.6288056791445;2516.5847635140362;2518.4711210645787;2524.911628093008;2525.949481010388;8843.513606751627;8873.51195684237;8886.511241881693;8887.022427532966;8900.109989001048;5399.406065332811;5456.890862182774;5537.695426751527;5588.189712491707;5588.21764952907;3628.4738712886483;3638.272345530904;3653.3058718843336;3686.686631636314;3715.5727091384565;976.3409698453587;1000.854876042977;1042.4527123260273;1065.8987396197426;1085.3704851186294;12087.87912120885;12172.965297949597;12173.817392739027;12185.69535761613;12208.267503949792;4718.528147185254;4744.7829920642835;4748.738819364899;4795.664303498722;4868.977514721948;9523.714288571355;9593.13661770444;9609.567569459392;9612;9628.518574071268;5503.449655034545;5546.584006199551;5562.137868630369;5570.387257401682;5571.969185700658;4092.652124569445;4569.2689169732685;4753.263244197155;4790.401199850019;5185.585153187736;3900.7854567999034;3974.980125099356;4026.416169655384;4034.8184331705143;4039.5556488786797;1219.3232755820604;1241.6461308527028;1245.9377031148406;1251.2617555642214;1267.689416093063;927.4620719982394;935.7099299217128;947.2800671489717;962.2302158273353;998.3810037776625;5883.911741323884;5990.221271234712;6089.786857460056;6121.387861213932;6152.569320147547;461.39096392761235;480.13575563985387;483.68560435716364;487.05754365302545;491.9311296418504;3271.8036917785007;3947.3289540778137;4113.732607380511;4120.25835349634;4137.77242251673;10461.26771126029;11026.393548354918;11164.441777911072;11197.776044479066;11208.27146235492;10810.243282970117;10835.891641083488;10950.34297942126;11050.115990720724;11067.335959842436;8492.872606910902;8601.225889669835;8609.91390086091;8667.739967800977;8681.392302538889;5642.181883626933;5869.413058694096;5903.527717782653;5991.550633702403;5998.280206375263;9723.708288751348;9766.85349719769;9911.801763964824;9925.1067403934;9927.553260103457;9602.231821454407;10064.345817521838;10102.646407375707;10147.49262536885;10356.482175891326;6573.1454910861285;6815.045893574805;6949.061876646588;7252.2747725227055;7327.963360183165;8446.944131983502;8466.74599762008;8522.318214542945;8528.445651032664;8528.872066919126;6423.42189202974;7488;7527.435442341737;7738.535687858746;7779.494332868346;7361.852762944818;7446.4042876568665;7507.924920750723;7558.2441755823975;7589.316961473494;7094.148702155568;7198.748043818441;7207.8558428832175;7215.422766178588;7246.7101315948885;4185.97907010463;4951.777170027285;4964.180910149785;5030.547250747451;5087.08432482142;5021.472745361684;5048.268001139888;5054.924176137434;5183.844484665466;5322.733863306897 09:11:09 INFO - PROCESS | 1666 | |4;prototype.html;326.9722073623742;332.1563229397331;338.4838121864156;342.55467891740744;346.5044985670493;6454.225492940848;6517.250516190639;6531.444827189683;6557.442617377528;6559.803205903819;6489.480841532678;6491.734111848192;6496.310959150619;6508.316626754194;6530.510211734115;4644.790984405701;4771.33201351811;4801.567858892699;4830.2513110467935;4840.031993601294;4820.301056346828;4893.510648935096;4900.142475066867;4905.681130726509;4908.533689299511;4831.951680483186;4847.0548243092435;4859.41686997559;4860.756962151896;4878.951025529511;4599.954000460003;4699.412573428339;4799.808007679689;4827.179379505457;4847.079054979543;4142.047329114321;4152.857964059877;4157.771322577257;4160.271952408317;4165.166966606691;6157.168782214433;6162.22972128484;6197.5351848611535;6240.157578726905;6247.718852651642;5554.2779438672715;5697.886042279131;5704.11586204139;5704.77180912763;5707.3721890592005;5851.473367396912;6930.5148639595245;6943.6875340609795;6948.930510694879;6952.374286314256;4390.934135987963;4533.977330113328;4536.410266665345;4551.931721024187;4554.203014472487;7147.821304467378;7307.6480851042725;7338.853222935565;7342.816429589249;7343.008693826318;4625.213713668684;4634.21218392874;4643.605293550018;4645.349651048856;4654.627629789608;4691.272852707836;4699.389079419653;4700.741459219776;4708.552687494683;4710.222813235778;5528.530074943595;5551.5010947044075;5561.443855614487;5566.137248726453;5570.442955704478;6389.648569328639;6522.608643481406;6924.307569243136;6938.236793952661;7017.228104908456;1525.6414742535496;1606.9437569685006;1634.730269505542;1635.337688236266;1637.1814092953523;980.2207245240052;991.5785791038779;1033.4316126130598;1033.6588925654517;1056.2183983851894;6382.36176382358;6553.311902250291;6561.409473147344;6578.013298005338;6580;7296.854062918712;7296.96351518239;7299.854002919912;7303.269673032761;7303.926960730431;5477.685355514727;6560.671966401661;6562.2453417856605;6577.309382514863;6581.934180658228;3733.2346868891814;3827.3302172119766;3831.3869780834934;3831.5402151741414;3838.846446142179;6544.887369147256;7259.41924646027;7338.522996005243;7576.356009739234;7585.0178656205935;7464.962675186698;7510.962445187739;7512.511686740344;7516;7545.132309784445;7613.695452181962;7618.352440042548;7628.732994345282;7645.044369453818;7669.808254793563;6934;7269.018682478009;7270.745523906638;7281.308275713799;7301.926980730337;6298.685065746786;6639.6680165992475;7045.823854403681;7090.680919358744;7098.041764361745;7545.584992825227;7567.205443428361;7573.015507983927;7577.431692623186;7606.239376062349;4577.29051996941;4642.16441040616;4650.186217411871;4652.488226295037;4664.580187783115;6966.164060312795;7225.855482890418;7230.493865429369;7236.457265704988;7253.746118885813;6950.270221626656;6980.581165130108;6980.616066116209;6987.056747339044;7002.124734408199;6930.480213984072;6967;6974.860502789814;6983.476239282176;6996.545224560387;6762.695678694569;6771.424428923399;6779.762708305186;6786.728530858711;6787.592744435349;5694.886102278014;5771.884562308815;6778.830529236809;6811.863762724619;6822.215445223665;6596.637184954873;6753.628550429774;6763.120794296907;6861.588304701734;6902.551334163263 09:11:09 INFO - PROCESS | 1666 | |5;yui.html;669.6417416682076;703.0579024107694;726.7202127181034;795.4670370851529;799.4563696686253;15481;15827.97118187317;15841.366345346201;15849;15858.36566537337;14420.134791912493;14630.707385852276;14632.41470341185;14632.926835365835;14659.340329685163;776.2315307845234;794.7059587952466;939.2673714502665;976.4434272464698;976.7851072764016;965.8840939087285;971.0871780526282;971.7764914069768;974.6832279509152;976.6435251133356;823.238504383446;1028.8250997330435;1031.3966329697137;1033.8655974723276;1034.260503739826;747.3050063441025;755.8488302339526;825.2943733108197;1025.0825511167538;1043.5982146873432;712.5535163617812;727.9417646588313;778.2101167315179;779.5751315532991;779.6842278877064;15354;15669.529914102595;15714.371425143096;15727.13500757458;15729.606759831096;13083;13185.406656700376;13322.933385333012;13426.261555614437;13496.527621533298;10229.948850255776;11192.216544841864;11305.71735706614;11531.711707207303;11659.950604445641;3595.496630471736;3619.1856832212807;3652.7077833773233;3692.3538380783257;3882.8835134946;87152.12847871568;88269.55865220632;88272.55863720704;89483.55258223732;89490.10509894883;9637.807243855084;10038.698839034842;10178.338408003456;10373.948130259301;10393.16854651626;19881.807091574552;23854.642180367307;23913.402164946016;23930.162444314366;23963.7603623965;7745.380369570421;7749;7810.1799311072655;7819.452638315263;8028.518288902685;4202.2646036943415;4293.313069908862;4307;4327.026419055687;4597.678162528591;3830.387138057953;3901.31726947783;3909.27678379495;3918.941215881764;3922.1763429680086;585.7217821534737;672.1732269308679;673.2022553274288;687.7833482453111;692.8856738638068;572.3332317849658;587.2600523340622;605.678990135229;622.4304761143503;657.1850904877917;8121.422047424887;8451.873221901677;8468.703595374132;8560.657573697106;8564.400491965502;532.321290354793;566.6656672563125;591.361329763854;605.1890466774544;618.0296933813959;3837.3860182370686;3957.5053118360206;3986.2824691555797;4016.618421250035;4069.29253083099;96925.5461168083;96934;98271.52592711116;98308.03383932282;98339.50830245802;82215.3556928858;82273;82741.58629206815;83304.16695832965;84274.57862710647;73449.2655073453;73469.6326518364;73637.26362736411;73914;74684.62657686677;7609.239076092346;7796.805079873048;7912.446128770931;8106.554139522383;8192.877106843522;45059.77470112628;46004;46309.536904631874;46538.534614654774;47279.76360118315;57852.42147578639;62253.443663908765;62456.375436246875;62842;62946.370536295886;10579.10077643409;10620.84068738985;10971.890281097087;11358.659240222807;11639.41802909868;12012.579559715368;12034.217775844541;12116.394180290774;12153;12906.161099528501;11628.825567616323;11682.4742886572;11699.707507312385;12036.157468977437;12161.635150945485;10201;11793.233439826385;11883.405829708652;12119.333436660716;12270.263784172621;11293.943530282297;11883.821742673694;11900.345480998629;11953.94023029914;11966.162368634112;9615.711528654152;9686.951565242129;9950.357752804537;10326.070653641209;10336.741581460523;9174.724758257264;9565.952170239105;9874.160696340892;9898.010198980044;9907.801843963225 09:11:09 INFO - PROCESS | 1666 | __end_tp_report 09:11:09 INFO - PROCESS | 1666 | __start_cc_report 09:11:09 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1072 09:11:09 INFO - PROCESS | 1666 | __end_cc_report 09:11:09 INFO - PROCESS | 1666 | __startTimestamp1466698269713__endTimestamp 09:11:09 INFO - PROCESS | 1666 | 09:11:09 INFO - PROCESS | 1666 | ------- Summary: start ------- 09:11:09 INFO - PROCESS | 1666 | Number of tests: 6 09:11:09 INFO - PROCESS | 1666 | 09:11:09 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5824.62 Median:6104.15 stddev:640.42 (10.5%) stddev-sans-first:616.09 09:11:09 INFO - PROCESS | 1666 | Values: 3509.4 3545.7 3566.4 3583.8 3638.6 5753.8 5759.1 5797.1 5798.5 5830.4 5778.8 5836.8 5843.4 5848.9 5851.1 5245.3 5256.1 5286.3 5336.9 5369.7 5303.0 5327.3 5339.3 5342.9 5343.6 5266.4 5274.7 5320.6 5348.5 5350.8 5349.8 5364.0 5374.2 5386.3 5408.2 5175.8 5238.9 5298.8 5318.8 5339.8 5668.5 5696.5 5724.0 5728.3 5730.3 6333.7 6333.9 6346.6 6358.8 6368.3 6216.4 6285.0 6327.8 6343.4 6390.5 5966.4 5992.2 5994.5 6009.5 6023.3 5064.6 6362.5 6364.4 6377.0 6387.6 6096.8 6133.7 6207.9 6220.2 6276.6 6160.4 6182.3 6183.1 6196.6 6198.2 6038.7 6107.0 6117.1 6131.4 6131.4 6197.5 6271.4 6339.4 6389.1 6399.8 4954.3 4978.3 5002.8 5003.4 5036.3 3890.4 4548.3 4555.8 4564.4 4587.7 5681.3 5791.2 5826.6 5914.8 5935.6 6292.5 6308.7 6309.2 6315.9 6320.2 5852.7 5875.1 5876.1 5887.1 5908.8 4515.0 5392.6 5414.9 5483.9 5508.9 6253.5 6403.3 6418.9 6420.0 6420.6 6166.8 6314.2 6344.6 6345.9 6345.9 6410.2 6430.7 6451.8 6452.5 6452.7 6304.5 6310.9 6324.9 6345.5 6346.0 6228.2 6239.2 6325.7 6347.0 6356.7 6128.6 6207.8 6283.0 6295.4 6298.5 5173.9 6219.3 6265.1 6272.7 6279.5 5885.9 6062.6 6089.9 6104.1 6137.9 6107.7 6152.3 6181.4 6260.8 6271.4 6127.3 6161.7 6165.8 6174.8 6181.8 09:11:09 INFO - PROCESS | 1666 | 09:11:09 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:65970.26 Median:3599.86 stddev:139564.41 (3876.9%) stddev-sans-first:139869.46 09:11:09 INFO - PROCESS | 1666 | Values: 535.6 557.8 583.0 606.6 611.1 26161.9 39412.6 40160.8 40259.8 40352.4 46295.0 46909.3 47006.5 47042.5 47148.0 9058.6 9850.5 10008.7 10011.8 10018.7 9092.4 11921.1 12119.8 12138.0 12142.8 11890.5 12033.6 12033.8 12045.6 12049.1 12047.6 12146.3 12150.2 12161.5 12165.4 12032.8 12177.2 12179.8 12183.9 12218.6 39841.2 42104.8 43258.9 43856.6 44011.0 3327.2 3432.0 3540.5 3574.9 3970.8 27328.9 29846.3 29894.6 30243.0 30634.5 2764.3 2794.6 2815.7 2834.2 2922.2 439090.0 443127.0 443135.0 444086.0 444294.0 37489.3 37632.2 37709.0 66472.0 68071.7 32157.0 36738.4 36874.9 36921.4 36948.3 15833.2 15968.1 15998.2 16022.8 16028.5 13026.3 13253.7 13385.2 13578.5 13605.4 8411.9 8434.8 8481.0 8507.1 8560.0 3546.9 3552.5 3585.1 3587.6 3612.1 949.4 1034.8 1046.7 1069.3 1175.9 30062.9 30479.4 31041.7 31341.7 31746.5 899.3 1142.9 1159.4 1187.6 1204.2 11588.5 15327.6 15610.0 15722.6 15972.8 498639.0 499763.0 506708.0 508386.0 509172.0 58556.7 59031.1 59038.8 59074.7 59122.7 1421.7 1555.7 1591.8 1597.2 1605.0 30317.1 30842.4 31279.4 31321.7 31865.5 53215.2 54095.7 54221.7 54231.0 54248.5 593853.0 612483.0 613355.9 614932.0 615085.0 38036.4 46085.0 46193.3 46396.3 46579.8 49651.8 49769.8 50031.7 50660.7 51900.7 39182.0 39920.8 41013.0 41367.0 42028.8 39488.2 40285.8 40502.0 40993.0 41549.8 32764.5 39213.6 40264.8 40556.6 40676.6 33670.8 34988.8 34997.1 35393.1 35438.0 26095.2 26396.5 26535.7 26689.2 26713.7 09:11:09 INFO - PROCESS | 1666 | 09:11:09 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:34168.89 Median:14711.31 stddev:102089.43 (694.0%) stddev-sans-first:102344.34 09:11:09 INFO - PROCESS | 1666 | Values: 409.9 411.4 413.0 416.1 422.3 15640.7 20478.2 21253.3 21298.3 21332.5 16925.4 17020.7 20506.0 20862.7 21075.8 5914.6 6203.0 6235.6 6238.3 6249.4 5357.4 5942.3 6084.7 6244.0 6245.0 6203.0 6228.7 6234.8 6238.1 6240.3 5416.0 5693.1 6212.8 6223.2 6230.7 4675.2 5392.0 5424.7 5433.7 5449.0 26878.6 26981.7 27135.9 27476.0 27490.5 2187.8 2438.5 2457.3 2544.0 2914.6 11702.8 15191.8 15211.4 15422.8 15800.8 1783.0 1815.8 1824.1 1847.7 1869.5 53938.7 80498.4 98311.0 111020.2 111287.4 11005.3 11319.0 11514.1 11639.7 11655.4 14380.6 14401.1 14423.1 14435.9 14447.6 8131.9 8527.6 8550.1 8669.0 9045.6 7626.7 9146.2 9248.8 9271.3 9419.7 6789.8 6849.3 6909.0 6929.3 6953.4 1800.7 1812.6 1912.9 1924.9 1939.7 959.9 999.4 1045.7 1072.9 1095.5 17813.1 20287.9 21037.2 22019.0 22128.9 1011.3 1015.3 1039.0 1055.0 1105.3 11577.2 11791.2 11806.8 11827.3 11842.5 605360.0 612809.0 621001.0 627291.0 627962.0 86680.1 111951.0 112099.0 115637.0 116085.0 1059.6 1064.5 1079.0 1083.7 1087.7 15515.8 18664.9 18760.7 19481.7 19825.7 48840.8 50021.7 50465.5 50866.5 53525.7 66574.0 66992.0 69243.0 69494.7 71100.3 7925.3 8071.2 8071.8 8239.2 8393.1 7473.4 9768.9 12418.0 12780.3 12848.2 11018.6 11120.2 11252.4 11314.7 11472.5 9675.1 9782.8 10984.8 11270.5 11276.4 9570.5 11074.4 11299.5 11592.4 11664.2 8282.3 8284.4 8357.5 8444.4 8610.3 7039.9 9862.3 10946.3 11412.5 11462.0 09:11:09 INFO - PROCESS | 1666 | 09:11:09 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5756.01 Median:5026.01 stddev:3225.52 (64.2%) stddev-sans-first:3218.32 09:11:09 INFO - PROCESS | 1666 | Values: 1448.1 1622.9 1654.2 1916.5 2022.9 8123.1 8312.5 8316.8 8330.3 8330.6 8163.6 8378.3 8503.1 8519.1 8519.8 2087.6 2471.0 2507.5 2508.2 2508.6 2460.7 2489.9 2504.5 2514.6 2518.5 2467.6 2494.9 2495.4 2501.7 2505.2 2453.9 2487.7 2498.9 2499.9 2500.4 2474.6 2516.6 2518.5 2524.9 2525.9 8843.5 8873.5 8886.5 8887.0 8900.1 5399.4 5456.9 5537.7 5588.2 5588.2 3628.5 3638.3 3653.3 3686.7 3715.6 976.3 1000.9 1042.5 1065.9 1085.4 12087.9 12173.0 12173.8 12185.7 12208.3 4718.5 4744.8 4748.7 4795.7 4869.0 9523.7 9593.1 9609.6 9612.0 9628.5 5503.4 5546.6 5562.1 5570.4 5572.0 4092.7 4569.3 4753.3 4790.4 5185.6 3900.8 3975.0 4026.4 4034.8 4039.6 1219.3 1241.6 1245.9 1251.3 1267.7 927.5 935.7 947.3 962.2 998.4 5883.9 5990.2 6089.8 6121.4 6152.6 461.4 480.1 483.7 487.1 491.9 3271.8 3947.3 4113.7 4120.3 4137.8 10461.3 11026.4 11164.4 11197.8 11208.3 10810.2 10835.9 10950.3 11050.1 11067.3 8492.9 8601.2 8609.9 8667.7 8681.4 5642.2 5869.4 5903.5 5991.6 5998.3 9723.7 9766.9 9911.8 9925.1 9927.6 9602.2 10064.3 10102.6 10147.5 10356.5 6573.1 6815.0 6949.1 7252.3 7328.0 8446.9 8466.7 8522.3 8528.4 8528.9 6423.4 7488.0 7527.4 7738.5 7779.5 7361.9 7446.4 7507.9 7558.2 7589.3 7094.1 7198.7 7207.9 7215.4 7246.7 4186.0 4951.8 4964.2 5030.5 5087.1 5021.5 5048.3 5054.9 5183.8 5322.7 09:11:09 INFO - PROCESS | 1666 | 09:11:09 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:5700.22 Median:6519.93 stddev:1807.42 (27.7%) stddev-sans-first:1766.92 09:11:09 INFO - PROCESS | 1666 | Values: 327.0 332.2 338.5 342.6 346.5 6454.2 6517.3 6531.4 6557.4 6559.8 6489.5 6491.7 6496.3 6508.3 6530.5 4644.8 4771.3 4801.6 4830.3 4840.0 4820.3 4893.5 4900.1 4905.7 4908.5 4832.0 4847.1 4859.4 4860.8 4879.0 4600.0 4699.4 4799.8 4827.2 4847.1 4142.0 4152.9 4157.8 4160.3 4165.2 6157.2 6162.2 6197.5 6240.2 6247.7 5554.3 5697.9 5704.1 5704.8 5707.4 5851.5 6930.5 6943.7 6948.9 6952.4 4390.9 4534.0 4536.4 4551.9 4554.2 7147.8 7307.6 7338.9 7342.8 7343.0 4625.2 4634.2 4643.6 4645.3 4654.6 4691.3 4699.4 4700.7 4708.6 4710.2 5528.5 5551.5 5561.4 5566.1 5570.4 6389.6 6522.6 6924.3 6938.2 7017.2 1525.6 1606.9 1634.7 1635.3 1637.2 980.2 991.6 1033.4 1033.7 1056.2 6382.4 6553.3 6561.4 6578.0 6580.0 7296.9 7297.0 7299.9 7303.3 7303.9 5477.7 6560.7 6562.2 6577.3 6581.9 3733.2 3827.3 3831.4 3831.5 3838.8 6544.9 7259.4 7338.5 7576.4 7585.0 7465.0 7511.0 7512.5 7516.0 7545.1 7613.7 7618.4 7628.7 7645.0 7669.8 6934.0 7269.0 7270.7 7281.3 7301.9 6298.7 6639.7 7045.8 7090.7 7098.0 7545.6 7567.2 7573.0 7577.4 7606.2 4577.3 4642.2 4650.2 4652.5 4664.6 6966.2 7225.9 7230.5 7236.5 7253.7 6950.3 6980.6 6980.6 6987.1 7002.1 6930.5 6967.0 6974.9 6983.5 6996.5 6762.7 6771.4 6779.8 6786.7 6787.6 5694.9 5771.9 6778.8 6811.9 6822.2 6596.6 6753.6 6763.1 6861.6 6902.6 09:11:09 INFO - PROCESS | 1666 | 09:11:09 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:18892.52 Median:46909.15 stddev:26751.55 (57.0%) stddev-sans-first:26791.60 09:11:09 INFO - PROCESS | 1666 | Values: 669.6 703.1 726.7 795.5 799.5 15481.0 15828.0 15841.4 15849.0 15858.4 14420.1 14630.7 14632.4 14632.9 14659.3 776.2 794.7 939.3 976.4 976.8 965.9 971.1 971.8 974.7 976.6 823.2 1028.8 1031.4 1033.9 1034.3 747.3 755.8 825.3 1025.1 1043.6 712.6 727.9 778.2 779.6 779.7 15354.0 15669.5 15714.4 15727.1 15729.6 13083.0 13185.4 13322.9 13426.3 13496.5 10229.9 11192.2 11305.7 11531.7 11660.0 3595.5 3619.2 3652.7 3692.4 3882.9 87152.1 88269.6 88272.6 89483.6 89490.1 9637.8 10038.7 10178.3 10373.9 10393.2 19881.8 23854.6 23913.4 23930.2 23963.8 7745.4 7749.0 7810.2 7819.5 8028.5 4202.3 4293.3 4307.0 4327.0 4597.7 3830.4 3901.3 3909.3 3918.9 3922.2 585.7 672.2 673.2 687.8 692.9 572.3 587.3 605.7 622.4 657.2 8121.4 8451.9 8468.7 8560.7 8564.4 532.3 566.7 591.4 605.2 618.0 3837.4 3957.5 3986.3 4016.6 4069.3 96925.5 96934.0 98271.5 98308.0 98339.5 82215.4 82273.0 82741.6 83304.2 84274.6 73449.3 73469.6 73637.3 73914.0 74684.6 7609.2 7796.8 7912.4 8106.6 8192.9 45059.8 46004.0 46309.5 46538.5 47279.8 57852.4 62253.4 62456.4 62842.0 62946.4 10579.1 10620.8 10971.9 11358.7 11639.4 12012.6 12034.2 12116.4 12153.0 12906.2 11628.8 11682.5 11699.7 12036.2 12161.6 10201.0 11793.2 11883.4 12119.3 12270.3 11293.9 11883.8 11900.3 11953.9 11966.2 9615.7 9687.0 9950.4 10326.1 10336.7 9174.7 9566.0 9874.2 9898.0 9907.8 09:11:09 INFO - PROCESS | 1666 | -------- Summary: end -------- 09:11:09 INFO - PROCESS | 1666 | 09:11:10 INFO - TEST-INFO | 1666: exit 0 09:11:10 INFO - TEST-OK | dromaeo_css | took 1113467ms 09:11:10 INFO - TEST-START | kraken 09:11:10 INFO - operating with platform_type : mac_ 09:11:10 INFO - Initialising browser for kraken test... 09:11:10 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpMUkXam/profile http://localhost:49273/getInfo.html) 09:11:12 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 09:11:12 INFO - PROCESS | 1673 | colorDepth:24 09:11:12 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 09:11:12 INFO - PROCESS | 1673 | __metrics 09:11:12 INFO - PROCESS | 1673 | 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" 09:11:12 ERROR - PROCESS | 1673 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:11:13 INFO - TEST-INFO | 1673: exit 0 09:11:13 INFO - Browser initialized. 09:11:13 INFO - Running cycle 1/1 for kraken test... 09:11:13 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpMUkXam/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:24 INFO - PROCESS | 1676 | RSS: Main: 161763328 09:11:24 INFO - PROCESS | 1676 | 09:11:27 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 09:11:28 INFO - PROCESS | 1676 | RSS: Main: 224526336 09:11:28 INFO - PROCESS | 1676 | 09:11:31 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 09:11:31 INFO - PROCESS | 1676 | RSS: Main: 239382528 09:11:31 INFO - PROCESS | 1676 | 09:11:35 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 09:11:35 INFO - PROCESS | 1676 | RSS: Main: 324964352 09:11:35 INFO - PROCESS | 1676 | 09:11:37 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 09:11:38 INFO - PROCESS | 1676 | RSS: Main: 231911424 09:11:38 INFO - PROCESS | 1676 | 09:11:40 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:11:40 INFO - PROCESS | 1676 | RSS: Main: 232271872 09:11:40 INFO - PROCESS | 1676 | 09:11:43 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 09:11:44 INFO - PROCESS | 1676 | RSS: Main: 271114240 09:11:44 INFO - PROCESS | 1676 | 09:11:47 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 09:11:47 INFO - PROCESS | 1676 | RSS: Main: 270741504 09:11:47 INFO - PROCESS | 1676 | 09:11:50 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 09:11:51 INFO - PROCESS | 1676 | RSS: Main: 268775424 09:11:51 INFO - PROCESS | 1676 | 09:11:52 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:11:53 INFO - PROCESS | 1676 | RSS: Main: 260292608 09:11:53 INFO - PROCESS | 1676 | 09:11:55 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:11:56 INFO - PROCESS | 1676 | RSS: Main: 266891264 09:11:56 INFO - PROCESS | 1676 | 09:11:58 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:11:58 INFO - PROCESS | 1676 | RSS: Main: 271458304 09:11:58 INFO - PROCESS | 1676 | 09:12:01 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:12:02 INFO - PROCESS | 1676 | RSS: Main: 278032384 09:12:02 INFO - PROCESS | 1676 | 09:12:04 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:12:05 INFO - PROCESS | 1676 | RSS: Main: 275099648 09:12:05 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 09:12:07 INFO - PROCESS | 1676 | RSS: Main: 336654336 09:12:07 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | __start_tp_report 09:12:07 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 09:12:07 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 09:12:07 INFO - PROCESS | 1676 | |i|pagename|runs| 09:12:07 INFO - PROCESS | 1676 | |0;ai-astar;113;113;120;116;161;165;113;113;113;132 09:12:07 INFO - PROCESS | 1676 | |1;audio-beat-detection;156;120;144;162;124;174;167;143;166;119 09:12:07 INFO - PROCESS | 1676 | |2;audio-dft;187;196;258;183;183;185;185;186;185;187 09:12:07 INFO - PROCESS | 1676 | |3;audio-fft;69;78;74;154;55;58;58;63;135;58 09:12:07 INFO - PROCESS | 1676 | |4;audio-oscillator;90;88;142;80;78;81;124;79;79;126 09:12:07 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;89;87;89;86;88;86;90;87;89;85 09:12:07 INFO - PROCESS | 1676 | |6;imaging-darkroom;94;94;94;93;94;98;98;94;93;94 09:12:07 INFO - PROCESS | 1676 | |7;imaging-desaturate;85;83;85;105;139;71;131;131;141;85 09:12:07 INFO - PROCESS | 1676 | |8;json-parse-financial;60;62;63;62;64;63;62;78;61;56 09:12:07 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;62;60;60;68;66;72;69;64;64;87 09:12:07 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;80;79;79;79;77;78;79;77;100;108 09:12:07 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;128;123;124;144;136;117;122;126;155;143 09:12:07 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;160;159;162;164;160;163;162;164;175;141 09:12:07 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;66;71;93;94;98;96;67;67;66;65 09:12:07 INFO - PROCESS | 1676 | __end_tp_report 09:12:07 INFO - PROCESS | 1676 | __start_cc_report 09:12:07 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,2034 09:12:07 INFO - PROCESS | 1676 | __end_cc_report 09:12:07 INFO - PROCESS | 1676 | __startTimestamp1466698327605__endTimestamp 09:12:07 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | ------- Summary: start ------- 09:12:07 INFO - PROCESS | 1676 | Number of tests: 14 09:12:07 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:125.90 Median:118.00 stddev:20.45 (17.3%) stddev-sans-first:21.15 09:12:07 INFO - PROCESS | 1676 | Values: 113.0 113.0 120.0 116.0 161.0 165.0 113.0 113.0 113.0 132.0 09:12:07 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:159.00 stddev:20.71 (13.0%) stddev-sans-first:21.74 09:12:07 INFO - PROCESS | 1676 | Values: 156.0 120.0 144.0 162.0 124.0 174.0 167.0 143.0 166.0 119.0 09:12:07 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:193.50 Median:186.50 stddev:22.96 (12.3%) stddev-sans-first:24.23 09:12:07 INFO - PROCESS | 1676 | Values: 187.0 196.0 258.0 183.0 183.0 185.0 185.0 186.0 185.0 187.0 09:12:07 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:80.20 Median:60.50 stddev:35.00 (57.9%) stddev-sans-first:36.89 09:12:07 INFO - PROCESS | 1676 | Values: 69.0 78.0 74.0 154.0 55.0 58.0 58.0 63.0 135.0 58.0 09:12:07 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:79.50 stddev:24.22 (30.5%) stddev-sans-first:25.56 09:12:07 INFO - PROCESS | 1676 | Values: 90.0 88.0 142.0 80.0 78.0 81.0 124.0 79.0 79.0 126.0 09:12:07 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.50 stddev:1.65 (1.9%) stddev-sans-first:1.67 09:12:07 INFO - PROCESS | 1676 | Values: 89.0 87.0 89.0 86.0 88.0 86.0 90.0 87.0 89.0 85.0 09:12:07 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:94.00 stddev:1.84 (2.0%) stddev-sans-first:1.94 09:12:07 INFO - PROCESS | 1676 | Values: 94.0 94.0 94.0 93.0 94.0 98.0 98.0 94.0 93.0 94.0 09:12:07 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:105.60 Median:77.00 stddev:27.16 (35.3%) stddev-sans-first:27.77 09:12:07 INFO - PROCESS | 1676 | Values: 85.0 83.0 85.0 105.0 139.0 71.0 131.0 131.0 141.0 85.0 09:12:07 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:62.50 stddev:5.69 (9.1%) stddev-sans-first:5.92 09:12:07 INFO - PROCESS | 1676 | Values: 60.0 62.0 63.0 62.0 64.0 63.0 62.0 78.0 61.0 56.0 09:12:07 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:7.97 (11.9%) stddev-sans-first:8.23 09:12:07 INFO - PROCESS | 1676 | Values: 62.0 60.0 60.0 68.0 66.0 72.0 69.0 64.0 64.0 87.0 09:12:07 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:79.00 stddev:10.96 (13.9%) stddev-sans-first:11.54 09:12:07 INFO - PROCESS | 1676 | Values: 80.0 79.0 79.0 79.0 77.0 78.0 79.0 77.0 100.0 108.0 09:12:07 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:132.00 stddev:12.16 (9.2%) stddev-sans-first:12.82 09:12:07 INFO - PROCESS | 1676 | Values: 128.0 123.0 124.0 144.0 136.0 117.0 122.0 126.0 155.0 143.0 09:12:07 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:162.50 stddev:8.34 (5.1%) stddev-sans-first:8.84 09:12:07 INFO - PROCESS | 1676 | Values: 160.0 159.0 162.0 164.0 160.0 163.0 162.0 164.0 175.0 141.0 09:12:07 INFO - PROCESS | 1676 | 09:12:07 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.30 Median:82.00 stddev:14.73 (18.0%) stddev-sans-first:14.93 09:12:07 INFO - PROCESS | 1676 | Values: 66.0 71.0 93.0 94.0 98.0 96.0 67.0 67.0 66.0 65.0 09:12:07 INFO - PROCESS | 1676 | -------- Summary: end -------- 09:12:07 INFO - PROCESS | 1676 | 09:12:08 INFO - TEST-INFO | 1676: exit 0 09:12:08 INFO - TEST-OK | kraken | took 58074ms 09:12:08 INFO - SUITE-END | took 1171s 09:12:08 INFO - Completed test suite (00:19:31) 09:12:08 INFO - javascript benchmark 09:12:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3509.403401421758, 3545.716342692585, 3566.447200683895, 3583.838727257273, 3638.6179451157627, 5753.798617048405, 5759.078547432407, 5797.072468405056, 5798.507126894208, 5830.358660547342, 5778.768849246025, 5836.766529338832, 5843.4156584341545, 5848.912266316009, 5851.122331650244, 5245.291885595443, 5256.08018596744, 5286.31277933868, 5336.932613477301, 5369.6509726867625, 5302.973485132569, 5327.307450031491, 5339.332583427072, 5342.919856202141, 5343.572514198855, 5266.3943646480575, 5274.709890955995, 5320.600954928376, 5348.545373643245, 5350.759215835296, 5349.7592608332525, 5363.973180134074, 5374.193870919394, 5386.326709161355, 5408.161734931092, 5175.7670904809, 5238.869028274324, 5298.814541491068, 5318.840434786963, 5339.759710812984, 5668.518175955049, 5696.51579615729, 5724.0, 5728.341240757324, 5730.283714535683, 6333.7466501339895, 6333.936660633381, 6346.587471814363, 6358.77744278948, 6368.267649220353, 6216.409441103088, 6285.0, 6327.778527751552, 6343.429091381798, 6390.456811171056, 5966.433188847052, 5992.161097446361, 5994.490468310155, 6009.519238460913, 6023.27720673522, 5064.645474816727, 6362.491000719931, 6364.395382438661, 6376.968115159394, 6387.648679322589, 6096.847578810565, 6133.701927635063, 6207.875842483125, 6220.160278362454, 6276.592021518587, 6160.383961603804, 6182.319944806068, 6183.103449999725, 6196.566240363131, 6198.163247961467, 6038.698065096815, 6106.969465152646, 6117.082437634391, 6131.356207598227, 6131.356207598227, 6197.4732147767945, 6271.372862713783, 6339.397757213057, 6389.137466442064, 6399.840003999844, 4954.256861470736, 4978.278149668277, 5002.799888004512, 5003.399592048978, 5036.294918711384, 3890.3580909149673, 4548.2722764358205, 4555.840545580889, 4564.406627138451, 4587.724736515753, 5681.34664513578, 5791.160281759206, 5826.592138550345, 5914.792982245687, 5935.643861368331, 6292.528060395489, 6308.653024083719, 6309.211348581427, 6315.905261421082, 6320.178376811077, 5852.707364631837, 5875.089361149029, 5876.1479585459865, 5887.146363777314, 5908.822735317947, 4514.954850451519, 5392.649477783932, 5414.891702166014, 5483.862903427446, 5508.862278442991, 6253.468455181361, 6403.295637479873, 6418.935810641927, 6420.0048992406255, 6420.550561460746, 6166.81499555014, 6314.179156709598, 6344.587601805868, 6345.904811427925, 6345.936540634534, 6410.1987251593555, 6430.678466076584, 6451.838704032437, 6452.54832161763, 6452.7418903245225, 6304.495640348853, 6310.936890631035, 6324.936750632619, 6345.524085693499, 6345.96827015862, 6228.22147231596, 6239.188905442264, 6325.746970121144, 6347.047942808431, 6356.650384228912, 6128.601640893327, 6207.81376558704, 6282.968585157045, 6295.433410993032, 6298.527610429144, 5173.92239116406, 6219.346968568235, 6265.122882796321, 6272.655003974825, 6279.497640188682, 5885.941140588539, 6062.605930614496, 6089.939100609115, 6104.145419641165, 6137.907931381123, 6107.694615269308, 6152.323244443197, 6181.350958149509, 6260.843478913063, 6271.372862713874, 6127.29536103336, 6161.6919154041225, 6165.784197553064, 6174.8147555573405, 6181.84545386369], "value": 5785.827194236431, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.617033820818, 557.7796770275742, 583.0321666034383, 606.5996442348052, 611.0559186057541, 26161.869190654044, 39412.605873941255, 40160.79919600405, 40259.79220623379, 40352.39471407927, 46295.0, 46909.29636055462, 47006.52993470073, 47042.52957470424, 47148.0, 9058.637654493845, 9850.458224797634, 10008.749781255454, 10011.799764004716, 10018.749531261741, 9092.40899341544, 11921.105917056213, 12119.757604847899, 12137.968272696788, 12142.817857732141, 11890.524379024828, 12033.578824741136, 12033.759324813498, 12045.578404755835, 12049.096317776159, 12047.578334758286, 12146.271223726604, 12150.21023633461, 12161.452734626962, 12165.391730413532, 12032.81950770739, 12177.208481448677, 12179.817302740466, 12183.939080304543, 12218.572349967797, 39841.203175936316, 42104.78947605273, 43258.91852703676, 43856.56143438556, 44011.0, 3327.2014716468116, 3432.0, 3540.451230059345, 3574.910627234314, 3970.7617542947514, 27328.863355683294, 29846.25384365408, 29894.551581726293, 30243.0, 30634.54048189279, 2764.25365151408, 2794.552871540544, 2815.7465828075365, 2834.2489240351324, 2922.21100302917, 439090.0, 443127.0, 443135.0, 444086.0, 444293.99999999674, 37489.25021499609, 37632.247355053296, 37709.0, 66472.0, 68071.65964170148, 32157.03528894137, 36738.44892326617, 36874.89375318745, 36921.44617830735, 36948.261034779156, 15833.208339582974, 15968.121753303447, 15998.200089995453, 16022.75965860513, 16028.519144425685, 13026.28355440441, 13253.66865828362, 13385.19688818674, 13578.45686172542, 13605.387757550934, 8411.915880841236, 8434.831303373898, 8480.957595212109, 8507.106753790888, 8559.95720021396, 3546.858125674944, 3552.484889691032, 3585.0858031202397, 3587.6232995535615, 3612.096975756061, 949.4445749236774, 1034.8085604163255, 1046.6912260883057, 1069.2996087562658, 1175.9118066145074, 30062.947796827444, 30479.39041219163, 31041.689583104333, 31341.68658313433, 31746.523802142987, 899.2760827533767, 1142.8514293142005, 1159.431878379588, 1187.5962172861268, 1204.2052245518091, 11588.536458541565, 15327.61680957985, 15610.0, 15722.606934826721, 15972.840271597135, 498639.0, 499763.0, 506708.0, 508386.0, 509172.0, 58556.7072164645, 59031.11453328204, 59038.81922361615, 59074.704626476596, 59122.704386478654, 1421.7085497472992, 1555.6810853774948, 1591.8169410517708, 1597.209381356236, 1605.0048969638665, 30317.090487285415, 30842.383152337276, 31279.37441251208, 31321.686783131878, 31865.522017170224, 53215.20177197268, 54095.72952135214, 54221.72889135529, 54231.0, 54248.45751542434, 593853.0, 612483.0, 613355.9332203311, 614932.0, 615085.0, 38036.42945355766, 46085.0, 46193.30710039285, 46396.30405543987, 46579.83550411267, 49651.75174124106, 49769.75115124546, 50031.74984125056, 50660.74669626628, 51900.74049629728, 39182.0, 39920.80039599783, 41013.0, 41367.0, 42028.78985605053, 39488.2102357957, 40285.79857100813, 40502.0, 40992.97517561966, 41549.792251038554, 32764.50853237251, 39213.60786392214, 40264.79867600643, 40556.59443405646, 40676.59323406728, 33670.83164584259, 34988.82505587456, 34997.12507187239, 35393.1151721209, 35438.0, 26095.217143485726, 26396.472070558866, 26535.734642654097, 26689.199324020312, 26713.732862671124], "value": 19763.719826564797, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.9262132816092, 411.36033467957316, 413.03968273763496, 416.1116017303058, 422.2926597948436, 15640.687186256268, 20478.18087276509, 21253.256136035223, 21298.254561090347, 21332.4666883328, 16925.407610733626, 17020.659586808255, 20505.974701264913, 20862.68705969408, 21075.789242107614, 5914.556408269386, 6203.0, 6235.563510554263, 6238.282597501277, 6249.375062493737, 5357.4374690657505, 5942.2869255689375, 6084.726187321581, 6243.968780156093, 6244.9687751561405, 6202.9689851550675, 6228.657423841687, 6234.8441288967915, 6238.064290356438, 6240.344763799803, 5416.0, 5693.060644993571, 6212.751489940397, 6223.222097237845, 6230.719617617218, 4675.2052151134385, 5391.975524650304, 5424.674519528841, 5433.701146436944, 5448.972755136199, 26878.5968210477, 26981.730182698313, 27135.86432067847, 27476.0, 27490.450190996067, 2187.8359123065675, 2438.5488684593406, 2457.31195265326, 2544.020552087441, 2914.562815577659, 11702.833599096755, 15191.848081519154, 15211.391544338214, 15422.845771542365, 15800.762988555181, 1782.9554261143446, 1815.7730283714536, 1824.1153040775214, 1847.7320788485729, 1869.5045812859603, 53938.73030634822, 80498.37757300936, 98311.0, 111020.22449438748, 111287.44356278247, 11005.284656497302, 11319.037881780141, 11514.136439767051, 11639.6508104757, 11655.358955257543, 14380.640483987774, 14401.135931844123, 14423.134611923319, 14435.855641443452, 14447.638809029859, 8131.918680813116, 8527.573621318908, 8550.102239264788, 8668.956655216683, 9045.649320090186, 7626.733064342721, 9146.222571081533, 9248.751418558542, 9271.258299336037, 9419.670311539063, 6789.796306110726, 6849.315068493211, 6909.032735417046, 6929.341712537301, 6953.374196322356, 1800.7388928605278, 1812.5519964162604, 1912.9043547822553, 1924.8845069295887, 1939.6896496560482, 959.8848138223458, 999.3604093380243, 1045.6915210013065, 1072.9195310351754, 1095.5145538412617, 17813.109344532983, 20287.898560507103, 21037.15851365959, 22019.0, 22128.889355553118, 1011.3022014809758, 1015.2791518022287, 1039.0, 1054.9683509494728, 1105.2815669814686, 11577.247478913843, 11791.233569817934, 11806.763864722829, 11827.349495777815, 11842.526298948118, 605360.0, 612809.0, 621001.0, 627291.0, 627962.0, 86680.1331986672, 111951.0, 112099.0, 115637.0, 116085.0, 1059.6171995545733, 1064.5475672839013, 1078.9568417263222, 1083.7236504691252, 1087.6845714742635, 15515.84484155144, 18664.906675466536, 18760.718589220898, 19481.738991448736, 19825.702614461083, 48840.755796220794, 50021.749891250314, 50465.49534504608, 50866.49133508765, 53525.66185845385, 66574.0, 66992.0, 69243.0, 69494.65252673705, 71100.28899711143, 7925.326347260317, 8071.192880711882, 8071.838563228585, 8239.217274358927, 8393.118722534045, 7473.439492038227, 9768.876579193484, 12418.0, 12780.297083660487, 12848.229106253655, 11018.614348497764, 11120.165987550805, 11252.381119038531, 11314.717132071764, 11472.483738231633, 9675.129238368581, 9782.75543111428, 10984.780304394028, 11270.49282782293, 11276.3797991108, 9570.521473926137, 11074.446277686244, 11299.491522881326, 11592.362420066976, 11664.183507154758, 8282.337413006824, 8284.420090593601, 8357.456765310235, 8444.36667249971, 8610.311175105851, 7039.8944015840825, 9862.2603304751, 10946.288491248044, 11412.543498259976, 11462.0], "value": 9740.440087689492, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.1311213272045, 1622.8721038877977, 1654.197714108657, 1916.492129585659, 2022.9190832366696, 8123.147069557693, 8312.459690120153, 8316.75049748507, 8330.333573314136, 8330.625121869516, 8163.632636531355, 8378.287845533121, 8503.149685031494, 8519.148085191478, 8519.78700532487, 2087.6242276390244, 2470.950580988379, 2507.4734305795805, 2508.209913877132, 2508.586083296254, 2460.6801115854914, 2489.9253022409266, 2504.5491811474017, 2514.5599520084, 2518.4711210645696, 2467.5558399488086, 2494.9126780562683, 2495.413577809213, 2501.7498250175017, 2505.24842547236, 2453.9018439262495, 2487.6517287579754, 2498.912972856813, 2499.9375015624573, 2500.3874050857567, 2474.6288056791445, 2516.5847635140362, 2518.4711210645787, 2524.911628093008, 2525.949481010388, 8843.513606751627, 8873.51195684237, 8886.511241881693, 8887.022427532966, 8900.109989001048, 5399.406065332811, 5456.890862182774, 5537.695426751527, 5588.189712491707, 5588.21764952907, 3628.4738712886483, 3638.272345530904, 3653.3058718843336, 3686.686631636314, 3715.5727091384565, 976.3409698453587, 1000.854876042977, 1042.4527123260273, 1065.8987396197426, 1085.3704851186294, 12087.87912120885, 12172.965297949597, 12173.817392739027, 12185.69535761613, 12208.267503949792, 4718.528147185254, 4744.7829920642835, 4748.738819364899, 4795.664303498722, 4868.977514721948, 9523.714288571355, 9593.13661770444, 9609.567569459392, 9612.0, 9628.518574071268, 5503.449655034545, 5546.584006199551, 5562.137868630369, 5570.387257401682, 5571.969185700658, 4092.652124569445, 4569.2689169732685, 4753.263244197155, 4790.401199850019, 5185.585153187736, 3900.7854567999034, 3974.980125099356, 4026.416169655384, 4034.8184331705143, 4039.5556488786797, 1219.3232755820604, 1241.6461308527028, 1245.9377031148406, 1251.2617555642214, 1267.689416093063, 927.4620719982394, 935.7099299217128, 947.2800671489717, 962.2302158273353, 998.3810037776625, 5883.911741323884, 5990.221271234712, 6089.786857460056, 6121.387861213932, 6152.569320147547, 461.39096392761235, 480.13575563985387, 483.68560435716364, 487.05754365302545, 491.9311296418504, 3271.8036917785007, 3947.3289540778137, 4113.732607380511, 4120.25835349634, 4137.77242251673, 10461.26771126029, 11026.393548354918, 11164.441777911072, 11197.776044479066, 11208.27146235492, 10810.243282970117, 10835.891641083488, 10950.34297942126, 11050.115990720724, 11067.335959842436, 8492.872606910902, 8601.225889669835, 8609.91390086091, 8667.739967800977, 8681.392302538889, 5642.181883626933, 5869.413058694096, 5903.527717782653, 5991.550633702403, 5998.280206375263, 9723.708288751348, 9766.85349719769, 9911.801763964824, 9925.1067403934, 9927.553260103457, 9602.231821454407, 10064.345817521838, 10102.646407375707, 10147.49262536885, 10356.482175891326, 6573.1454910861285, 6815.045893574805, 6949.061876646588, 7252.2747725227055, 7327.963360183165, 8446.944131983502, 8466.74599762008, 8522.318214542945, 8528.445651032664, 8528.872066919126, 6423.42189202974, 7488.0, 7527.435442341737, 7738.535687858746, 7779.494332868346, 7361.852762944818, 7446.4042876568665, 7507.924920750723, 7558.2441755823975, 7589.316961473494, 7094.148702155568, 7198.748043818441, 7207.8558428832175, 7215.422766178588, 7246.7101315948885, 4185.97907010463, 4951.777170027285, 4964.180910149785, 5030.547250747451, 5087.08432482142, 5021.472745361684, 5048.268001139888, 5054.924176137434, 5183.844484665466, 5322.733863306897], "value": 4573.534032550177, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.9722073623742, 332.1563229397331, 338.4838121864156, 342.55467891740744, 346.5044985670493, 6454.225492940848, 6517.250516190639, 6531.444827189683, 6557.442617377528, 6559.803205903819, 6489.480841532678, 6491.734111848192, 6496.310959150619, 6508.316626754194, 6530.510211734115, 4644.790984405701, 4771.33201351811, 4801.567858892699, 4830.2513110467935, 4840.031993601294, 4820.301056346828, 4893.510648935096, 4900.142475066867, 4905.681130726509, 4908.533689299511, 4831.951680483186, 4847.0548243092435, 4859.41686997559, 4860.756962151896, 4878.951025529511, 4599.954000460003, 4699.412573428339, 4799.808007679689, 4827.179379505457, 4847.079054979543, 4142.047329114321, 4152.857964059877, 4157.771322577257, 4160.271952408317, 4165.166966606691, 6157.168782214433, 6162.22972128484, 6197.5351848611535, 6240.157578726905, 6247.718852651642, 5554.2779438672715, 5697.886042279131, 5704.11586204139, 5704.77180912763, 5707.3721890592005, 5851.473367396912, 6930.5148639595245, 6943.6875340609795, 6948.930510694879, 6952.374286314256, 4390.934135987963, 4533.977330113328, 4536.410266665345, 4551.931721024187, 4554.203014472487, 7147.821304467378, 7307.6480851042725, 7338.853222935565, 7342.816429589249, 7343.008693826318, 4625.213713668684, 4634.21218392874, 4643.605293550018, 4645.349651048856, 4654.627629789608, 4691.272852707836, 4699.389079419653, 4700.741459219776, 4708.552687494683, 4710.222813235778, 5528.530074943595, 5551.5010947044075, 5561.443855614487, 5566.137248726453, 5570.442955704478, 6389.648569328639, 6522.608643481406, 6924.307569243136, 6938.236793952661, 7017.228104908456, 1525.6414742535496, 1606.9437569685006, 1634.730269505542, 1635.337688236266, 1637.1814092953523, 980.2207245240052, 991.5785791038779, 1033.4316126130598, 1033.6588925654517, 1056.2183983851894, 6382.36176382358, 6553.311902250291, 6561.409473147344, 6578.013298005338, 6580.0, 7296.854062918712, 7296.96351518239, 7299.854002919912, 7303.269673032761, 7303.926960730431, 5477.685355514727, 6560.671966401661, 6562.2453417856605, 6577.309382514863, 6581.934180658228, 3733.2346868891814, 3827.3302172119766, 3831.3869780834934, 3831.5402151741414, 3838.846446142179, 6544.887369147256, 7259.41924646027, 7338.522996005243, 7576.356009739234, 7585.0178656205935, 7464.962675186698, 7510.962445187739, 7512.511686740344, 7516.0, 7545.132309784445, 7613.695452181962, 7618.352440042548, 7628.732994345282, 7645.044369453818, 7669.808254793563, 6934.0, 7269.018682478009, 7270.745523906638, 7281.308275713799, 7301.926980730337, 6298.685065746786, 6639.6680165992475, 7045.823854403681, 7090.680919358744, 7098.041764361745, 7545.584992825227, 7567.205443428361, 7573.015507983927, 7577.431692623186, 7606.239376062349, 4577.29051996941, 4642.16441040616, 4650.186217411871, 4652.488226295037, 4664.580187783115, 6966.164060312795, 7225.855482890418, 7230.493865429369, 7236.457265704988, 7253.746118885813, 6950.270221626656, 6980.581165130108, 6980.616066116209, 6987.056747339044, 7002.124734408199, 6930.480213984072, 6967.0, 6974.860502789814, 6983.476239282176, 6996.545224560387, 6762.695678694569, 6771.424428923399, 6779.762708305186, 6786.728530858711, 6787.592744435349, 5694.886102278014, 5771.884562308815, 6778.830529236809, 6811.863762724619, 6822.215445223665, 6596.637184954873, 6753.628550429774, 6763.120794296907, 6861.588304701734, 6902.551334163263], "value": 5094.898886021575, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.6417416682076, 703.0579024107694, 726.7202127181034, 795.4670370851529, 799.4563696686253, 15481.0, 15827.97118187317, 15841.366345346201, 15849.0, 15858.36566537337, 14420.134791912493, 14630.707385852276, 14632.41470341185, 14632.926835365835, 14659.340329685163, 776.2315307845234, 794.7059587952466, 939.2673714502665, 976.4434272464698, 976.7851072764016, 965.8840939087285, 971.0871780526282, 971.7764914069768, 974.6832279509152, 976.6435251133356, 823.238504383446, 1028.8250997330435, 1031.3966329697137, 1033.8655974723276, 1034.260503739826, 747.3050063441025, 755.8488302339526, 825.2943733108197, 1025.0825511167538, 1043.5982146873432, 712.5535163617812, 727.9417646588313, 778.2101167315179, 779.5751315532991, 779.6842278877064, 15354.0, 15669.529914102595, 15714.371425143096, 15727.13500757458, 15729.606759831096, 13083.0, 13185.406656700376, 13322.933385333012, 13426.261555614437, 13496.527621533298, 10229.948850255776, 11192.216544841864, 11305.71735706614, 11531.711707207303, 11659.950604445641, 3595.496630471736, 3619.1856832212807, 3652.7077833773233, 3692.3538380783257, 3882.8835134946, 87152.12847871568, 88269.55865220632, 88272.55863720704, 89483.55258223732, 89490.10509894883, 9637.807243855084, 10038.698839034842, 10178.338408003456, 10373.948130259301, 10393.16854651626, 19881.807091574552, 23854.642180367307, 23913.402164946016, 23930.162444314366, 23963.7603623965, 7745.380369570421, 7749.0, 7810.1799311072655, 7819.452638315263, 8028.518288902685, 4202.2646036943415, 4293.313069908862, 4307.0, 4327.026419055687, 4597.678162528591, 3830.387138057953, 3901.31726947783, 3909.27678379495, 3918.941215881764, 3922.1763429680086, 585.7217821534737, 672.1732269308679, 673.2022553274288, 687.7833482453111, 692.8856738638068, 572.3332317849658, 587.2600523340622, 605.678990135229, 622.4304761143503, 657.1850904877917, 8121.422047424887, 8451.873221901677, 8468.703595374132, 8560.657573697106, 8564.400491965502, 532.321290354793, 566.6656672563125, 591.361329763854, 605.1890466774544, 618.0296933813959, 3837.3860182370686, 3957.5053118360206, 3986.2824691555797, 4016.618421250035, 4069.29253083099, 96925.5461168083, 96934.0, 98271.52592711116, 98308.03383932282, 98339.50830245802, 82215.3556928858, 82273.0, 82741.58629206815, 83304.16695832965, 84274.57862710647, 73449.2655073453, 73469.6326518364, 73637.26362736411, 73914.0, 74684.62657686677, 7609.239076092346, 7796.805079873048, 7912.446128770931, 8106.554139522383, 8192.877106843522, 45059.77470112628, 46004.0, 46309.536904631874, 46538.534614654774, 47279.76360118315, 57852.42147578639, 62253.443663908765, 62456.375436246875, 62842.0, 62946.370536295886, 10579.10077643409, 10620.84068738985, 10971.890281097087, 11358.659240222807, 11639.41802909868, 12012.579559715368, 12034.217775844541, 12116.394180290774, 12153.0, 12906.161099528501, 11628.825567616323, 11682.4742886572, 11699.707507312385, 12036.157468977437, 12161.635150945485, 10201.0, 11793.233439826385, 11883.405829708652, 12119.333436660716, 12270.263784172621, 11293.943530282297, 11883.821742673694, 11900.345480998629, 11953.94023029914, 11966.162368634112, 9615.711528654152, 9686.951565242129, 9950.357752804537, 10326.070653641209, 10336.741581460523, 9174.724758257264, 9565.952170239105, 9874.160696340892, 9898.010198980044, 9907.801843963225], "value": 7133.5527492518395, "unit": "score"}], "name": "dromaeo_css", "value": 7549.599929872491, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 120.0, 116.0, 161.0, 165.0, 113.0, 113.0, 113.0, 132.0], "value": 125.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 120.0, 144.0, 162.0, 124.0, 174.0, 167.0, 143.0, 166.0, 119.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 196.0, 258.0, 183.0, 183.0, 185.0, 185.0, 186.0, 185.0, 187.0], "value": 193.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 78.0, 74.0, 154.0, 55.0, 58.0, 58.0, 63.0, 135.0, 58.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 142.0, 80.0, 78.0, 81.0, 124.0, 79.0, 79.0, 126.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 86.0, 88.0, 86.0, 90.0, 87.0, 89.0, 85.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 98.0, 98.0, 94.0, 93.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 85.0, 105.0, 139.0, 71.0, 131.0, 131.0, 141.0, 85.0], "value": 105.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 63.0, 62.0, 64.0, 63.0, 62.0, 78.0, 61.0, 56.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 68.0, 66.0, 72.0, 69.0, 64.0, 64.0, 87.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 77.0, 78.0, 79.0, 77.0, 100.0, 108.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 123.0, 124.0, 144.0, 136.0, 117.0, 122.0, 126.0, 155.0, 143.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 162.0, 164.0, 160.0, 163.0, 162.0, 164.0, 175.0, 141.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 93.0, 94.0, 98.0, 96.0, 67.0, 67.0, 66.0, 65.0], "value": 78.3, "unit": "score"}], "name": "kraken", "value": 1516.6, "alertThreshold": 2.0}]} 09:12:08 INFO - Return code: 0 09:12:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:12:08 ERROR - # TBPL SUCCESS # 09:12:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:12:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:12:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:12:08 INFO - 2016-06-23 09:12:08.910 screenresolution[1680:9913] starting screenresolution argv=screenresolution get 09:12:08 INFO - 2016-06-23 09:12:08.913 screenresolution[1680:9913] Display 0: 1600x1200x32@60 09:12:08 INFO - 2016-06-23 09:12:08.919 screenresolution[1681:9916] starting screenresolution argv=screenresolution list 09:12:08 INFO - Available Modes on Display 0 09:12:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:12:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:12:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:12:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:12:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:12:09 INFO - Intel Iris: 09:12:09 INFO - Chipset Model: Intel Iris 09:12:09 INFO - Type: GPU 09:12:09 INFO - Bus: Built-In 09:12:09 INFO - VRAM (Dynamic, Max): 1536 MB 09:12:09 INFO - Vendor: Intel (0x8086) 09:12:09 INFO - Device ID: 0x0a2e 09:12:09 INFO - Revision ID: 0x0009 09:12:09 INFO - Displays: 09:12:09 INFO - Display: 09:12:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:12:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:12:09 INFO - Display Serial Number: 1600x1200 60 09:12:09 INFO - Main Display: Yes 09:12:09 INFO - Mirror: Off 09:12:09 INFO - Online: Yes 09:12:09 INFO - Rotation: Supported 09:12:09 INFO - Return code: 0 09:12:09 INFO - Running post-action listener: _resource_record_post_action 09:12:09 INFO - Running post-run listener: _resource_record_post_run 09:12:10 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 38069760; Write bytes: 494009344; Read time: 400; Write time: 1703 09:12:10 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 194468352; Write bytes: 187311616; Read time: 17709; Write time: 416 09:12:10 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 30998016; Write bytes: 295908864; Read time: 308; Write time: 1201 09:12:10 INFO - Running post-run listener: _upload_blobber_files 09:12:10 INFO - Blob upload gear active. 09:12:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:12:10 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 09:12:10 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'] 09:12:10 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 09:12:10 INFO - (blobuploader) - INFO - Open directory for files ... 09:12:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:12:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:12:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:11 INFO - (blobuploader) - INFO - Done attempting. 09:12:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:12:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:12:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:12 INFO - (blobuploader) - INFO - Done attempting. 09:12:12 INFO - (blobuploader) - INFO - Iteration through files over. 09:12:12 INFO - Return code: 0 09:12:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:12:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:12:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ce066c3e2bdeeb1ade5f8e0c4515d8b62c341136d652218270d0eee98ea23d66b839e8f38aebb16aa670e4ca4c354f05d8acc8d9b52b25df676a2e1f344e324c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5134ac0390712a53ab854505b71fb9752cd09d3ce52e2cc0fec8b3869a01edbc9bfa86b51e29d99b82b6c1cb6463b19a6cd590a53dbd9a5a4a6e8109eabd3911"} 09:12:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:12:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:12:12 INFO - Contents: 09:12:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ce066c3e2bdeeb1ade5f8e0c4515d8b62c341136d652218270d0eee98ea23d66b839e8f38aebb16aa670e4ca4c354f05d8acc8d9b52b25df676a2e1f344e324c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5134ac0390712a53ab854505b71fb9752cd09d3ce52e2cc0fec8b3869a01edbc9bfa86b51e29d99b82b6c1cb6463b19a6cd590a53dbd9a5a4a6e8109eabd3911"} 09:12:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:12:12 INFO - Copying logs to upload dir... 09:12:12 INFO - mkdir: /builds/slave/test/build/upload/logs 09:12:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.120887 ========= master_lag: 0.50 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-23 09:12:12.731531) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 09:12:12.735443) ========= 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.kmTo8IZecM/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.RQNfeAQX49/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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/ce066c3e2bdeeb1ade5f8e0c4515d8b62c341136d652218270d0eee98ea23d66b839e8f38aebb16aa670e4ca4c354f05d8acc8d9b52b25df676a2e1f344e324c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5134ac0390712a53ab854505b71fb9752cd09d3ce52e2cc0fec8b3869a01edbc9bfa86b51e29d99b82b6c1cb6463b19a6cd590a53dbd9a5a4a6e8109eabd3911"} build_url:https://queue.taskcluster.net/v1/task/GU4-UeugQUWqtmm6TC6AMw/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010651 build_url: 'https://queue.taskcluster.net/v1/task/GU4-UeugQUWqtmm6TC6AMw/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/ce066c3e2bdeeb1ade5f8e0c4515d8b62c341136d652218270d0eee98ea23d66b839e8f38aebb16aa670e4ca4c354f05d8acc8d9b52b25df676a2e1f344e324c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5134ac0390712a53ab854505b71fb9752cd09d3ce52e2cc0fec8b3869a01edbc9bfa86b51e29d99b82b6c1cb6463b19a6cd590a53dbd9a5a4a6e8109eabd3911"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 09:12:12.783653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:12:12.783987) ========= 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.kmTo8IZecM/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.RQNfeAQX49/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.005092 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:12:12.832624) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 09:12:12.832921) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 09:12:12.833231) ========= ========= Total master_lag: 0.64 =========