builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0061 starttime: 1463507744.69 results: success (0) buildid: 20160516203739 builduid: 35109f84dca34c5782941e77d47db877 revision: b9598d922a0ba3957d4cf178a03b877d76354fb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.688399) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.688985) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.689256) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.734920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.735189) ========= 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.wVsJLkgye3/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.VLetf35g4g/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-05-17 10:55:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 173M=0s 2016-05-17 10:55:45 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.716777 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:45.476734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:45.477021) ========= 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.wVsJLkgye3/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.VLetf35g4g/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.026536 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:45.563110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 10:55:45.563430) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b9598d922a0ba3957d4cf178a03b877d76354fb1 --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 b9598d922a0ba3957d4cf178a03b877d76354fb1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wVsJLkgye3/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.VLetf35g4g/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-05-17 10:55:45,571 truncating revision to first 12 chars 2016-05-17 10:55:45,571 Setting DEBUG logging. 2016-05-17 10:55:45,571 attempt 1/10 2016-05-17 10:55:45,571 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b9598d922a0b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 10:55:46,626 unpacking tar archive at: mozilla-beta-b9598d922a0b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.304958 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 10:55:46.889315) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:46.889583) ========= script_repo_revision: b9598d922a0ba3957d4cf178a03b877d76354fb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:46.889945) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:46.890208) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:46.918021) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-05-17 10:55:46.918274) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.wVsJLkgye3/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.VLetf35g4g/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:55:47 INFO - MultiFileLogger online at 20160517 10:55:47 in /builds/slave/test 10:55:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:55:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:55:47 INFO - {'append_to_log': False, 10:55:47 INFO - 'base_work_dir': '/builds/slave/test', 10:55:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:55:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:55:47 INFO - 'branch': 'Mozilla-Beta', 10:55:47 INFO - 'buildbot_json_path': 'buildprops.json', 10:55:47 INFO - 'config_files': ('talos/mac_config.py',), 10:55:47 INFO - 'default_actions': ('clobber', 10:55:47 INFO - 'read-buildbot-config', 10:55:47 INFO - 'download-and-extract', 10:55:47 INFO - 'populate-webroot', 10:55:47 INFO - 'create-virtualenv', 10:55:47 INFO - 'install', 10:55:47 INFO - 'run-tests'), 10:55:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:55:47 INFO - 'download_minidump_stackwalk': True, 10:55:47 INFO - 'download_symbols': 'ondemand', 10:55:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:55:47 INFO - 'tooltool.py': '/tools/tooltool.py', 10:55:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:55:47 INFO - '/tools/misc-python/virtualenv.py')}, 10:55:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:55:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:55:47 INFO - 'installer_path': 'installer.exe', 10:55:47 INFO - 'log_level': 'info', 10:55:47 INFO - 'log_name': 'talos', 10:55:47 INFO - 'log_to_console': True, 10:55:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:55:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:55:47 INFO - 'opt_config_files': (), 10:55:47 INFO - 'pip_index': False, 10:55:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:55:47 INFO - 'cmd': ('bash', 10:55:47 INFO - '-c', 10:55:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:55:47 INFO - 'enabled': True, 10:55:47 INFO - 'halt_on_failure': False, 10:55:47 INFO - 'name': 'check_screen_resolution'},), 10:55:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:55:47 INFO - 'cmd': ('bash', 10:55:47 INFO - '-c', 10:55:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:55:47 INFO - 'enabled': True, 10:55:47 INFO - 'halt_on_failure': False, 10:55:47 INFO - 'name': 'check_screen_resolution'},), 10:55:47 INFO - 'run_cmd_checks_enabled': True, 10:55:47 INFO - 'sps_profile': False, 10:55:47 INFO - 'sps_profile_interval': 0, 10:55:47 INFO - 'suite': 'dromaeojs-e10s', 10:55:47 INFO - 'system_bits': '32', 10:55:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:55:47 INFO - 'title': 't-yosemite-r7-0061', 10:55:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:55:47 INFO - 'use_talos_json': True, 10:55:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:55:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:55:47 INFO - 'work_dir': 'build'} 10:55:47 INFO - ##### 10:55:47 INFO - ##### Running clobber step. 10:55:47 INFO - ##### 10:55:47 INFO - Running pre-action listener: _resource_record_pre_action 10:55:47 INFO - Running main action method: clobber 10:55:47 INFO - rmtree: /builds/slave/test/build 10:55:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:55:48 INFO - Running post-action listener: _resource_record_post_action 10:55:48 INFO - ##### 10:55:48 INFO - ##### Running read-buildbot-config step. 10:55:48 INFO - ##### 10:55:48 INFO - Running pre-action listener: _resource_record_pre_action 10:55:48 INFO - Running main action method: read_buildbot_config 10:55:48 INFO - Using buildbot properties: 10:55:48 INFO - { 10:55:48 INFO - "project": "", 10:55:48 INFO - "product": "firefox", 10:55:48 INFO - "script_repo_revision": "production", 10:55:48 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 10:55:48 INFO - "repository": "", 10:55:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 10:55:48 INFO - "buildid": "20160516203739", 10:55:48 INFO - "pgo_build": "False", 10:55:48 INFO - "basedir": "/builds/slave/test", 10:55:48 INFO - "buildnumber": 29, 10:55:48 INFO - "slavename": "t-yosemite-r7-0061", 10:55:48 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:55:48 INFO - "platform": "yosemite_r7", 10:55:48 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:55:48 INFO - "branch": "mozilla-beta", 10:55:48 INFO - "repo_path": "releases/mozilla-beta", 10:55:48 INFO - "revision": "b9598d922a0ba3957d4cf178a03b877d76354fb1", 10:55:48 INFO - "stage_platform": "macosx64", 10:55:48 INFO - "builduid": "35109f84dca34c5782941e77d47db877", 10:55:48 INFO - "slavebuilddir": "test" 10:55:48 INFO - } 10:55:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 10:55:48 INFO - Running post-action listener: _resource_record_post_action 10:55:48 INFO - ##### 10:55:48 INFO - ##### Running download-and-extract step. 10:55:48 INFO - ##### 10:55:48 INFO - Running pre-action listener: _resource_record_pre_action 10:55:48 INFO - Running main action method: download_and_extract 10:55:48 INFO - mkdir: /builds/slave/test/build/tests 10:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:48 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:55:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:55:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:55:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:55:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 10:55:52 INFO - Downloaded 1241 bytes. 10:55:52 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:55:52 INFO - Using the following test package requirements: 10:55:52 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:55:52 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:55:52 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 10:55:52 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:55:52 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 10:55:52 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:55:52 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:55:52 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 10:55:52 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:55:52 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:55:52 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 10:55:52 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:55:52 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 10:55:52 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:55:52 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 10:55:52 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:55:52 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:55:52 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 10:55:52 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 10:55:52 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')]} 10:55:52 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:55:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:55:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:55:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 10:55:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 10:56:00 INFO - Downloaded 17747789 bytes. 10:56:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:56:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:56:03 INFO - Return code: 0 10:56:03 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:03 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:56:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:56:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:56:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 10:56:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 10:56:08 INFO - Downloaded 17747789 bytes. 10:56:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:56:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:56:12 INFO - Return code: 0 10:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:12 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:56:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:56:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:56:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 10:56:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 10:56:13 INFO - Downloaded 10845194 bytes. 10:56:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:56:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:56:13 INFO - Return code: 0 10:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:13 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 10:56:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:56:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:56:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 10:56:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 10:56:17 INFO - Downloaded 88288778 bytes. 10:56:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:56:17 INFO - mkdir: /builds/slave/test/properties 10:56:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:56:17 INFO - Writing to file /builds/slave/test/properties/build_url 10:56:17 INFO - Contents: 10:56:17 INFO - build_url:https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:56:17 WARNING - Can't figure out symbols_url from installer_url: https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg! 10:56:17 INFO - Running post-action listener: _resource_record_post_action 10:56:17 INFO - Running post-action listener: set_extra_try_arguments 10:56:17 INFO - ##### 10:56:17 INFO - ##### Running populate-webroot step. 10:56:17 INFO - ##### 10:56:17 INFO - Running pre-action listener: _resource_record_pre_action 10:56:17 INFO - Running main action method: populate_webroot 10:56:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:56:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:56:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:56:17 INFO - '--tppagecycles', 10:56:17 INFO - '7'], 10:56:17 INFO - 'tests': ['tsvgm']}}, 10:56:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:56:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:56:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:56:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:56:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:56:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:56:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:17 INFO - 'talos_options': ['--e10s'], 10:56:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:17 INFO - 'tests': ['damp', 'tps']}, 10:56:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:17 INFO - 'talos_options': ['--e10s'], 10:56:17 INFO - 'tests': ['damp', 'tps']}, 10:56:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:56:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:56:17 INFO - 'other': {'tests': ['a11yr', 10:56:17 INFO - 'ts_paint', 10:56:17 INFO - 'tpaint', 10:56:17 INFO - 'sessionrestore', 10:56:17 INFO - 'sessionrestore_no_auto_restore', 10:56:17 INFO - 'tabpaint']}, 10:56:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:56:17 INFO - 'tests': ['a11yr', 10:56:17 INFO - 'ts_paint', 10:56:17 INFO - 'tpaint', 10:56:17 INFO - 'sessionrestore', 10:56:17 INFO - 'sessionrestore_no_auto_restore', 10:56:17 INFO - 'tabpaint']}, 10:56:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:56:17 INFO - 'tests': ['a11yr', 10:56:17 INFO - 'ts_paint', 10:56:17 INFO - 'tpaint', 10:56:17 INFO - 'sessionrestore', 10:56:17 INFO - 'sessionrestore_no_auto_restore', 10:56:17 INFO - 'tabpaint']}, 10:56:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:56:17 INFO - 'tests': ['a11yr', 10:56:17 INFO - 'ts_paint', 10:56:17 INFO - 'tpaint', 10:56:17 INFO - 'sessionrestore', 10:56:17 INFO - 'sessionrestore_no_auto_restore', 10:56:17 INFO - 'tabpaint']}, 10:56:17 INFO - 'other_l64': {'tests': ['a11yr', 10:56:17 INFO - 'ts_paint', 10:56:17 INFO - 'tpaint', 10:56:17 INFO - 'sessionrestore', 10:56:17 INFO - 'sessionrestore_no_auto_restore', 10:56:17 INFO - 'tabpaint']}, 10:56:17 INFO - 'other_nol64': {'tests': ['a11yr', 10:56:17 INFO - 'ts_paint', 10:56:17 INFO - 'tpaint', 10:56:17 INFO - 'sessionrestore', 10:56:17 INFO - 'sessionrestore_no_auto_restore', 10:56:17 INFO - 'tabpaint']}, 10:56:17 INFO - 'svgr': {'tests': ['tsvgx', 10:56:17 INFO - 'tsvgr_opacity', 10:56:17 INFO - 'tart', 10:56:17 INFO - 'tscrollx', 10:56:17 INFO - 'cart']}, 10:56:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:56:17 INFO - 'tests': ['tsvgx', 10:56:17 INFO - 'tsvgr_opacity', 10:56:17 INFO - 'tart', 10:56:17 INFO - 'tscrollx', 10:56:17 INFO - 'cart']}, 10:56:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:17 INFO - 'tests': ['tp5o']}, 10:56:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:17 INFO - 'talos_options': ['--e10s'], 10:56:17 INFO - 'tests': ['tp5o']}, 10:56:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:17 INFO - 'talos_options': ['--xperf_path', 10:56:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:17 INFO - 'tests': ['tp5n']}, 10:56:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:17 INFO - 'talos_options': ['--e10s', 10:56:17 INFO - '--xperf_path', 10:56:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:17 INFO - 'tests': ['tp5n']}}, 10:56:17 INFO - 'talos.zip': {'path': '', 10:56:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:56:17 INFO - Running post-action listener: _resource_record_post_action 10:56:17 INFO - ##### 10:56:17 INFO - ##### Running create-virtualenv step. 10:56:17 INFO - ##### 10:56:17 INFO - Running pre-action listener: _resource_record_pre_action 10:56:17 INFO - Running main action method: create_virtualenv 10:56:17 INFO - Creating virtualenv /builds/slave/test/build/venv 10:56:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:56:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:56:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:56:17 INFO - Using real prefix '/tools/python27' 10:56:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:56:18 INFO - Installing distribute.............................................................................................................................................................................................done. 10:56:21 INFO - Installing pip.................done. 10:56:21 INFO - Return code: 0 10:56:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100efaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f014c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c01cc1430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9ed30>, '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 0x100c02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d95b20>, '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.wVsJLkgye3/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.VLetf35g4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:56:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:56:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wVsJLkgye3/Render', 10:56:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:21 INFO - 'HOME': '/Users/cltbld', 10:56:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:21 INFO - 'LOGNAME': 'cltbld', 10:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:21 INFO - 'MOZ_NO_REMOTE': '1', 10:56:21 INFO - 'NO_EM_RESTART': '1', 10:56:21 INFO - 'PAGER': '/bin/cat', 10:56:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:21 INFO - 'PWD': '/builds/slave/test', 10:56:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:21 INFO - 'SHELL': '/bin/bash', 10:56:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VLetf35g4g/Listeners', 10:56:21 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:56:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:21 INFO - 'USER': 'cltbld', 10:56:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:21 INFO - 'XPC_FLAGS': '0x0', 10:56:21 INFO - 'XPC_SERVICE_NAME': '0', 10:56:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:56:21 INFO - Cleaning up... 10:56:21 INFO - Return code: 0 10:56:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100efaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f014c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c01cc1430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9ed30>, '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 0x100c02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d95b20>, '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.wVsJLkgye3/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.VLetf35g4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:56:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:56:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wVsJLkgye3/Render', 10:56:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:21 INFO - 'HOME': '/Users/cltbld', 10:56:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:21 INFO - 'LOGNAME': 'cltbld', 10:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:21 INFO - 'MOZ_NO_REMOTE': '1', 10:56:21 INFO - 'NO_EM_RESTART': '1', 10:56:21 INFO - 'PAGER': '/bin/cat', 10:56:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:21 INFO - 'PWD': '/builds/slave/test', 10:56:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:21 INFO - 'SHELL': '/bin/bash', 10:56:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VLetf35g4g/Listeners', 10:56:21 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:56:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:21 INFO - 'USER': 'cltbld', 10:56:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:21 INFO - 'XPC_FLAGS': '0x0', 10:56:21 INFO - 'XPC_SERVICE_NAME': '0', 10:56:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:22 INFO - Downloading/unpacking psutil>=0.7.1 10:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:56:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:25 INFO - Installing collected packages: psutil 10:56:25 INFO - Running setup.py install for psutil 10:56:25 INFO - building 'psutil._psutil_osx' extension 10:56:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:56:26 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 10:56:26 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 10:56:26 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 10:56:26 INFO - building 'psutil._psutil_posix' extension 10:56:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:56:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:56:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:56:26 INFO - ^ 10:56:26 INFO - 1 warning generated. 10:56:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:56:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:26 INFO - Successfully installed psutil 10:56:26 INFO - Cleaning up... 10:56:26 INFO - Return code: 0 10:56:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100efaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f014c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c01cc1430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9ed30>, '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 0x100c02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d95b20>, '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.wVsJLkgye3/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.VLetf35g4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:56:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wVsJLkgye3/Render', 10:56:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:26 INFO - 'HOME': '/Users/cltbld', 10:56:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:26 INFO - 'LOGNAME': 'cltbld', 10:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:26 INFO - 'MOZ_NO_REMOTE': '1', 10:56:26 INFO - 'NO_EM_RESTART': '1', 10:56:26 INFO - 'PAGER': '/bin/cat', 10:56:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:26 INFO - 'PWD': '/builds/slave/test', 10:56:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:26 INFO - 'SHELL': '/bin/bash', 10:56:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VLetf35g4g/Listeners', 10:56:26 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:56:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:26 INFO - 'USER': 'cltbld', 10:56:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:26 INFO - 'XPC_FLAGS': '0x0', 10:56:26 INFO - 'XPC_SERVICE_NAME': '0', 10:56:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:56:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:56:29 INFO - Installing collected packages: mozsystemmonitor 10:56:29 INFO - Running setup.py install for mozsystemmonitor 10:56:29 INFO - Successfully installed mozsystemmonitor 10:56:29 INFO - Cleaning up... 10:56:29 INFO - Return code: 0 10:56:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100efaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f014c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c01cc1430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9ed30>, '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 0x100c02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d95b20>, '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.wVsJLkgye3/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.VLetf35g4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:56:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wVsJLkgye3/Render', 10:56:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:29 INFO - 'HOME': '/Users/cltbld', 10:56:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:29 INFO - 'LOGNAME': 'cltbld', 10:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:29 INFO - 'MOZ_NO_REMOTE': '1', 10:56:29 INFO - 'NO_EM_RESTART': '1', 10:56:29 INFO - 'PAGER': '/bin/cat', 10:56:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:29 INFO - 'PWD': '/builds/slave/test', 10:56:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:29 INFO - 'SHELL': '/bin/bash', 10:56:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VLetf35g4g/Listeners', 10:56:29 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:56:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:29 INFO - 'USER': 'cltbld', 10:56:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:29 INFO - 'XPC_FLAGS': '0x0', 10:56:29 INFO - 'XPC_SERVICE_NAME': '0', 10:56:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:30 INFO - Downloading/unpacking blobuploader==1.2.4 10:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:32 INFO - Downloading blobuploader-1.2.4.tar.gz 10:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:56:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:56:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:56:33 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 10:56:33 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 10:56:33 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 10:56:33 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 10:56:33 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 10:56:33 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 10:56:33 INFO - Downloading docopt-0.6.1.tar.gz 10:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:56:33 INFO - Installing collected packages: blobuploader, requests, docopt 10:56:33 INFO - Running setup.py install for blobuploader 10:56:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:56:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:56:33 INFO - Running setup.py install for requests 10:56:34 INFO - Running setup.py install for docopt 10:56:34 INFO - Successfully installed blobuploader requests docopt 10:56:34 INFO - Cleaning up... 10:56:34 INFO - Return code: 0 10:56:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:56: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')]} 10:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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')]} 10:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100efaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f014c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c01cc1430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9ed30>, '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 0x100c02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d95b20>, '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.wVsJLkgye3/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.VLetf35g4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:56:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wVsJLkgye3/Render', 10:56:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:34 INFO - 'HOME': '/Users/cltbld', 10:56:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:34 INFO - 'LOGNAME': 'cltbld', 10:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:34 INFO - 'MOZ_NO_REMOTE': '1', 10:56:34 INFO - 'NO_EM_RESTART': '1', 10:56:34 INFO - 'PAGER': '/bin/cat', 10:56:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:34 INFO - 'PWD': '/builds/slave/test', 10:56:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:34 INFO - 'SHELL': '/bin/bash', 10:56:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VLetf35g4g/Listeners', 10:56:34 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:56:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:34 INFO - 'USER': 'cltbld', 10:56:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:34 INFO - 'XPC_FLAGS': '0x0', 10:56:34 INFO - 'XPC_SERVICE_NAME': '0', 10:56:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:56:34 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-nYCuKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:56:34 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-YB1XXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:56:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-mKXWwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:56:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-QNaKj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:56:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-fPiIqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:56:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-S0lykO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:56:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-lQSbTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:56:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-T7vdps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:56:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-0InOFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:56:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-K17hn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:56:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-w2A8fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:56:36 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-IYutUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:56:36 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-RdGsmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:56:36 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-kpeCbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:36 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-oPwW97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:56:36 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-GMwLp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:56:36 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-FeHMh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:56:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:56:36 INFO - Running setup.py install for manifestparser 10:56:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:56:36 INFO - Running setup.py install for mozcrash 10:56:36 INFO - Running setup.py install for mozdebug 10:56:37 INFO - Running setup.py install for mozdevice 10:56:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:56:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:56:37 INFO - Running setup.py install for mozfile 10:56:37 INFO - Running setup.py install for mozhttpd 10:56:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:56:37 INFO - Running setup.py install for mozinfo 10:56:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:56:37 INFO - Running setup.py install for mozInstall 10:56:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:56:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:56:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:56:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:56:37 INFO - Running setup.py install for mozleak 10:56:37 INFO - Running setup.py install for mozlog 10:56:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:56:38 INFO - Running setup.py install for moznetwork 10:56:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:56:38 INFO - Running setup.py install for mozprocess 10:56:38 INFO - Running setup.py install for mozprofile 10:56:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:56:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:56:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:56:38 INFO - Running setup.py install for mozrunner 10:56:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:56:38 INFO - Running setup.py install for mozscreenshot 10:56:38 INFO - Running setup.py install for moztest 10:56:39 INFO - Running setup.py install for mozversion 10:56:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:56:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:56:39 INFO - Cleaning up... 10:56:39 INFO - Return code: 0 10:56:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:56:39 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')]} 10:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:39 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')]} 10:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:39 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 0x100efaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f014c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c01cc1430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9ed30>, '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 0x100c02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d95b20>, '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.wVsJLkgye3/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.VLetf35g4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:56:39 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 10:56:39 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 10:56:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wVsJLkgye3/Render', 10:56:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:39 INFO - 'HOME': '/Users/cltbld', 10:56:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:39 INFO - 'LOGNAME': 'cltbld', 10:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:39 INFO - 'MOZ_NO_REMOTE': '1', 10:56:39 INFO - 'NO_EM_RESTART': '1', 10:56:39 INFO - 'PAGER': '/bin/cat', 10:56:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:39 INFO - 'PWD': '/builds/slave/test', 10:56:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:39 INFO - 'SHELL': '/bin/bash', 10:56:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VLetf35g4g/Listeners', 10:56:39 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:56:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:39 INFO - 'USER': 'cltbld', 10:56:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:39 INFO - 'XPC_FLAGS': '0x0', 10:56:39 INFO - 'XPC_SERVICE_NAME': '0', 10:56:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:56:39 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-HdyM7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:56:39 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-052VKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:56:39 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-IWYAms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:56:39 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-SHfTkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:56:39 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-x9uutN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:56:40 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ItAezN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:56:40 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)) 10:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:56:40 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-SbvKdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:56:40 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)) 10:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:56:40 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-voysCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:56:40 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)) 10:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:56:40 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Otw8bK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:56:40 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)) 10:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:56:40 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-aaMlvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:56:40 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-1jr5co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:56:40 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ErmpH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:56:40 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-5ZKDyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:56:40 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-5_5JQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:40 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-l49n6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:41 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)) 10:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:56:41 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-S78caK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:56:41 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)) 10:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:56:41 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-UptE0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:56:41 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)) 10:56:41 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)) 10:56:41 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)) 10:56:41 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)) 10:56:41 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)) 10:56:41 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)) 10:56:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:56:41 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 10:56:41 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 10:56:41 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 10:56:41 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 10:56:41 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 10:56:41 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 10:56:43 INFO - Downloading blessings-1.6.tar.gz 10:56:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:56:43 INFO - Installing collected packages: blessings 10:56:43 INFO - Running setup.py install for blessings 10:56:43 INFO - Successfully installed blessings 10:56:43 INFO - Cleaning up... 10:56:44 INFO - Return code: 0 10:56:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:56:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:56:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:56:44 INFO - Reading from file tmpfile_stdout 10:56:44 INFO - Current package versions: 10:56:44 INFO - blessings == 1.6 10:56:44 INFO - blobuploader == 1.2.4 10:56:44 INFO - docopt == 0.6.1 10:56:44 INFO - manifestparser == 1.1 10:56:44 INFO - mozInstall == 1.12 10:56:44 INFO - mozcrash == 0.17 10:56:44 INFO - mozdebug == 0.1 10:56:44 INFO - mozdevice == 0.48 10:56:44 INFO - mozfile == 1.2 10:56:44 INFO - mozhttpd == 0.7 10:56:44 INFO - mozinfo == 0.9 10:56:44 INFO - mozleak == 0.1 10:56:44 INFO - mozlog == 3.1 10:56:44 INFO - moznetwork == 0.27 10:56:44 INFO - mozprocess == 0.22 10:56:44 INFO - mozprofile == 0.28 10:56:44 INFO - mozrunner == 6.11 10:56:44 INFO - mozscreenshot == 0.1 10:56:44 INFO - mozsystemmonitor == 0.0 10:56:44 INFO - moztest == 0.7 10:56:44 INFO - mozversion == 1.4 10:56:44 INFO - psutil == 3.1.1 10:56:44 INFO - requests == 1.2.3 10:56:44 INFO - wsgiref == 0.1.2 10:56:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:44 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 0x100efaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f014c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c01cc1430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9ed30>, '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 0x100c02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d95b20>, '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.wVsJLkgye3/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.VLetf35g4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:56:44 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 10:56:44 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 10:56:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wVsJLkgye3/Render', 10:56:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:44 INFO - 'HOME': '/Users/cltbld', 10:56:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:44 INFO - 'LOGNAME': 'cltbld', 10:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:44 INFO - 'MOZ_NO_REMOTE': '1', 10:56:44 INFO - 'NO_EM_RESTART': '1', 10:56:44 INFO - 'PAGER': '/bin/cat', 10:56:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:44 INFO - 'PWD': '/builds/slave/test', 10:56:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:44 INFO - 'SHELL': '/bin/bash', 10:56:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VLetf35g4g/Listeners', 10:56:44 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:56:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:44 INFO - 'USER': 'cltbld', 10:56:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:44 INFO - 'XPC_FLAGS': '0x0', 10:56:44 INFO - 'XPC_SERVICE_NAME': '0', 10:56:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:44 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)) 10:56:44 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)) 10:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:56:44 INFO - Cleaning up... 10:56:44 INFO - Return code: 0 10:56:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100efaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f014c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c01cc1430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9ed30>, '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 0x100c02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d95b20>, '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.wVsJLkgye3/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.VLetf35g4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:56:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:56:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:56:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wVsJLkgye3/Render', 10:56:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:44 INFO - 'HOME': '/Users/cltbld', 10:56:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:44 INFO - 'LOGNAME': 'cltbld', 10:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:44 INFO - 'MOZ_NO_REMOTE': '1', 10:56:44 INFO - 'NO_EM_RESTART': '1', 10:56:44 INFO - 'PAGER': '/bin/cat', 10:56:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:44 INFO - 'PWD': '/builds/slave/test', 10:56:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:44 INFO - 'SHELL': '/bin/bash', 10:56:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VLetf35g4g/Listeners', 10:56:44 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:56:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:44 INFO - 'USER': 'cltbld', 10:56:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:44 INFO - 'XPC_FLAGS': '0x0', 10:56:44 INFO - 'XPC_SERVICE_NAME': '0', 10:56:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:44 INFO - Downloading/unpacking jsonschema 10:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:56:47 INFO - Downloading/unpacking functools32 (from jsonschema) 10:56: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 10:56: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 10:56: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 10:56: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 10:56: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 10:56: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 10:56:47 INFO - Downloading functools32-3.2.3-2.tar.gz 10:56:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:56:47 INFO - warning: no files found matching '*.txt' 10:56:47 INFO - no previously-included directories found matching 'build' 10:56:47 INFO - no previously-included directories found matching 'dist' 10:56:47 INFO - no previously-included directories found matching '.git*' 10:56:47 INFO - Installing collected packages: jsonschema, functools32 10:56:47 INFO - Running setup.py install for functools32 10:56:48 INFO - warning: no files found matching '*.txt' 10:56:48 INFO - no previously-included directories found matching 'build' 10:56:48 INFO - no previously-included directories found matching 'dist' 10:56:48 INFO - no previously-included directories found matching '.git*' 10:56:48 INFO - Successfully installed jsonschema functools32 10:56:48 INFO - Cleaning up... 10:56:48 INFO - Return code: 0 10:56:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:48 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 0x100efaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f014c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c01cc1430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d9ed30>, '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 0x100c02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d95b20>, '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.wVsJLkgye3/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.VLetf35g4g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:56:48 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 10:56:48 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 10:56:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wVsJLkgye3/Render', 10:56:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:48 INFO - 'HOME': '/Users/cltbld', 10:56:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:48 INFO - 'LOGNAME': 'cltbld', 10:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:48 INFO - 'MOZ_NO_REMOTE': '1', 10:56:48 INFO - 'NO_EM_RESTART': '1', 10:56:48 INFO - 'PAGER': '/bin/cat', 10:56:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:48 INFO - 'PWD': '/builds/slave/test', 10:56:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:48 INFO - 'SHELL': '/bin/bash', 10:56:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VLetf35g4g/Listeners', 10:56:48 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:56:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:48 INFO - 'USER': 'cltbld', 10:56:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:48 INFO - 'XPC_FLAGS': '0x0', 10:56:48 INFO - 'XPC_SERVICE_NAME': '0', 10:56:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:48 INFO - Downloading/unpacking flake8 10:56:48 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 10:56:48 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 10:56:48 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 10:56:48 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 10:56:48 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 10:56:48 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 10:56:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:56:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:56: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 10:56: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 10:56: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 10:56: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 10:56: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 10:56: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 10:56:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:56:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:56:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:56:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:56:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:56:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:56:52 INFO - no previously-included directories found matching 'docs/_build' 10:56:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:56:52 INFO - Running setup.py install for pep8 10:56:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:56:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:56:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:56:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:56:52 INFO - no previously-included directories found matching 'docs/_build' 10:56:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:56:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:56:52 INFO - Cleaning up... 10:56:52 INFO - Return code: 0 10:56:52 INFO - Running post-action listener: _resource_record_post_action 10:56:52 INFO - Running post-action listener: _start_resource_monitoring 10:56:52 INFO - Starting resource monitoring. 10:56:52 INFO - ##### 10:56:52 INFO - ##### Running install step. 10:56:52 INFO - ##### 10:56:52 INFO - Running pre-action listener: _resource_record_pre_action 10:56:52 INFO - Running main action method: install 10:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:56:52 INFO - Reading from file tmpfile_stdout 10:56:52 INFO - Detecting whether we're running mozinstall >=1.0... 10:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:56:52 INFO - Reading from file tmpfile_stdout 10:56:52 INFO - Output received: 10:56:52 INFO - Usage: mozinstall [options] installer 10:56:52 INFO - Options: 10:56:52 INFO - -h, --help show this help message and exit 10:56:52 INFO - -d DEST, --destination=DEST 10:56:52 INFO - Directory to install application into. [default: 10:56:52 INFO - "/builds/slave/test"] 10:56:52 INFO - --app=APP Application being installed. [default: firefox] 10:56:52 INFO - mkdir: /builds/slave/test/build/application 10:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:57:15 INFO - Reading from file tmpfile_stdout 10:57:15 INFO - Output received: 10:57:15 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:57:15 INFO - Running post-action listener: _resource_record_post_action 10:57:15 INFO - ##### 10:57:15 INFO - ##### Running run-tests step. 10:57:15 INFO - ##### 10:57:15 INFO - Running pre-action listener: _resource_record_pre_action 10:57:15 INFO - Running main action method: run_tests 10:57:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:57:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:57:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:57:15 INFO - 2016-05-17 10:57:15.146 screenresolution[1651:9008] starting screenresolution argv=screenresolution get 10:57:15 INFO - 2016-05-17 10:57:15.148 screenresolution[1651:9008] Display 0: 1600x1200x32@60 10:57:15 INFO - 2016-05-17 10:57:15.154 screenresolution[1652:9010] starting screenresolution argv=screenresolution list 10:57:15 INFO - Available Modes on Display 0 10:57:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:57:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:57:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:57:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:57:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:57:15 INFO - Intel Iris: 10:57:15 INFO - Chipset Model: Intel Iris 10:57:15 INFO - Type: GPU 10:57:15 INFO - Bus: Built-In 10:57:15 INFO - VRAM (Dynamic, Max): 1536 MB 10:57:15 INFO - Vendor: Intel (0x8086) 10:57:15 INFO - Device ID: 0x0a2e 10:57:15 INFO - Revision ID: 0x0009 10:57:15 INFO - Displays: 10:57:15 INFO - Display: 10:57:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:57:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:57:15 INFO - Display Serial Number: 1600x1200 60 10:57:15 INFO - Main Display: Yes 10:57:15 INFO - Mirror: Off 10:57:15 INFO - Online: Yes 10:57:15 INFO - Rotation: Supported 10:57:15 INFO - Return code: 0 10:57:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:57:15 INFO - Python 2.7.3 10:57:15 INFO - Return code: 0 10:57:15 INFO - grabbing minidump binary from tooltool 10:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:15 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 0x100d9ed30>, '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 0x100c02db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d95b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:57:15 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 10:57:15 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 10:57:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:57:15 INFO - Return code: 0 10:57:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:57:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:57:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:57:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:57:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:57:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:57:16 INFO - Return code: 0 10:57:16 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-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--title', 't-yosemite-r7-0061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:57:16 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-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --title t-yosemite-r7-0061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:57:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wVsJLkgye3/Render', 10:57:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:16 INFO - 'HOME': '/Users/cltbld', 10:57:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:16 INFO - 'LOGNAME': 'cltbld', 10:57:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:57:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:16 INFO - 'MOZ_NO_REMOTE': '1', 10:57:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:57:16 INFO - 'NO_EM_RESTART': '1', 10:57:16 INFO - 'PAGER': '/bin/cat', 10:57:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:16 INFO - 'PWD': '/builds/slave/test', 10:57:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:57:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:16 INFO - 'SHELL': '/bin/bash', 10:57:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VLetf35g4g/Listeners', 10:57:16 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:57:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:16 INFO - 'USER': 'cltbld', 10:57:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:16 INFO - 'XPC_FLAGS': '0x0', 10:57:16 INFO - 'XPC_SERVICE_NAME': '0', 10:57:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--title', 't-yosemite-r7-0061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:57:16 INFO - mozversion application_buildid: 20160516203739 10:57:16 INFO - mozversion application_changeset: b9598d922a0ba3957d4cf178a03b877d76354fb1 10:57:16 INFO - mozversion application_display_name: Firefox 10:57:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:57:16 INFO - mozversion application_name: Firefox 10:57:16 INFO - mozversion application_remotingname: firefox 10:57:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:57:16 INFO - mozversion application_vendor: Mozilla 10:57:16 INFO - mozversion application_version: 47.0 10:57:16 INFO - mozversion platform_buildid: 20160516203739 10:57:16 INFO - mozversion platform_changeset: b9598d922a0ba3957d4cf178a03b877d76354fb1 10:57:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:57:16 INFO - mozversion platform_version: 47.0 10:57:16 INFO - using testdate: 1463507836 10:57:16 INFO - actual date: 1463507836 10:57:16 INFO - starting webserver on 'localhost:49276' 10:57:16 INFO - SUITE-START | Running 2 tests 10:57:16 INFO - TEST-START | dromaeo_css 10:57:16 INFO - operating with platform_type : mac_ 10:57:16 INFO - Initialising browser for dromaeo_css test... 10:57:16 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpMt7LB3/profile http://localhost:49276/getInfo.html) 10:57:19 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 10:57:19 INFO - PROCESS | 1670 | colorDepth:24 10:57:19 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 10:57:19 INFO - PROCESS | 1670 | __metrics 10:57:19 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 10:57:20 INFO - TEST-INFO | 1670: exit 0 10:57:20 INFO - Browser initialized. 10:57:20 INFO - Running cycle 1/1 for dromaeo_css test... 10:57:20 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpMt7LB3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:57:32 INFO - PROCESS | 1675 | RSS: Main: 167845888 10:57:32 INFO - PROCESS | 1675 | 10:58:21 INFO - PROCESS | 1675 | 1463507901928 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] 11:00:32 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 11:00:33 INFO - PROCESS | 1675 | RSS: Main: 181637120 11:00:33 INFO - PROCESS | 1675 | 11:03:35 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 11:03:36 INFO - PROCESS | 1675 | RSS: Main: 193388544 11:03:36 INFO - PROCESS | 1675 | 11:06:38 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 11:06:38 INFO - PROCESS | 1675 | RSS: Main: 195407872 11:06:38 INFO - PROCESS | 1675 | 11:09:40 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 11:09:41 INFO - PROCESS | 1675 | RSS: Main: 198508544 11:09:41 INFO - PROCESS | 1675 | 11:12:43 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 11:12:44 INFO - PROCESS | 1675 | RSS: Main: 197394432 11:12:44 INFO - PROCESS | 1675 | 11:15:46 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 11:15:46 INFO - PROCESS | 1675 | RSS: Main: 202866688 11:15:46 INFO - PROCESS | 1675 | 11:15:46 INFO - PROCESS | 1675 | __start_tp_report 11:15:46 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 11:15:46 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 11:15:46 INFO - PROCESS | 1675 | |i|pagename|runs| 11:15:46 INFO - PROCESS | 1675 | |0;dojo.html;3622.909427264318;3667.15655399258;3694.7783133012003;3709.2210635766487;3723.795191264481;4306.332518459636;5870.765169393229;5907.911381329278;5916.585838991272;5944.88110237795;4889.017699203492;5909.970450147754;5939.168516407695;5972.104184372335;5997.160397544348;5216.9478305216935;5319.760610772524;5340.786368545273;5356.517913387795;5361.169018802072;5213.817516386927;5319.468053194669;5354.544863686591;5379.946200537984;5424.267723857288;4314.503832059307;5190.377154741417;5322.0952438085615;5340.893182136355;5349.144136938091;5316.9202461963105;5329.307190065306;5379.488948549882;5383.892322153574;5435.293411856473;5207;5231.659942103789;5252.133397989365;5261.631685781997;5308.734563271821;5641.294838145232;5767.019606666877;5801.796937107223;5824.534037277008;5859.882802343972;6195.132681424604;6221.782237621662;6267.4672652824565;6287.402696743802;6318.399752023551;6210.161628180228;6254.093156492283;6259.530535209878;6269.467095296905;6275;4937.753112344404;6010.278766547998;6081.908771368433;6084.939150608526;6095.146679464879;6342.873142537123;6351.745930162834;6423.389777971085;6450.774222902176;6460.063290822804;5615.606907516435;6093.451589356979;6236.812895613139;6304.338044505353;6314.02132669437;5385.6230063895155;5404.973055119514;6204.968975155095;6303.212098487689;6330.39861213184;6145;6213.440790328892;6240.157578726905;6242.875142497215;6259.123722678829;6175.228096487939;6221.875562488724;6255.843603909848;6261.060840873814;6263.78076767311;4326.199653064194;4764.761761911891;5016.54851063406;5025.346704928336;5031.77357018935;4406.228909940747;4463.843765468193;4475.552444755498;4542.727436353829;4577.816887324537;6121.877562448726;6152.753889844445;6154.230721159855;6156.815295541141;6161.353057928943;6296.779612713533;6318.62088274705;6351.333110023474;6368.617882927039;6374.075759014917;4798.424189097331;6017.217761690952;6098.54260930432;6129.3870612939245;6167;5515.558755299567;5516.806911758069;5533.142362933671;5536.916946245809;5555.8888822223325;6451.935480645134;6459.09572659828;6459.644719540471;6463.612183269019;6477.611343319321;6219.564630475823;6257.561970662192;6289.465395441439;6294.15028971083;6320.841978950563;6266.624002559679;6267.968660156853;6277.874442511215;6293.653849038164;6330.39861213184;6128.724207410588;6130.18412495751;6131.325554189125;6184.072389141665;6192.59748116371;5196.4283928767045;6267.46726528232;6351.841203969753;6356.713947872265;6372.458341041063;6100.664463454375;6225.097360882556;6252.5935814171935;6261.7182226799;6274.027525733519;6168.907466388097;6189.535784816067;6289.716962736779;6304.968475157595;6310.242770867525;6066.3023752269055;6070.0591408331775;6128.778133445034;6165.876682466236;6201.162843016135;6179.859047126711;6180.258368995749;6216.627002379872;6247.5939063960695;6250.281217659845;6060;6139.522803442411;6222.937770622236;6241.438270555672;6262.718177681924 11:15:46 INFO - PROCESS | 1675 | |1;ext.html;532.5473347654491;542.682530719529;570.2757497977567;582.9125631155326;595.93742657021;38399.616003839954;39124.21751564967;39221.41167882481;39224;39284.60715392845;37382;42303;43045.35431968523;43858.90352741183;43921;9519;9675.709728708114;9835.508224588777;9922.107010369065;9938.20494360453;9739.318247722662;9818.803623927517;9872.111509964101;9895.604175832957;9941.40351578904;9843.458609776459;9883.357581757164;9889.40663560185;9972.252081093911;9977.650782222623;9801.264905132108;9883.159931405839;9887.209023278156;9889.950550247238;9911.603535858558;9763.414195148314;9883.752906177331;9891.653792117313;9931.652392166312;9959;39840;39980;40135.79932100321;40384.59615403838;40390;2943.67619561848;3179.554862319254;3309.7021268085746;3311.7516186286125;3334.4664853623544;28969.420611587862;29590;29608.25979350512;29983.850080749675;30191.69808301911;2771.6973171518707;2785.9860700696568;2789.4700006998605;2795.4828356754065;2865.957010644842;545156;546046;549812;550166;551472.2426387883;47480.28779568309;47663.28505072427;71221;71755.6412217946;71867.92198117032;46597.534024659995;46663.76668116638;46792.2981155283;46989.82525436823;47092.05815883663;17331.480055598353;17387.217575209146;17415.56461088483;17439;17475.650486990442;13542.526011589744;13874.375653095634;13931.860681393056;13932;13975.510857119953;15172.620684482976;15525.37898484048;15611.765823512656;15704;15777.605559861095;6538.346165383518;6615.801525954229;6685.197776266879;6686.297938716462;6695.866082678416;961.624966263158;982.7592239901127;1024.975024975025;1039.4023436523878;1126.2172789910933;28572;28578.285542861595;29060.12819615415;29096.563551546744;29155.416891662047;1143.1255089856268;1151.2114201771813;1159.5767544846071;1189.583645724007;1190.7737529869298;14298.85701142996;14895.404183832525;16716.832831671527;16775.748363774554;16856.241469133918;698259;698757;701586;707197;708828;53624;54148;58782.4121758777;63430.682846586395;65834.34165658282;1531.9157446340334;1544.3050627217797;1563.1793308513122;1572.716910956016;1577.574055005165;27871;31355.21611959628;31864.681353187098;32125;32181.195470113435;54202.186967196314;54652.45347546474;54892.45107548873;54931.45068549264;55088.44911550833;452468;516833;517925;521045;522692;35187.472187917716;45305;46070.308945366516;47400.52599473961;47447.76276118597;39618.40572391359;46691;47045.4125023127;48019;48199.795005125154;32879.83560082184;39132.82601521959;39288.6071139285;39583.60416395799;39895;33805.32389352249;37468.87593372203;37719.811400943916;38080.61919380771;38659;33641.3271734559;37550.62449375581;38084.04789880164;38305.6169438302;38621.227575448895;28097;33123.83438082794;33586.49620255747;34141.975740727816;34375.82812085924;25736.61395079038;25955;26025.0891218814;26029.349266268495;26467.867660661574 11:15:46 INFO - PROCESS | 1675 | |2;jquery.html;360.2506785885359;371.5448575495019;373.4715377740497;373.5480069116369;373.58532029447326;17397.652046959054;20778.89610551947;21669.45826354342;22412.215572454967;22420.439489012762;21429.464263393384;22263.777362226374;22345.664815027787;22641.433964150903;22760;5871.500922421599;5889;6145.877082458371;6154.476869466078;6172.321044685081;5962;6019.307779605358;6033.245844269466;6075.848103797396;6078.665673387962;5704.971475142618;5934.376890426508;5955.970220148914;5996.220491336142;6012.2184116064855;5938.079597662369;5991.760329586833;5996.580239383245;6013.128096426038;6054.303755068179;4840.903181936342;5210.739463026834;5222.399424066205;5243.554297884684;5248;14045.929770351186;14173.220472873987;14173.43306267748;14263.358148883326;14366.85633143676;2116.1323857218467;2145.9785402145935;2178.7930146636045;2251.8648881067024;2321.860688358687;10326.638567650096;10329.84505232422;10452.059314661641;10609.73475663107;10807.35155890649;1730.8355706208015;1813.4015774794286;1842.5854182808762;1888.1503323504478;1974.1708482437411;85577.14422855692;94289.52855235749;104506.95493045125;107841.7647470577;112968;9421.528923553795;11452.770944581061;11881.227720198332;11916.987056100155;12038.939805300917;14362;14702.191379474018;14702.852971470362;14734.484293049905;14749.557513274405;9116.270698344117;9147.588358523883;9196.264298856075;9199.356045076915;9330.253579713606;7624.961875190588;9403.623855045858;9409.717708468757;9447.338686291894;9501.23990080792;3859.5947425519917;4494.191045611821;4511.436070491189;4537.977310113494;4673;1905.2950408349;1963.185278109597;1964.1259639460588;1967.7441932548677;2001.5296405344732;865.8917635295588;916.4501299220415;954.8663187153804;1009.5255230042015;1084.452351562456;16255.674886502204;19578.51053723668;20866.895665521577;21110.47223819386;21191.364259072252;970.2529052629436;985.9211263098935;1028.7273872423814;1038.7922415516928;1051.321897376188;11067.72330691723;11189;11670.649880503599;11761.353125578175;11857.229280096766;583072;684389;685213;723513;730873;93920;112472;122453.38773306076;123088;125770;988.826955282837;1050.369778133114;1107.8257047529644;1110.2505808579176;1113.6714669172613;15581.753459722968;18355.81644183541;18534.907325463286;18842;19344.839309641466;52330.64512097041;53062.4693753073;54117.72941135269;56416.5895852607;56705.71647141738;71133.64433178007;77455.61272193604;77747;78030.6098469504;80697;9640.71077867665;12337.444814983168;12450.875491245333;12571.74856502883;12691.682707932376;13946.651333716738;13971.720565588834;13993.440262389391;14148.646283842574;14374.496892608708;11951.342676152548;11977.221480603734;12118.272903625812;12260.32568208757;12269.631911042683;11782.234154779911;11843.348615826213;11890.524379024742;12034.879651203375;12201.023918086354;11963.760724785281;12320.199187052813;12417.31704756247;12529.686757831127;12629.747405051663;12199.573014944433;12226.75546489083;12390.132690711564;12480.00159987217;12490.063245256824;12147.088968327234;12211.572594959134;12226.694332641755;12407.813882791585;12435.440405181607 11:15:46 INFO - PROCESS | 1675 | |3;mootools.html;1654.5119189838997;1685.9325626974921;2052.384284714585;2113.9154433822646;2147.742270927489;8304.21109994551;8864.512451815155;9004.099590040993;9032.909670903297;9046.140616641416;9074.591643376047;9122.86315705265;9186.770330741734;9215;9242.584083716232;2578.530237764475;2591.76674099331;2605.7394260573888;2612.399148195916;2616.82990605611;2561.9743802562016;2587.935301617465;2598.883050262743;2608.1393140263667;2618.908338208163;2582.741725827421;2595.390083330416;2625.7768089712304;2633.0521012435506;2633.1310667479684;2588.715241323453;2590.222933120066;2601.2846467221475;2611.8955241790304;2623.9606405903833;2189.2884812436023;2571.524268010424;2583.8578878161693;2611.0339174505366;2629.3032346428213;9241.122093401116;9263.21262692672;9276.907230927673;9296.628134874596;9301.58142883565;4700.929486057712;5676.091825307973;5724.370319264877;5818.883622327572;5827.533797296206;3586.910327241814;3632.8001959892194;3689.169936764207;3820.4460353248624;3841.8847434577006;1067.2795862792584;1083.9078678312353;1090.0189829153826;1129.3054771315665;1132.64887884756;10386.584536618526;12144.453499592451;12273.447694853843;12298.077644176723;12370.19593726414;5050.949490505048;5075.0357432087785;5109.080365534165;5138.434772175057;5158.948410515922;9078.909210907806;9218.769530761785;10554.208434367452;10589.258751887293;10614;5671.9716401418555;5735.340435849847;5755.366909639936;5779.046457334577;5795.449432303924;3788.6211378862445;4887.29134275528;5022.321986531844;5181.637285389987;5183;3427.7771944824003;3752.849886004584;3836.9040773980873;4085.5097388313593;4196;1065.8294672852307;1353.5939218234491;1360.8026836108709;1364.733876894016;1367.924764137962;1076.580133747839;1093.7156339351666;1098.6209757633603;1117.3631030312806;1470.1032370254136;8462.492250464991;8502.06477287498;8574.3997920145;8609.870851937227;8623.525706086226;409.9754014759124;547.2666626720214;549.370970239074;550.3835704011533;551.5642642312608;6366.808995730135;6398.976163813861;6440.549161558646;6467.870642587122;6477.870442591122;10922.945385273022;11338.773224535464;11381.772364552662;11389.487473063731;11420.714482137846;10782.245242833083;11095.44522773858;11118.499667514981;11277.71805704864;11299.322040677585;8785.956070219609;8790.648374064966;8809.383343166044;8842.425242359226;8882.022977472472;8158.061822890206;8290.212429819157;8297.29472994778;8342.87485687703;8369.246767790684;9505.95247023788;9640.132388085107;9734.610615575297;10047.191505529076;10065.748356291151;9871.111599956039;10081.042300981395;10088.394696318244;10089.545970431202;10132.037456441627;7239.493235473677;7287.781366559012;7862.567558784322;7881.369490440866;7942.08666003417;8563.61463734146;8585.785355366166;8594;8606.913930860612;8629.611667475105;7486.8876966844455;7603.2776886195725;7623;7690;7862.72480463181;7392.667329970272;7460.0674915635545;7486.7005319786595;7540.886886696594;7569.243075692387;7928.7621371358955;7954.482958607672;7956.801079973047;8015.959920200362;8035.959820200862;7151.177614574391;7186.568805871664;7203.8559228816175;7244.492885498175;7267.491275610657;7357.668904899186;7381.667824947997;7409.407247420301;7432.702691892264;7473.290037446434 11:15:46 INFO - PROCESS | 1675 | |4;prototype.html;334.64527600743213;337.39942901635084;340.58958954459877;342.5632318793538;346.2901052841674;6641.900371494431;6685.799426017215;6734.79795606132;6758.189017317916;6787.524873258868;6635.469162467003;6642.136522252101;6656.866862662744;6670.533062685614;6672.065910772496;4697.131030759303;4817.0365926814775;4918.2376731606655;4919.458859525449;4992.375953005883;4888.144574699431;4908.656394052417;4924.138275801738;4940.925886111693;4957.925631115518;4865.270209468573;4869.634777391692;4872.65891387603;4901.607871370282;4936.753162341886;4948.703077815343;4949.628777841676;4967.7019378837385;4973.502649735015;4980.352554167971;3782.2813665403487;4051.4530538377235;4277.443932288783;4288.120935208275;4297.828086876521;6127.908081378783;6339.714712837887;6405.135306733578;6422.325655806119;6427.967860160716;5853.76584936602;5926.466618004357;5932.3177834548715;5940.732667029994;5975.581709280352;7144.106986626672;7150.606716630583;7151.106111736033;7174.1032370953635;7181.281871812829;4298.011457364823;4821.831235906761;4827.42070951488;4835.879103022453;4849.903001939977;7145.464090193256;7476.289752473506;7531.661075251627;7532.6233688315915;7541;4294.63495602871;4426.64586833059;4627.838025669085;4730.645201609893;4897.191963326082;4962.404511458576;4986.526280003394;4989.002199560103;4998.850034498898;5000.2499625056535;5817.650940943557;5834.183214349994;5834.67909264986;5840.561957853178;5860.3260625027815;7130.003598992291;7159.856802863914;7166.175889772639;7166.713331466683;7186.784396468114;1721.6040310728602;1749.282794054457;1754.6402987387555;1757.499112752885;1761.1018380625974;1100.9394483303336;1136.023020202625;1152.8213126965334;1159.576754484624;1160.5647882044234;6708.563943343765;6772.762953296611;6799.218089919624;6835.14560679905;6847.726090956406;5403.8651883104985;7277.126744790659;7372.447066470037;7390.408767298603;7415.629218539159;4897.436794768647;6146.877062458726;6767.898481522781;6797.320267973163;6814.97775333694;3803.7147213959065;3889.572147063821;3925.21495700861;3936.842526298916;3955.228730397545;7642.235776422313;7738.187490313436;7762.184970578121;7764.378849692124;7771;6412.839679008062;7349.669264883093;7555.773326800205;7628.771136865903;7632.084149902047;6231.376862313732;6234.501239900797;6414.9679251604375;7528.473006889575;7739.922600774033;7174.713011479691;7360.742374016883;7404;7426.777196684108;7427.628618569158;7343.3390994810725;7367.2264412235945;7371.262873712586;7373.410127189919;7402.148752893271;7873.606319684108;7877.409194310564;7878.369730421437;7885.093214280431;7932.206779322021;4727.62179025684;4771.976140119277;4781.760911954458;4795.520447955177;4799.112164249625;7118.644067796486;7241.4206863451855;7450.515716478411;7495.775126746206;7498.362639175732;6362.840928976628;6826.658667066527;7184.461165412719;7215.422766178588;7234.710611575478;7188.065551478275;7193.820154496179;7213.098362704662;7213.495055346076;7225.205227425085;7011.684474198775;7034.718611255493;7058.364747172779;7078.805570273232;7088.539244949062;6109.716959438568;6641.568298060611;7210.1708303545765;7220.241874603301;7224.819379515554;6998.54509456904;7032.859342813217;7045.859082818418;7069.22238553769;7078.964605176941 11:15:46 INFO - PROCESS | 1675 | |5;yui.html;663.3532306001646;685.4721864164593;779.7699678594814;790.1821614628859;791.3629528229776;15229.543113706593;15521.91346605738;15526.844731552681;15532.22338883057;15563.844361556381;14407.567772966828;14444;14491.058081224714;14517.346719397627;14536;809.2837838512929;931.1247427418239;951.9476428796431;976.5459061536384;1002;944.1219665710886;953.8044700836347;968;980.2305190425482;981.3670182732169;1008.8537162111489;1009.0666133826218;1051.0488008352454;1055.0978913029364;1058.5077938758475;999.4253304349992;1000.1099021870541;1004.221728160674;1006.6879267427084;1046.1944302886773;750.7935317787598;758.7192738686666;779.6413649721135;781.6048353688695;782.7495201535511;14659.340329685083;14700.632484187874;14700.926495367561;14701.04443211188;14745.11529308245;13095.869041309561;13157.86842131576;13322.866771332356;13325.533606323828;13366.866331336756;9929.751756206153;10210.234232432596;10227.79544409115;10239;10278.7430314242;3597.964020359815;3599;3721.79530125843;3735.4396840473873;3850.7111966602615;75263.62368188179;76615;78783;80136.59931700362;80450.59774701147;8534.78663033429;9316.394434361744;9848.35985660944;9901.900980990242;10100.949495252476;21820;22271.888640556692;22290.108395664316;22594.322170334915;22594.54810903773;7741.264579864904;7812.414068944852;7915.841683166304;8029.036515618163;8154.143814899468;4208.158368326347;4236.406903033578;4246.044639955985;4268.658507319407;4276.18752437036;3524.33037722837;3547.255076433926;3558.768680035789;3577.266660334625;3589.587197472272;662.1590579963515;665.2250128600126;683.4498228925762;687.5221720904024;688.6040526697169;531.0149672357797;575.8848230353946;584.3922320786335;590.2297501760244;603.7524614907867;7816.49192802466;7852.607369631495;8051.355891528664;8101.716439924692;8165.653480369347;495.9925601115986;523.9161734122598;541.8374487653688;589.9292084949748;604.030530997751;3528.6414730329006;3682.668559829628;3711.9072023199096;3830.0807806126327;3857;83039.84800760058;83533.16466835253;85579;85637.57181214179;95541;79564.60217698874;79677;80599;80649;80830.59584702039;71905.20236994117;72196.27803722;74982.25017749752;75030.62484687542;75654;8702.347323950602;8860.158284962918;8935.865962010444;9001;9095.454272743656;50074.74813129701;51822.48177518177;51864.74067629638;52404;53010.73494632502;64820.67589662022;66115.66942165258;67982.3201767976;68374;69509;11019.228653994143;11163.33020018769;11192.440377980905;11217.439128043401;11480.540778368771;12076.939615301868;12081.939590301992;12269.263844169378;12509.56216532417;12560.874391256337;9384.859227111736;9426.387284826464;11810.940945295219;12178.612996847976;12751.744965100832;11808.35054072;12035.338056406632;12066.818997715216;12103.878961210627;12158.331291779037;11032.227744057838;11304.604338848101;11496.94251528737;11553.537858485566;11788.76422471563;9726.95136524341;9840.852387214341;9909.504524773876;9926.602935882484;10014.048665376778;9769.071938165864;9912.454814984956;9968.651097211563;10026.598936042768;10026.749331266778 11:15:46 INFO - PROCESS | 1675 | __end_tp_report 11:15:46 INFO - PROCESS | 1675 | __start_cc_report 11:15:46 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,345 11:15:46 INFO - PROCESS | 1675 | __end_cc_report 11:15:46 INFO - PROCESS | 1675 | __startTimestamp1463508946564__endTimestamp 11:15:46 INFO - PROCESS | 1675 | 11:15:46 INFO - PROCESS | 1675 | ------- Summary: start ------- 11:15:46 INFO - PROCESS | 1675 | Number of tests: 6 11:15:46 INFO - PROCESS | 1675 | 11:15:46 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5815.48 Median:6131.33 stddev:655.44 (10.7%) stddev-sans-first:634.48 11:15:46 INFO - PROCESS | 1675 | Values: 3622.9 3667.2 3694.8 3709.2 3723.8 4306.3 5870.8 5907.9 5916.6 5944.9 4889.0 5910.0 5939.2 5972.1 5997.2 5216.9 5319.8 5340.8 5356.5 5361.2 5213.8 5319.5 5354.5 5379.9 5424.3 4314.5 5190.4 5322.1 5340.9 5349.1 5316.9 5329.3 5379.5 5383.9 5435.3 5207.0 5231.7 5252.1 5261.6 5308.7 5641.3 5767.0 5801.8 5824.5 5859.9 6195.1 6221.8 6267.5 6287.4 6318.4 6210.2 6254.1 6259.5 6269.5 6275.0 4937.8 6010.3 6081.9 6084.9 6095.1 6342.9 6351.7 6423.4 6450.8 6460.1 5615.6 6093.5 6236.8 6304.3 6314.0 5385.6 5405.0 6205.0 6303.2 6330.4 6145.0 6213.4 6240.2 6242.9 6259.1 6175.2 6221.9 6255.8 6261.1 6263.8 4326.2 4764.8 5016.5 5025.3 5031.8 4406.2 4463.8 4475.6 4542.7 4577.8 6121.9 6152.8 6154.2 6156.8 6161.4 6296.8 6318.6 6351.3 6368.6 6374.1 4798.4 6017.2 6098.5 6129.4 6167.0 5515.6 5516.8 5533.1 5536.9 5555.9 6451.9 6459.1 6459.6 6463.6 6477.6 6219.6 6257.6 6289.5 6294.2 6320.8 6266.6 6268.0 6277.9 6293.7 6330.4 6128.7 6130.2 6131.3 6184.1 6192.6 5196.4 6267.5 6351.8 6356.7 6372.5 6100.7 6225.1 6252.6 6261.7 6274.0 6168.9 6189.5 6289.7 6305.0 6310.2 6066.3 6070.1 6128.8 6165.9 6201.2 6179.9 6180.3 6216.6 6247.6 6250.3 6060.0 6139.5 6222.9 6241.4 6262.7 11:15:46 INFO - PROCESS | 1675 | 11:15:46 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:71716.38 Median:39867.50 stddev:158444.26 (397.4%) stddev-sans-first:158798.60 11:15:46 INFO - PROCESS | 1675 | Values: 532.5 542.7 570.3 582.9 595.9 38399.6 39124.2 39221.4 39224.0 39284.6 37382.0 42303.0 43045.4 43858.9 43921.0 9519.0 9675.7 9835.5 9922.1 9938.2 9739.3 9818.8 9872.1 9895.6 9941.4 9843.5 9883.4 9889.4 9972.3 9977.7 9801.3 9883.2 9887.2 9890.0 9911.6 9763.4 9883.8 9891.7 9931.7 9959.0 39840.0 39980.0 40135.8 40384.6 40390.0 2943.7 3179.6 3309.7 3311.8 3334.5 28969.4 29590.0 29608.3 29983.9 30191.7 2771.7 2786.0 2789.5 2795.5 2866.0 545156.0 546046.0 549812.0 550166.0 551472.2 47480.3 47663.3 71221.0 71755.6 71867.9 46597.5 46663.8 46792.3 46989.8 47092.1 17331.5 17387.2 17415.6 17439.0 17475.7 13542.5 13874.4 13931.9 13932.0 13975.5 15172.6 15525.4 15611.8 15704.0 15777.6 6538.3 6615.8 6685.2 6686.3 6695.9 961.6 982.8 1025.0 1039.4 1126.2 28572.0 28578.3 29060.1 29096.6 29155.4 1143.1 1151.2 1159.6 1189.6 1190.8 14298.9 14895.4 16716.8 16775.7 16856.2 698259.0 698757.0 701586.0 707197.0 708828.0 53624.0 54148.0 58782.4 63430.7 65834.3 1531.9 1544.3 1563.2 1572.7 1577.6 27871.0 31355.2 31864.7 32125.0 32181.2 54202.2 54652.5 54892.5 54931.5 55088.4 452468.0 516833.0 517925.0 521045.0 522692.0 35187.5 45305.0 46070.3 47400.5 47447.8 39618.4 46691.0 47045.4 48019.0 48199.8 32879.8 39132.8 39288.6 39583.6 39895.0 33805.3 37468.9 37719.8 38080.6 38659.0 33641.3 37550.6 38084.0 38305.6 38621.2 28097.0 33123.8 33586.5 34142.0 34375.8 25736.6 25955.0 26025.1 26029.3 26467.9 11:15:46 INFO - PROCESS | 1675 | 11:15:46 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:36702.37 Median:1987.85 stddev:112765.62 (5672.7%) stddev-sans-first:113048.94 11:15:46 INFO - PROCESS | 1675 | Values: 360.3 371.5 373.5 373.5 373.6 17397.7 20778.9 21669.5 22412.2 22420.4 21429.5 22263.8 22345.7 22641.4 22760.0 5871.5 5889.0 6145.9 6154.5 6172.3 5962.0 6019.3 6033.2 6075.8 6078.7 5705.0 5934.4 5956.0 5996.2 6012.2 5938.1 5991.8 5996.6 6013.1 6054.3 4840.9 5210.7 5222.4 5243.6 5248.0 14045.9 14173.2 14173.4 14263.4 14366.9 2116.1 2146.0 2178.8 2251.9 2321.9 10326.6 10329.8 10452.1 10609.7 10807.4 1730.8 1813.4 1842.6 1888.2 1974.2 85577.1 94289.5 104507.0 107841.8 112968.0 9421.5 11452.8 11881.2 11917.0 12038.9 14362.0 14702.2 14702.9 14734.5 14749.6 9116.3 9147.6 9196.3 9199.4 9330.3 7625.0 9403.6 9409.7 9447.3 9501.2 3859.6 4494.2 4511.4 4538.0 4673.0 1905.3 1963.2 1964.1 1967.7 2001.5 865.9 916.5 954.9 1009.5 1084.5 16255.7 19578.5 20866.9 21110.5 21191.4 970.3 985.9 1028.7 1038.8 1051.3 11067.7 11189.0 11670.6 11761.4 11857.2 583072.0 684389.0 685213.0 723513.0 730873.0 93920.0 112472.0 122453.4 123088.0 125770.0 988.8 1050.4 1107.8 1110.3 1113.7 15581.8 18355.8 18534.9 18842.0 19344.8 52330.6 53062.5 54117.7 56416.6 56705.7 71133.6 77455.6 77747.0 78030.6 80697.0 9640.7 12337.4 12450.9 12571.7 12691.7 13946.7 13971.7 13993.4 14148.6 14374.5 11951.3 11977.2 12118.3 12260.3 12269.6 11782.2 11843.3 11890.5 12034.9 12201.0 11963.8 12320.2 12417.3 12529.7 12629.7 12199.6 12226.8 12390.1 12480.0 12490.1 12147.1 12211.6 12226.7 12407.8 12435.4 11:15:46 INFO - PROCESS | 1675 | 11:15:46 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:6257.91 Median:2865.13 stddev:3311.63 (115.6%) stddev-sans-first:3302.84 11:15:46 INFO - PROCESS | 1675 | Values: 1654.5 1685.9 2052.4 2113.9 2147.7 8304.2 8864.5 9004.1 9032.9 9046.1 9074.6 9122.9 9186.8 9215.0 9242.6 2578.5 2591.8 2605.7 2612.4 2616.8 2562.0 2587.9 2598.9 2608.1 2618.9 2582.7 2595.4 2625.8 2633.1 2633.1 2588.7 2590.2 2601.3 2611.9 2624.0 2189.3 2571.5 2583.9 2611.0 2629.3 9241.1 9263.2 9276.9 9296.6 9301.6 4700.9 5676.1 5724.4 5818.9 5827.5 3586.9 3632.8 3689.2 3820.4 3841.9 1067.3 1083.9 1090.0 1129.3 1132.6 10386.6 12144.5 12273.4 12298.1 12370.2 5050.9 5075.0 5109.1 5138.4 5158.9 9078.9 9218.8 10554.2 10589.3 10614.0 5672.0 5735.3 5755.4 5779.0 5795.4 3788.6 4887.3 5022.3 5181.6 5183.0 3427.8 3752.8 3836.9 4085.5 4196.0 1065.8 1353.6 1360.8 1364.7 1367.9 1076.6 1093.7 1098.6 1117.4 1470.1 8462.5 8502.1 8574.4 8609.9 8623.5 410.0 547.3 549.4 550.4 551.6 6366.8 6399.0 6440.5 6467.9 6477.9 10922.9 11338.8 11381.8 11389.5 11420.7 10782.2 11095.4 11118.5 11277.7 11299.3 8786.0 8790.6 8809.4 8842.4 8882.0 8158.1 8290.2 8297.3 8342.9 8369.2 9506.0 9640.1 9734.6 10047.2 10065.7 9871.1 10081.0 10088.4 10089.5 10132.0 7239.5 7287.8 7862.6 7881.4 7942.1 8563.6 8585.8 8594.0 8606.9 8629.6 7486.9 7603.3 7623.0 7690.0 7862.7 7392.7 7460.1 7486.7 7540.9 7569.2 7928.8 7954.5 7956.8 8016.0 8036.0 7151.2 7186.6 7203.9 7244.5 7267.5 7357.7 7381.7 7409.4 7432.7 7473.3 11:15:46 INFO - PROCESS | 1675 | 11:15:46 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:5842.20 Median:6641.73 stddev:1841.35 (27.7%) stddev-sans-first:1799.52 11:15:46 INFO - PROCESS | 1675 | Values: 334.6 337.4 340.6 342.6 346.3 6641.9 6685.8 6734.8 6758.2 6787.5 6635.5 6642.1 6656.9 6670.5 6672.1 4697.1 4817.0 4918.2 4919.5 4992.4 4888.1 4908.7 4924.1 4940.9 4957.9 4865.3 4869.6 4872.7 4901.6 4936.8 4948.7 4949.6 4967.7 4973.5 4980.4 3782.3 4051.5 4277.4 4288.1 4297.8 6127.9 6339.7 6405.1 6422.3 6428.0 5853.8 5926.5 5932.3 5940.7 5975.6 7144.1 7150.6 7151.1 7174.1 7181.3 4298.0 4821.8 4827.4 4835.9 4849.9 7145.5 7476.3 7531.7 7532.6 7541.0 4294.6 4426.6 4627.8 4730.6 4897.2 4962.4 4986.5 4989.0 4998.9 5000.2 5817.7 5834.2 5834.7 5840.6 5860.3 7130.0 7159.9 7166.2 7166.7 7186.8 1721.6 1749.3 1754.6 1757.5 1761.1 1100.9 1136.0 1152.8 1159.6 1160.6 6708.6 6772.8 6799.2 6835.1 6847.7 5403.9 7277.1 7372.4 7390.4 7415.6 4897.4 6146.9 6767.9 6797.3 6815.0 3803.7 3889.6 3925.2 3936.8 3955.2 7642.2 7738.2 7762.2 7764.4 7771.0 6412.8 7349.7 7555.8 7628.8 7632.1 6231.4 6234.5 6415.0 7528.5 7739.9 7174.7 7360.7 7404.0 7426.8 7427.6 7343.3 7367.2 7371.3 7373.4 7402.1 7873.6 7877.4 7878.4 7885.1 7932.2 4727.6 4772.0 4781.8 4795.5 4799.1 7118.6 7241.4 7450.5 7495.8 7498.4 6362.8 6826.7 7184.5 7215.4 7234.7 7188.1 7193.8 7213.1 7213.5 7225.2 7011.7 7034.7 7058.4 7078.8 7088.5 6109.7 6641.6 7210.2 7220.2 7224.8 6998.5 7032.9 7045.9 7069.2 7079.0 11:15:46 INFO - PROCESS | 1675 | 11:15:46 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:18431.44 Median:26463.96 stddev:25484.64 (96.3%) stddev-sans-first:25521.21 11:15:46 INFO - PROCESS | 1675 | Values: 663.4 685.5 779.8 790.2 791.4 15229.5 15521.9 15526.8 15532.2 15563.8 14407.6 14444.0 14491.1 14517.3 14536.0 809.3 931.1 951.9 976.5 1002.0 944.1 953.8 968.0 980.2 981.4 1008.9 1009.1 1051.0 1055.1 1058.5 999.4 1000.1 1004.2 1006.7 1046.2 750.8 758.7 779.6 781.6 782.7 14659.3 14700.6 14700.9 14701.0 14745.1 13095.9 13157.9 13322.9 13325.5 13366.9 9929.8 10210.2 10227.8 10239.0 10278.7 3598.0 3599.0 3721.8 3735.4 3850.7 75263.6 76615.0 78783.0 80136.6 80450.6 8534.8 9316.4 9848.4 9901.9 10100.9 21820.0 22271.9 22290.1 22594.3 22594.5 7741.3 7812.4 7915.8 8029.0 8154.1 4208.2 4236.4 4246.0 4268.7 4276.2 3524.3 3547.3 3558.8 3577.3 3589.6 662.2 665.2 683.4 687.5 688.6 531.0 575.9 584.4 590.2 603.8 7816.5 7852.6 8051.4 8101.7 8165.7 496.0 523.9 541.8 589.9 604.0 3528.6 3682.7 3711.9 3830.1 3857.0 83039.8 83533.2 85579.0 85637.6 95541.0 79564.6 79677.0 80599.0 80649.0 80830.6 71905.2 72196.3 74982.3 75030.6 75654.0 8702.3 8860.2 8935.9 9001.0 9095.5 50074.7 51822.5 51864.7 52404.0 53010.7 64820.7 66115.7 67982.3 68374.0 69509.0 11019.2 11163.3 11192.4 11217.4 11480.5 12076.9 12081.9 12269.3 12509.6 12560.9 9384.9 9426.4 11810.9 12178.6 12751.7 11808.4 12035.3 12066.8 12103.9 12158.3 11032.2 11304.6 11496.9 11553.5 11788.8 9727.0 9840.9 9909.5 9926.6 10014.0 9769.1 9912.5 9968.7 10026.6 10026.7 11:15:46 INFO - PROCESS | 1675 | -------- Summary: end -------- 11:15:46 INFO - PROCESS | 1675 | 11:15:47 INFO - TEST-INFO | 1675: exit 0 11:15:47 INFO - TEST-OK | dromaeo_css | took 1110162ms 11:15:47 INFO - TEST-START | kraken 11:15:47 INFO - operating with platform_type : mac_ 11:15:47 INFO - Initialising browser for kraken test... 11:15:47 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpFTYsTr/profile http://localhost:49276/getInfo.html) 11:15:49 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 11:15:49 INFO - PROCESS | 1684 | colorDepth:24 11:15:49 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 11:15:49 INFO - PROCESS | 1684 | __metrics 11:15:49 ERROR - PROCESS | 1684 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 11:15:50 INFO - TEST-INFO | 1684: exit 0 11:15:50 INFO - Browser initialized. 11:15:50 INFO - Running cycle 1/1 for kraken test... 11:15:50 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpFTYsTr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:01 INFO - PROCESS | 1688 | RSS: Main: 167583744 11:16:01 INFO - PROCESS | 1688 | 11:16:04 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 11:16:05 INFO - PROCESS | 1688 | RSS: Main: 179150848 11:16:05 INFO - PROCESS | 1688 | 11:16:07 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 11:16:08 INFO - PROCESS | 1688 | RSS: Main: 188768256 11:16:08 INFO - PROCESS | 1688 | 11:16:11 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 11:16:12 INFO - PROCESS | 1688 | RSS: Main: 192700416 11:16:12 INFO - PROCESS | 1688 | 11:16:14 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 11:16:14 INFO - PROCESS | 1688 | RSS: Main: 192536576 11:16:14 INFO - PROCESS | 1688 | 11:16:16 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:16:17 INFO - PROCESS | 1688 | RSS: Main: 192315392 11:16:17 INFO - PROCESS | 1688 | 11:16:20 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 11:16:20 INFO - PROCESS | 1688 | RSS: Main: 193826816 11:16:20 INFO - PROCESS | 1688 | 11:16:23 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 11:16:24 INFO - PROCESS | 1688 | RSS: Main: 194400256 11:16:24 INFO - PROCESS | 1688 | 11:16:27 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 11:16:28 INFO - PROCESS | 1688 | RSS: Main: 194039808 11:16:28 INFO - PROCESS | 1688 | 11:16:29 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:16:30 INFO - PROCESS | 1688 | RSS: Main: 193716224 11:16:30 INFO - PROCESS | 1688 | 11:16:32 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:16:32 INFO - PROCESS | 1688 | RSS: Main: 193478656 11:16:32 INFO - PROCESS | 1688 | 11:16:34 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:16:35 INFO - PROCESS | 1688 | RSS: Main: 194400256 11:16:35 INFO - PROCESS | 1688 | 11:16:38 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:16:38 INFO - PROCESS | 1688 | RSS: Main: 194351104 11:16:38 INFO - PROCESS | 1688 | 11:16:40 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:16:41 INFO - PROCESS | 1688 | RSS: Main: 193933312 11:16:41 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 11:16:43 INFO - PROCESS | 1688 | RSS: Main: 195473408 11:16:43 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | __start_tp_report 11:16:43 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 11:16:43 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 11:16:43 INFO - PROCESS | 1688 | |i|pagename|runs| 11:16:43 INFO - PROCESS | 1688 | |0;ai-astar;114;110;115;115;114;129;113;115;115;115 11:16:43 INFO - PROCESS | 1688 | |1;audio-beat-detection;153;120;155;188;151;138;121;151;148;117 11:16:43 INFO - PROCESS | 1688 | |2;audio-dft;189;196;195;210;252;272;207;195;198;192 11:16:43 INFO - PROCESS | 1688 | |3;audio-fft;65;66;77;111;58;58;57;58;116;56 11:16:43 INFO - PROCESS | 1688 | |4;audio-oscillator;82;85;112;77;77;82;114;77;78;114 11:16:43 INFO - PROCESS | 1688 | |5;imaging-gaussian-blur;104;130;88;101;134;116;90;86;88;85 11:16:43 INFO - PROCESS | 1688 | |6;imaging-darkroom;113;153;151;94;94;103;97;96;130;96 11:16:43 INFO - PROCESS | 1688 | |7;imaging-desaturate;93;91;91;126;141;91;98;116;144;97 11:16:43 INFO - PROCESS | 1688 | |8;json-parse-financial;48;58;70;53;52;79;48;53;55;56 11:16:43 INFO - PROCESS | 1688 | |9;json-stringify-tinderbox;65;74;87;92;72;59;81;94;95;64 11:16:43 INFO - PROCESS | 1688 | |10;stanford-crypto-aes;71;72;92;108;73;109;109;110;110;87 11:16:43 INFO - PROCESS | 1688 | |11;stanford-crypto-ccm;127;104;134;127;134;137;118;121;126;118 11:16:43 INFO - PROCESS | 1688 | |12;stanford-crypto-pbkdf2;126;134;136;133;137;120;136;133;136;135 11:16:43 INFO - PROCESS | 1688 | |13;stanford-crypto-sha256-iterative;64;66;69;69;69;65;67;67;68;68 11:16:43 INFO - PROCESS | 1688 | __end_tp_report 11:16:43 INFO - PROCESS | 1688 | __start_cc_report 11:16:43 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,913 11:16:43 INFO - PROCESS | 1688 | __end_cc_report 11:16:43 INFO - PROCESS | 1688 | __startTimestamp1463509003504__endTimestamp 11:16:43 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | ------- Summary: start ------- 11:16:43 INFO - PROCESS | 1688 | Number of tests: 14 11:16:43 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.00 stddev:4.99 (4.3%) stddev-sans-first:5.27 11:16:43 INFO - PROCESS | 1688 | Values: 114.0 110.0 115.0 115.0 114.0 129.0 113.0 115.0 115.0 115.0 11:16:43 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:151.00 stddev:21.40 (14.2%) stddev-sans-first:22.46 11:16:43 INFO - PROCESS | 1688 | Values: 153.0 120.0 155.0 188.0 151.0 138.0 121.0 151.0 148.0 117.0 11:16:43 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | [#2] audio-dft Cycles:10 Average:210.60 Median:202.50 stddev:28.22 (13.9%) stddev-sans-first:28.83 11:16:43 INFO - PROCESS | 1688 | Values: 189.0 196.0 195.0 210.0 252.0 272.0 207.0 195.0 198.0 192.0 11:16:43 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | [#3] audio-fft Cycles:10 Average:72.20 Median:58.00 stddev:22.70 (39.1%) stddev-sans-first:23.92 11:16:43 INFO - PROCESS | 1688 | Values: 65.0 66.0 77.0 111.0 58.0 58.0 57.0 58.0 116.0 56.0 11:16:43 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:77.50 stddev:16.46 (21.2%) stddev-sans-first:17.22 11:16:43 INFO - PROCESS | 1688 | Values: 82.0 85.0 112.0 77.0 77.0 82.0 114.0 77.0 78.0 114.0 11:16:43 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | [#5] imaging-gaussian-blur Cycles:10 Average:102.20 Median:85.50 stddev:18.53 (21.7%) stddev-sans-first:19.64 11:16:43 INFO - PROCESS | 1688 | Values: 104.0 130.0 88.0 101.0 134.0 116.0 90.0 86.0 88.0 85.0 11:16:43 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | [#6] imaging-darkroom Cycles:10 Average:112.70 Median:94.00 stddev:23.54 (25.0%) stddev-sans-first:24.97 11:16:43 INFO - PROCESS | 1688 | Values: 113.0 153.0 151.0 94.0 94.0 103.0 97.0 96.0 130.0 96.0 11:16:43 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | [#7] imaging-desaturate Cycles:10 Average:108.80 Median:91.00 stddev:21.29 (23.4%) stddev-sans-first:21.80 11:16:43 INFO - PROCESS | 1688 | Values: 93.0 91.0 91.0 126.0 141.0 91.0 98.0 116.0 144.0 97.0 11:16:43 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:55.50 stddev:9.87 (17.8%) stddev-sans-first:9.90 11:16:43 INFO - PROCESS | 1688 | Values: 48.0 58.0 70.0 53.0 52.0 79.0 48.0 53.0 55.0 56.0 11:16:43 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | [#9] json-stringify-tinderbox Cycles:10 Average:78.30 Median:84.00 stddev:13.37 (15.9%) stddev-sans-first:13.28 11:16:43 INFO - PROCESS | 1688 | Values: 65.0 74.0 87.0 92.0 72.0 59.0 81.0 94.0 95.0 64.0 11:16:43 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | [#10] stanford-crypto-aes Cycles:10 Average:94.10 Median:71.50 stddev:17.21 (24.1%) stddev-sans-first:16.09 11:16:43 INFO - PROCESS | 1688 | Values: 71.0 72.0 92.0 108.0 73.0 109.0 109.0 110.0 110.0 87.0 11:16:43 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:127.00 stddev:9.82 (7.7%) stddev-sans-first:10.38 11:16:43 INFO - PROCESS | 1688 | Values: 127.0 104.0 134.0 127.0 134.0 137.0 118.0 121.0 126.0 118.0 11:16:43 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.60 Median:135.50 stddev:5.42 (4.0%) stddev-sans-first:5.20 11:16:43 INFO - PROCESS | 1688 | Values: 126.0 134.0 136.0 133.0 137.0 120.0 136.0 133.0 136.0 135.0 11:16:43 INFO - PROCESS | 1688 | 11:16:43 INFO - PROCESS | 1688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.75 (2.6%) stddev-sans-first:1.42 11:16:43 INFO - PROCESS | 1688 | Values: 64.0 66.0 69.0 69.0 69.0 65.0 67.0 67.0 68.0 68.0 11:16:43 INFO - PROCESS | 1688 | -------- Summary: end -------- 11:16:43 INFO - PROCESS | 1688 | 11:16:44 INFO - TEST-INFO | 1688: exit 0 11:16:44 INFO - TEST-OK | kraken | took 57120ms 11:16:44 INFO - SUITE-END | took 1167s 11:16:44 INFO - Completed test suite (00:19:27) 11:16:44 INFO - javascript benchmark 11:16:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3622.909427264318, 3667.15655399258, 3694.7783133012003, 3709.2210635766487, 3723.795191264481, 4306.332518459636, 5870.765169393229, 5907.911381329278, 5916.585838991272, 5944.88110237795, 4889.017699203492, 5909.970450147754, 5939.168516407695, 5972.104184372335, 5997.160397544348, 5216.9478305216935, 5319.760610772524, 5340.786368545273, 5356.517913387795, 5361.169018802072, 5213.817516386927, 5319.468053194669, 5354.544863686591, 5379.946200537984, 5424.267723857288, 4314.503832059307, 5190.377154741417, 5322.0952438085615, 5340.893182136355, 5349.144136938091, 5316.9202461963105, 5329.307190065306, 5379.488948549882, 5383.892322153574, 5435.293411856473, 5207.0, 5231.659942103789, 5252.133397989365, 5261.631685781997, 5308.734563271821, 5641.294838145232, 5767.019606666877, 5801.796937107223, 5824.534037277008, 5859.882802343972, 6195.132681424604, 6221.782237621662, 6267.4672652824565, 6287.402696743802, 6318.399752023551, 6210.161628180228, 6254.093156492283, 6259.530535209878, 6269.467095296905, 6275.0, 4937.753112344404, 6010.278766547998, 6081.908771368433, 6084.939150608526, 6095.146679464879, 6342.873142537123, 6351.745930162834, 6423.389777971085, 6450.774222902176, 6460.063290822804, 5615.606907516435, 6093.451589356979, 6236.812895613139, 6304.338044505353, 6314.02132669437, 5385.6230063895155, 5404.973055119514, 6204.968975155095, 6303.212098487689, 6330.39861213184, 6145.0, 6213.440790328892, 6240.157578726905, 6242.875142497215, 6259.123722678829, 6175.228096487939, 6221.875562488724, 6255.843603909848, 6261.060840873814, 6263.78076767311, 4326.199653064194, 4764.761761911891, 5016.54851063406, 5025.346704928336, 5031.77357018935, 4406.228909940747, 4463.843765468193, 4475.552444755498, 4542.727436353829, 4577.816887324537, 6121.877562448726, 6152.753889844445, 6154.230721159855, 6156.815295541141, 6161.353057928943, 6296.779612713533, 6318.62088274705, 6351.333110023474, 6368.617882927039, 6374.075759014917, 4798.424189097331, 6017.217761690952, 6098.54260930432, 6129.3870612939245, 6167.0, 5515.558755299567, 5516.806911758069, 5533.142362933671, 5536.916946245809, 5555.8888822223325, 6451.935480645134, 6459.09572659828, 6459.644719540471, 6463.612183269019, 6477.611343319321, 6219.564630475823, 6257.561970662192, 6289.465395441439, 6294.15028971083, 6320.841978950563, 6266.624002559679, 6267.968660156853, 6277.874442511215, 6293.653849038164, 6330.39861213184, 6128.724207410588, 6130.18412495751, 6131.325554189125, 6184.072389141665, 6192.59748116371, 5196.4283928767045, 6267.46726528232, 6351.841203969753, 6356.713947872265, 6372.458341041063, 6100.664463454375, 6225.097360882556, 6252.5935814171935, 6261.7182226799, 6274.027525733519, 6168.907466388097, 6189.535784816067, 6289.716962736779, 6304.968475157595, 6310.242770867525, 6066.3023752269055, 6070.0591408331775, 6128.778133445034, 6165.876682466236, 6201.162843016135, 6179.859047126711, 6180.258368995749, 6216.627002379872, 6247.5939063960695, 6250.281217659845, 6060.0, 6139.522803442411, 6222.937770622236, 6241.438270555672, 6262.718177681924], "unit": "score", "name": "dojo.html", "value": 5778.6121504694065}, {"lowerIsBetter": false, "replicates": [532.5473347654491, 542.682530719529, 570.2757497977567, 582.9125631155326, 595.93742657021, 38399.616003839954, 39124.21751564967, 39221.41167882481, 39224.0, 39284.60715392845, 37382.0, 42303.0, 43045.35431968523, 43858.90352741183, 43921.0, 9519.0, 9675.709728708114, 9835.508224588777, 9922.107010369065, 9938.20494360453, 9739.318247722662, 9818.803623927517, 9872.111509964101, 9895.604175832957, 9941.40351578904, 9843.458609776459, 9883.357581757164, 9889.40663560185, 9972.252081093911, 9977.650782222623, 9801.264905132108, 9883.159931405839, 9887.209023278156, 9889.950550247238, 9911.603535858558, 9763.414195148314, 9883.752906177331, 9891.653792117313, 9931.652392166312, 9959.0, 39840.0, 39980.0, 40135.79932100321, 40384.59615403838, 40390.0, 2943.67619561848, 3179.554862319254, 3309.7021268085746, 3311.7516186286125, 3334.4664853623544, 28969.420611587862, 29590.0, 29608.25979350512, 29983.850080749675, 30191.69808301911, 2771.6973171518707, 2785.9860700696568, 2789.4700006998605, 2795.4828356754065, 2865.957010644842, 545156.0, 546046.0, 549812.0, 550166.0, 551472.2426387883, 47480.28779568309, 47663.28505072427, 71221.0, 71755.6412217946, 71867.92198117032, 46597.534024659995, 46663.76668116638, 46792.2981155283, 46989.82525436823, 47092.05815883663, 17331.480055598353, 17387.217575209146, 17415.56461088483, 17439.0, 17475.650486990442, 13542.526011589744, 13874.375653095634, 13931.860681393056, 13932.0, 13975.510857119953, 15172.620684482976, 15525.37898484048, 15611.765823512656, 15704.0, 15777.605559861095, 6538.346165383518, 6615.801525954229, 6685.197776266879, 6686.297938716462, 6695.866082678416, 961.624966263158, 982.7592239901127, 1024.975024975025, 1039.4023436523878, 1126.2172789910933, 28572.0, 28578.285542861595, 29060.12819615415, 29096.563551546744, 29155.416891662047, 1143.1255089856268, 1151.2114201771813, 1159.5767544846071, 1189.583645724007, 1190.7737529869298, 14298.85701142996, 14895.404183832525, 16716.832831671527, 16775.748363774554, 16856.241469133918, 698259.0, 698757.0, 701586.0, 707197.0, 708828.0, 53624.0, 54148.0, 58782.4121758777, 63430.682846586395, 65834.34165658282, 1531.9157446340334, 1544.3050627217797, 1563.1793308513122, 1572.716910956016, 1577.574055005165, 27871.0, 31355.21611959628, 31864.681353187098, 32125.0, 32181.195470113435, 54202.186967196314, 54652.45347546474, 54892.45107548873, 54931.45068549264, 55088.44911550833, 452468.0, 516833.0, 517925.0, 521045.0, 522692.0, 35187.472187917716, 45305.0, 46070.308945366516, 47400.52599473961, 47447.76276118597, 39618.40572391359, 46691.0, 47045.4125023127, 48019.0, 48199.795005125154, 32879.83560082184, 39132.82601521959, 39288.6071139285, 39583.60416395799, 39895.0, 33805.32389352249, 37468.87593372203, 37719.811400943916, 38080.61919380771, 38659.0, 33641.3271734559, 37550.62449375581, 38084.04789880164, 38305.6169438302, 38621.227575448895, 28097.0, 33123.83438082794, 33586.49620255747, 34141.975740727816, 34375.82812085924, 25736.61395079038, 25955.0, 26025.0891218814, 26029.349266268495, 26467.867660661574], "unit": "score", "name": "ext.html", "value": 20231.513153538603}, {"lowerIsBetter": false, "replicates": [360.2506785885359, 371.5448575495019, 373.4715377740497, 373.5480069116369, 373.58532029447326, 17397.652046959054, 20778.89610551947, 21669.45826354342, 22412.215572454967, 22420.439489012762, 21429.464263393384, 22263.777362226374, 22345.664815027787, 22641.433964150903, 22760.0, 5871.500922421599, 5889.0, 6145.877082458371, 6154.476869466078, 6172.321044685081, 5962.0, 6019.307779605358, 6033.245844269466, 6075.848103797396, 6078.665673387962, 5704.971475142618, 5934.376890426508, 5955.970220148914, 5996.220491336142, 6012.2184116064855, 5938.079597662369, 5991.760329586833, 5996.580239383245, 6013.128096426038, 6054.303755068179, 4840.903181936342, 5210.739463026834, 5222.399424066205, 5243.554297884684, 5248.0, 14045.929770351186, 14173.220472873987, 14173.43306267748, 14263.358148883326, 14366.85633143676, 2116.1323857218467, 2145.9785402145935, 2178.7930146636045, 2251.8648881067024, 2321.860688358687, 10326.638567650096, 10329.84505232422, 10452.059314661641, 10609.73475663107, 10807.35155890649, 1730.8355706208015, 1813.4015774794286, 1842.5854182808762, 1888.1503323504478, 1974.1708482437411, 85577.14422855692, 94289.52855235749, 104506.95493045125, 107841.7647470577, 112968.0, 9421.528923553795, 11452.770944581061, 11881.227720198332, 11916.987056100155, 12038.939805300917, 14362.0, 14702.191379474018, 14702.852971470362, 14734.484293049905, 14749.557513274405, 9116.270698344117, 9147.588358523883, 9196.264298856075, 9199.356045076915, 9330.253579713606, 7624.961875190588, 9403.623855045858, 9409.717708468757, 9447.338686291894, 9501.23990080792, 3859.5947425519917, 4494.191045611821, 4511.436070491189, 4537.977310113494, 4673.0, 1905.2950408349, 1963.185278109597, 1964.1259639460588, 1967.7441932548677, 2001.5296405344732, 865.8917635295588, 916.4501299220415, 954.8663187153804, 1009.5255230042015, 1084.452351562456, 16255.674886502204, 19578.51053723668, 20866.895665521577, 21110.47223819386, 21191.364259072252, 970.2529052629436, 985.9211263098935, 1028.7273872423814, 1038.7922415516928, 1051.321897376188, 11067.72330691723, 11189.0, 11670.649880503599, 11761.353125578175, 11857.229280096766, 583072.0, 684389.0, 685213.0, 723513.0, 730873.0, 93920.0, 112472.0, 122453.38773306076, 123088.0, 125770.0, 988.826955282837, 1050.369778133114, 1107.8257047529644, 1110.2505808579176, 1113.6714669172613, 15581.753459722968, 18355.81644183541, 18534.907325463286, 18842.0, 19344.839309641466, 52330.64512097041, 53062.4693753073, 54117.72941135269, 56416.5895852607, 56705.71647141738, 71133.64433178007, 77455.61272193604, 77747.0, 78030.6098469504, 80697.0, 9640.71077867665, 12337.444814983168, 12450.875491245333, 12571.74856502883, 12691.682707932376, 13946.651333716738, 13971.720565588834, 13993.440262389391, 14148.646283842574, 14374.496892608708, 11951.342676152548, 11977.221480603734, 12118.272903625812, 12260.32568208757, 12269.631911042683, 11782.234154779911, 11843.348615826213, 11890.524379024742, 12034.879651203375, 12201.023918086354, 11963.760724785281, 12320.199187052813, 12417.31704756247, 12529.686757831127, 12629.747405051663, 12199.573014944433, 12226.75546489083, 12390.132690711564, 12480.00159987217, 12490.063245256824, 12147.088968327234, 12211.572594959134, 12226.694332641755, 12407.813882791585, 12435.440405181607], "unit": "score", "name": "jquery.html", "value": 9842.158859227711}, {"lowerIsBetter": false, "replicates": [1654.5119189838997, 1685.9325626974921, 2052.384284714585, 2113.9154433822646, 2147.742270927489, 8304.21109994551, 8864.512451815155, 9004.099590040993, 9032.909670903297, 9046.140616641416, 9074.591643376047, 9122.86315705265, 9186.770330741734, 9215.0, 9242.584083716232, 2578.530237764475, 2591.76674099331, 2605.7394260573888, 2612.399148195916, 2616.82990605611, 2561.9743802562016, 2587.935301617465, 2598.883050262743, 2608.1393140263667, 2618.908338208163, 2582.741725827421, 2595.390083330416, 2625.7768089712304, 2633.0521012435506, 2633.1310667479684, 2588.715241323453, 2590.222933120066, 2601.2846467221475, 2611.8955241790304, 2623.9606405903833, 2189.2884812436023, 2571.524268010424, 2583.8578878161693, 2611.0339174505366, 2629.3032346428213, 9241.122093401116, 9263.21262692672, 9276.907230927673, 9296.628134874596, 9301.58142883565, 4700.929486057712, 5676.091825307973, 5724.370319264877, 5818.883622327572, 5827.533797296206, 3586.910327241814, 3632.8001959892194, 3689.169936764207, 3820.4460353248624, 3841.8847434577006, 1067.2795862792584, 1083.9078678312353, 1090.0189829153826, 1129.3054771315665, 1132.64887884756, 10386.584536618526, 12144.453499592451, 12273.447694853843, 12298.077644176723, 12370.19593726414, 5050.949490505048, 5075.0357432087785, 5109.080365534165, 5138.434772175057, 5158.948410515922, 9078.909210907806, 9218.769530761785, 10554.208434367452, 10589.258751887293, 10614.0, 5671.9716401418555, 5735.340435849847, 5755.366909639936, 5779.046457334577, 5795.449432303924, 3788.6211378862445, 4887.29134275528, 5022.321986531844, 5181.637285389987, 5183.0, 3427.7771944824003, 3752.849886004584, 3836.9040773980873, 4085.5097388313593, 4196.0, 1065.8294672852307, 1353.5939218234491, 1360.8026836108709, 1364.733876894016, 1367.924764137962, 1076.580133747839, 1093.7156339351666, 1098.6209757633603, 1117.3631030312806, 1470.1032370254136, 8462.492250464991, 8502.06477287498, 8574.3997920145, 8609.870851937227, 8623.525706086226, 409.9754014759124, 547.2666626720214, 549.370970239074, 550.3835704011533, 551.5642642312608, 6366.808995730135, 6398.976163813861, 6440.549161558646, 6467.870642587122, 6477.870442591122, 10922.945385273022, 11338.773224535464, 11381.772364552662, 11389.487473063731, 11420.714482137846, 10782.245242833083, 11095.44522773858, 11118.499667514981, 11277.71805704864, 11299.322040677585, 8785.956070219609, 8790.648374064966, 8809.383343166044, 8842.425242359226, 8882.022977472472, 8158.061822890206, 8290.212429819157, 8297.29472994778, 8342.87485687703, 8369.246767790684, 9505.95247023788, 9640.132388085107, 9734.610615575297, 10047.191505529076, 10065.748356291151, 9871.111599956039, 10081.042300981395, 10088.394696318244, 10089.545970431202, 10132.037456441627, 7239.493235473677, 7287.781366559012, 7862.567558784322, 7881.369490440866, 7942.08666003417, 8563.61463734146, 8585.785355366166, 8594.0, 8606.913930860612, 8629.611667475105, 7486.8876966844455, 7603.2776886195725, 7623.0, 7690.0, 7862.72480463181, 7392.667329970272, 7460.0674915635545, 7486.7005319786595, 7540.886886696594, 7569.243075692387, 7928.7621371358955, 7954.482958607672, 7956.801079973047, 8015.959920200362, 8035.959820200862, 7151.177614574391, 7186.568805871664, 7203.8559228816175, 7244.492885498175, 7267.491275610657, 7357.668904899186, 7381.667824947997, 7409.407247420301, 7432.702691892264, 7473.290037446434], "unit": "score", "name": "mootools.html", "value": 5011.287991360664}, {"lowerIsBetter": false, "replicates": [334.64527600743213, 337.39942901635084, 340.58958954459877, 342.5632318793538, 346.2901052841674, 6641.900371494431, 6685.799426017215, 6734.79795606132, 6758.189017317916, 6787.524873258868, 6635.469162467003, 6642.136522252101, 6656.866862662744, 6670.533062685614, 6672.065910772496, 4697.131030759303, 4817.0365926814775, 4918.2376731606655, 4919.458859525449, 4992.375953005883, 4888.144574699431, 4908.656394052417, 4924.138275801738, 4940.925886111693, 4957.925631115518, 4865.270209468573, 4869.634777391692, 4872.65891387603, 4901.607871370282, 4936.753162341886, 4948.703077815343, 4949.628777841676, 4967.7019378837385, 4973.502649735015, 4980.352554167971, 3782.2813665403487, 4051.4530538377235, 4277.443932288783, 4288.120935208275, 4297.828086876521, 6127.908081378783, 6339.714712837887, 6405.135306733578, 6422.325655806119, 6427.967860160716, 5853.76584936602, 5926.466618004357, 5932.3177834548715, 5940.732667029994, 5975.581709280352, 7144.106986626672, 7150.606716630583, 7151.106111736033, 7174.1032370953635, 7181.281871812829, 4298.011457364823, 4821.831235906761, 4827.42070951488, 4835.879103022453, 4849.903001939977, 7145.464090193256, 7476.289752473506, 7531.661075251627, 7532.6233688315915, 7541.0, 4294.63495602871, 4426.64586833059, 4627.838025669085, 4730.645201609893, 4897.191963326082, 4962.404511458576, 4986.526280003394, 4989.002199560103, 4998.850034498898, 5000.2499625056535, 5817.650940943557, 5834.183214349994, 5834.67909264986, 5840.561957853178, 5860.3260625027815, 7130.003598992291, 7159.856802863914, 7166.175889772639, 7166.713331466683, 7186.784396468114, 1721.6040310728602, 1749.282794054457, 1754.6402987387555, 1757.499112752885, 1761.1018380625974, 1100.9394483303336, 1136.023020202625, 1152.8213126965334, 1159.576754484624, 1160.5647882044234, 6708.563943343765, 6772.762953296611, 6799.218089919624, 6835.14560679905, 6847.726090956406, 5403.8651883104985, 7277.126744790659, 7372.447066470037, 7390.408767298603, 7415.629218539159, 4897.436794768647, 6146.877062458726, 6767.898481522781, 6797.320267973163, 6814.97775333694, 3803.7147213959065, 3889.572147063821, 3925.21495700861, 3936.842526298916, 3955.228730397545, 7642.235776422313, 7738.187490313436, 7762.184970578121, 7764.378849692124, 7771.0, 6412.839679008062, 7349.669264883093, 7555.773326800205, 7628.771136865903, 7632.084149902047, 6231.376862313732, 6234.501239900797, 6414.9679251604375, 7528.473006889575, 7739.922600774033, 7174.713011479691, 7360.742374016883, 7404.0, 7426.777196684108, 7427.628618569158, 7343.3390994810725, 7367.2264412235945, 7371.262873712586, 7373.410127189919, 7402.148752893271, 7873.606319684108, 7877.409194310564, 7878.369730421437, 7885.093214280431, 7932.206779322021, 4727.62179025684, 4771.976140119277, 4781.760911954458, 4795.520447955177, 4799.112164249625, 7118.644067796486, 7241.4206863451855, 7450.515716478411, 7495.775126746206, 7498.362639175732, 6362.840928976628, 6826.658667066527, 7184.461165412719, 7215.422766178588, 7234.710611575478, 7188.065551478275, 7193.820154496179, 7213.098362704662, 7213.495055346076, 7225.205227425085, 7011.684474198775, 7034.718611255493, 7058.364747172779, 7078.805570273232, 7088.539244949062, 6109.716959438568, 6641.568298060611, 7210.1708303545765, 7220.241874603301, 7224.819379515554, 6998.54509456904, 7032.859342813217, 7045.859082818418, 7069.22238553769, 7078.964605176941], "unit": "score", "name": "prototype.html", "value": 5237.3692200339265}, {"lowerIsBetter": false, "replicates": [663.3532306001646, 685.4721864164593, 779.7699678594814, 790.1821614628859, 791.3629528229776, 15229.543113706593, 15521.91346605738, 15526.844731552681, 15532.22338883057, 15563.844361556381, 14407.567772966828, 14444.0, 14491.058081224714, 14517.346719397627, 14536.0, 809.2837838512929, 931.1247427418239, 951.9476428796431, 976.5459061536384, 1002.0, 944.1219665710886, 953.8044700836347, 968.0, 980.2305190425482, 981.3670182732169, 1008.8537162111489, 1009.0666133826218, 1051.0488008352454, 1055.0978913029364, 1058.5077938758475, 999.4253304349992, 1000.1099021870541, 1004.221728160674, 1006.6879267427084, 1046.1944302886773, 750.7935317787598, 758.7192738686666, 779.6413649721135, 781.6048353688695, 782.7495201535511, 14659.340329685083, 14700.632484187874, 14700.926495367561, 14701.04443211188, 14745.11529308245, 13095.869041309561, 13157.86842131576, 13322.866771332356, 13325.533606323828, 13366.866331336756, 9929.751756206153, 10210.234232432596, 10227.79544409115, 10239.0, 10278.7430314242, 3597.964020359815, 3599.0, 3721.79530125843, 3735.4396840473873, 3850.7111966602615, 75263.62368188179, 76615.0, 78783.0, 80136.59931700362, 80450.59774701147, 8534.78663033429, 9316.394434361744, 9848.35985660944, 9901.900980990242, 10100.949495252476, 21820.0, 22271.888640556692, 22290.108395664316, 22594.322170334915, 22594.54810903773, 7741.264579864904, 7812.414068944852, 7915.841683166304, 8029.036515618163, 8154.143814899468, 4208.158368326347, 4236.406903033578, 4246.044639955985, 4268.658507319407, 4276.18752437036, 3524.33037722837, 3547.255076433926, 3558.768680035789, 3577.266660334625, 3589.587197472272, 662.1590579963515, 665.2250128600126, 683.4498228925762, 687.5221720904024, 688.6040526697169, 531.0149672357797, 575.8848230353946, 584.3922320786335, 590.2297501760244, 603.7524614907867, 7816.49192802466, 7852.607369631495, 8051.355891528664, 8101.716439924692, 8165.653480369347, 495.9925601115986, 523.9161734122598, 541.8374487653688, 589.9292084949748, 604.030530997751, 3528.6414730329006, 3682.668559829628, 3711.9072023199096, 3830.0807806126327, 3857.0, 83039.84800760058, 83533.16466835253, 85579.0, 85637.57181214179, 95541.0, 79564.60217698874, 79677.0, 80599.0, 80649.0, 80830.59584702039, 71905.20236994117, 72196.27803722, 74982.25017749752, 75030.62484687542, 75654.0, 8702.347323950602, 8860.158284962918, 8935.865962010444, 9001.0, 9095.454272743656, 50074.74813129701, 51822.48177518177, 51864.74067629638, 52404.0, 53010.73494632502, 64820.67589662022, 66115.66942165258, 67982.3201767976, 68374.0, 69509.0, 11019.228653994143, 11163.33020018769, 11192.440377980905, 11217.439128043401, 11480.540778368771, 12076.939615301868, 12081.939590301992, 12269.263844169378, 12509.56216532417, 12560.874391256337, 9384.859227111736, 9426.387284826464, 11810.940945295219, 12178.612996847976, 12751.744965100832, 11808.35054072, 12035.338056406632, 12066.818997715216, 12103.878961210627, 12158.331291779037, 11032.227744057838, 11304.604338848101, 11496.94251528737, 11553.537858485566, 11788.76422471563, 9726.95136524341, 9840.852387214341, 9909.504524773876, 9926.602935882484, 10014.048665376778, 9769.071938165864, 9912.454814984956, 9968.651097211563, 10026.598936042768, 10026.749331266778], "unit": "score", "name": "yui.html", "value": 7071.1180287181605}], "name": "dromaeo_css", "value": 7731.337003428046}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 115.0, 115.0, 114.0, 129.0, 113.0, 115.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [153.0, 120.0, 155.0, 188.0, 151.0, 138.0, 121.0, 151.0, 148.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 144.2}, {"lowerIsBetter": true, "replicates": [189.0, 196.0, 195.0, 210.0, 252.0, 272.0, 207.0, 195.0, 198.0, 192.0], "unit": "score", "name": "audio-dft", "value": 210.6}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 77.0, 111.0, 58.0, 58.0, 57.0, 58.0, 116.0, 56.0], "unit": "score", "name": "audio-fft", "value": 72.2}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 112.0, 77.0, 77.0, 82.0, 114.0, 77.0, 78.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 89.8}, {"lowerIsBetter": true, "replicates": [104.0, 130.0, 88.0, 101.0, 134.0, 116.0, 90.0, 86.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 102.2}, {"lowerIsBetter": true, "replicates": [113.0, 153.0, 151.0, 94.0, 94.0, 103.0, 97.0, 96.0, 130.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 112.7}, {"lowerIsBetter": true, "replicates": [93.0, 91.0, 91.0, 126.0, 141.0, 91.0, 98.0, 116.0, 144.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 108.8}, {"lowerIsBetter": true, "replicates": [48.0, 58.0, 70.0, 53.0, 52.0, 79.0, 48.0, 53.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [65.0, 74.0, 87.0, 92.0, 72.0, 59.0, 81.0, 94.0, 95.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 78.3}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 92.0, 108.0, 73.0, 109.0, 109.0, 110.0, 110.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 94.1}, {"lowerIsBetter": true, "replicates": [127.0, 104.0, 134.0, 127.0, 134.0, 137.0, 118.0, 121.0, 126.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.6}, {"lowerIsBetter": true, "replicates": [126.0, 134.0, 136.0, 133.0, 137.0, 120.0, 136.0, 133.0, 136.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 132.6}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 69.0, 69.0, 69.0, 65.0, 67.0, 67.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1509.9999999999998}]} 11:16:44 INFO - Return code: 0 11:16:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:16:44 ERROR - # TBPL SUCCESS # 11:16:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:16:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:16:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:16:44 INFO - 2016-05-17 11:16:44.827 screenresolution[1693:11831] starting screenresolution argv=screenresolution get 11:16:44 INFO - 2016-05-17 11:16:44.829 screenresolution[1693:11831] Display 0: 1600x1200x32@60 11:16:44 INFO - 2016-05-17 11:16:44.835 screenresolution[1694:11835] starting screenresolution argv=screenresolution list 11:16:44 INFO - Available Modes on Display 0 11:16:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:16:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:16:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:16:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:16:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:16:45 INFO - Intel Iris: 11:16:45 INFO - Chipset Model: Intel Iris 11:16:45 INFO - Type: GPU 11:16:45 INFO - Bus: Built-In 11:16:45 INFO - VRAM (Dynamic, Max): 1536 MB 11:16:45 INFO - Vendor: Intel (0x8086) 11:16:45 INFO - Device ID: 0x0a2e 11:16:45 INFO - Revision ID: 0x0009 11:16:45 INFO - Displays: 11:16:45 INFO - Display: 11:16:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:16:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:16:45 INFO - Display Serial Number: 1600x1200 60 11:16:45 INFO - Main Display: Yes 11:16:45 INFO - Mirror: Off 11:16:45 INFO - Online: Yes 11:16:45 INFO - Rotation: Supported 11:16:45 INFO - Return code: 0 11:16:45 INFO - Running post-action listener: _resource_record_post_action 11:16:45 INFO - Running post-run listener: _resource_record_post_run 11:16:46 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 31976960; Write bytes: 512884736; Read time: 328; Write time: 1607 11:16:46 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 198560256; Write bytes: 197761024; Read time: 17925; Write time: 393 11:16:46 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 30219776; Write bytes: 304281600; Read time: 311; Write time: 1176 11:16:46 INFO - Running post-run listener: _upload_blobber_files 11:16:46 INFO - Blob upload gear active. 11:16:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:16:46 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 11:16:46 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'] 11:16:46 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 11:16:46 INFO - (blobuploader) - INFO - Open directory for files ... 11:16:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:16:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:16:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:16:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:16:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:16:48 INFO - (blobuploader) - INFO - Done attempting. 11:16:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:16:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:16:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:16:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:16:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:16:49 INFO - (blobuploader) - INFO - Done attempting. 11:16:49 INFO - (blobuploader) - INFO - Iteration through files over. 11:16:49 INFO - Return code: 0 11:16:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:16:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:16:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c3379e09ead123287f6e4101e374b1aabaf4c680c6d56abef9d5ed574d86543e627cfc7ff6187f38e780e7205966dc34b071f22ba0ad69bca64de9bccb90fd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a987fac13281d9a9341f05d9703621b4407c165e8d03eb043977a644dec371f3363fe9e79821dc227186cc501fe3a3bb0a6ddaa73de083bba4f1f27e4e651bc0"} 11:16:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:16:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:16:49 INFO - Contents: 11:16:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c3379e09ead123287f6e4101e374b1aabaf4c680c6d56abef9d5ed574d86543e627cfc7ff6187f38e780e7205966dc34b071f22ba0ad69bca64de9bccb90fd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a987fac13281d9a9341f05d9703621b4407c165e8d03eb043977a644dec371f3363fe9e79821dc227186cc501fe3a3bb0a6ddaa73de083bba4f1f27e4e651bc0"} 11:16:49 INFO - Running post-run listener: copy_logs_to_upload_dir 11:16:49 INFO - Copying logs to upload dir... 11:16:49 INFO - mkdir: /builds/slave/test/build/upload/logs 11:16:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.473944 ========= master_lag: 0.99 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-05-17 11:16:50.378330) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:16:50.383146) ========= 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.wVsJLkgye3/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.VLetf35g4g/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c3379e09ead123287f6e4101e374b1aabaf4c680c6d56abef9d5ed574d86543e627cfc7ff6187f38e780e7205966dc34b071f22ba0ad69bca64de9bccb90fd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a987fac13281d9a9341f05d9703621b4407c165e8d03eb043977a644dec371f3363fe9e79821dc227186cc501fe3a3bb0a6ddaa73de083bba4f1f27e4e651bc0"} build_url:https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011132 build_url: 'https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c3379e09ead123287f6e4101e374b1aabaf4c680c6d56abef9d5ed574d86543e627cfc7ff6187f38e780e7205966dc34b071f22ba0ad69bca64de9bccb90fd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a987fac13281d9a9341f05d9703621b4407c165e8d03eb043977a644dec371f3363fe9e79821dc227186cc501fe3a3bb0a6ddaa73de083bba4f1f27e4e651bc0"}' ========= master_lag: 0.81 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:16:51.201068) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:16:51.201462) ========= 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.wVsJLkgye3/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.VLetf35g4g/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.005129 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:16:51.230579) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:16:51.230911) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:16:51.232428) ========= ========= Total master_lag: 1.92 =========