builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0343 starttime: 1467102336.68 results: success (0) buildid: 20160627053125 builduid: 91d531b5383642ed8679b7f776c5ef70 revision: 8664ad5c52883cb66cb9b46879eb062fb6600756 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:36.681398) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:36.681816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:36.682160) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:36.706672) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:36.706959) ========= 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.E4NAAeDxLR/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.S7oxffyII8/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-28 01:25:36-- 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% 154M=0s 2016-06-28 01:25:36 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091499 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:36.820176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:36.820490) ========= 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.E4NAAeDxLR/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.S7oxffyII8/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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.026961 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:36.868824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 01:25:36.869155) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8664ad5c52883cb66cb9b46879eb062fb6600756 --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 8664ad5c52883cb66cb9b46879eb062fb6600756 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.E4NAAeDxLR/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.S7oxffyII8/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-28 01:25:36,951 truncating revision to first 12 chars 2016-06-28 01:25:36,951 Setting DEBUG logging. 2016-06-28 01:25:36,951 attempt 1/10 2016-06-28 01:25:36,951 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8664ad5c5288?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 01:25:38,342 unpacking tar archive at: mozilla-beta-8664ad5c5288/testing/mozharness/ program finished with exit code 0 elapsedTime=1.661311 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 01:25:38.553579) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:38.553895) ========= script_repo_revision: 8664ad5c52883cb66cb9b46879eb062fb6600756 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:38.554326) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:38.554587) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:38.573388) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 36 secs) (at 2016-06-28 01:25:38.573774) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.E4NAAeDxLR/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.S7oxffyII8/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 01:25:38 INFO - MultiFileLogger online at 20160628 01:25:38 in /builds/slave/test 01:25:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 01:25:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:25:38 INFO - {'append_to_log': False, 01:25:38 INFO - 'base_work_dir': '/builds/slave/test', 01:25:38 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:25:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:25:38 INFO - 'branch': 'Mozilla-Beta', 01:25:38 INFO - 'buildbot_json_path': 'buildprops.json', 01:25:38 INFO - 'config_files': ('talos/mac_config.py',), 01:25:38 INFO - 'default_actions': ('clobber', 01:25:38 INFO - 'read-buildbot-config', 01:25:38 INFO - 'download-and-extract', 01:25:38 INFO - 'populate-webroot', 01:25:38 INFO - 'create-virtualenv', 01:25:38 INFO - 'install', 01:25:38 INFO - 'run-tests'), 01:25:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:25:38 INFO - 'download_minidump_stackwalk': True, 01:25:38 INFO - 'download_symbols': 'ondemand', 01:25:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:25:38 INFO - 'tooltool.py': '/tools/tooltool.py', 01:25:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:25:38 INFO - '/tools/misc-python/virtualenv.py')}, 01:25:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:25:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:25:38 INFO - 'installer_path': 'installer.exe', 01:25:38 INFO - 'log_level': 'info', 01:25:38 INFO - 'log_name': 'talos', 01:25:38 INFO - 'log_to_console': True, 01:25:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:25:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:25:38 INFO - 'opt_config_files': (), 01:25:38 INFO - 'pip_index': False, 01:25:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:25:38 INFO - 'cmd': ('bash', 01:25:38 INFO - '-c', 01:25:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:25:38 INFO - 'enabled': True, 01:25:38 INFO - 'halt_on_failure': False, 01:25:38 INFO - 'name': 'check_screen_resolution'},), 01:25:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:25:38 INFO - 'cmd': ('bash', 01:25:38 INFO - '-c', 01:25:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:25:38 INFO - 'enabled': True, 01:25:38 INFO - 'halt_on_failure': False, 01:25:38 INFO - 'name': 'check_screen_resolution'},), 01:25:38 INFO - 'run_cmd_checks_enabled': True, 01:25:38 INFO - 'sps_profile': False, 01:25:38 INFO - 'sps_profile_interval': 0, 01:25:38 INFO - 'suite': 'dromaeojs', 01:25:38 INFO - 'system_bits': '32', 01:25:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:25:38 INFO - 'title': 't-yosemite-r7-0343', 01:25:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:25:38 INFO - 'use_talos_json': True, 01:25:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:25:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:25:38 INFO - 'work_dir': 'build'} 01:25:38 INFO - ##### 01:25:38 INFO - ##### Running clobber step. 01:25:38 INFO - ##### 01:25:38 INFO - Running pre-action listener: _resource_record_pre_action 01:25:38 INFO - Running main action method: clobber 01:25:38 INFO - rmtree: /builds/slave/test/build 01:25:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:25:40 INFO - Running post-action listener: _resource_record_post_action 01:25:40 INFO - ##### 01:25:40 INFO - ##### Running read-buildbot-config step. 01:25:40 INFO - ##### 01:25:40 INFO - Running pre-action listener: _resource_record_pre_action 01:25:40 INFO - Running main action method: read_buildbot_config 01:25:40 INFO - Using buildbot properties: 01:25:40 INFO - { 01:25:40 INFO - "project": "", 01:25:40 INFO - "product": "firefox", 01:25:40 INFO - "script_repo_revision": "production", 01:25:40 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 01:25:40 INFO - "repository": "", 01:25:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 01:25:40 INFO - "buildid": "20160627053125", 01:25:40 INFO - "pgo_build": "False", 01:25:40 INFO - "basedir": "/builds/slave/test", 01:25:40 INFO - "buildnumber": 16, 01:25:40 INFO - "slavename": "t-yosemite-r7-0343", 01:25:40 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 01:25:40 INFO - "platform": "yosemite_r7", 01:25:40 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 01:25:40 INFO - "branch": "mozilla-beta", 01:25:40 INFO - "repo_path": "releases/mozilla-beta", 01:25:40 INFO - "revision": "8664ad5c52883cb66cb9b46879eb062fb6600756", 01:25:40 INFO - "stage_platform": "macosx64", 01:25:40 INFO - "builduid": "91d531b5383642ed8679b7f776c5ef70", 01:25:40 INFO - "slavebuilddir": "test" 01:25:40 INFO - } 01:25:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 01:25:40 INFO - Running post-action listener: _resource_record_post_action 01:25:40 INFO - ##### 01:25:40 INFO - ##### Running download-and-extract step. 01:25:40 INFO - ##### 01:25:40 INFO - Running pre-action listener: _resource_record_pre_action 01:25:40 INFO - Running main action method: download_and_extract 01:25:40 INFO - mkdir: /builds/slave/test/build/tests 01:25:40 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')]} 01:25:40 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:25:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:25:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:25:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:25:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 01:25:42 INFO - Downloaded 1165 bytes. 01:25:42 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:25:42 INFO - Using the following test package requirements: 01:25:42 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:25:42 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:25:42 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 01:25:42 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:25:42 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 01:25:42 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 01:25:42 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:25:42 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 01:25:42 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:25:42 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:25:42 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 01:25:42 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:25:42 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 01:25:42 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:25:42 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 01:25:42 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:25:42 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 01:25:42 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 01:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:42 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:25:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:25:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:25:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 01:25:43 INFO - Downloaded 18344127 bytes. 01:25:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:25:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:25:46 INFO - Return code: 0 01:25:46 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 01:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:46 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:25:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:25:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:25:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:25:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 01:25:47 INFO - Downloaded 18344127 bytes. 01:25:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:25:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:25:50 INFO - Return code: 0 01:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:50 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:25:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:25:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:25:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 01:25:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 01:25:51 INFO - Downloaded 10840145 bytes. 01:25:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:25:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:25:52 INFO - Return code: 0 01:25: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')]} 01:25:52 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 01:25:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:25:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:25:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 01:25:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 01:25:54 INFO - Downloaded 86228614 bytes. 01:25:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:25:54 INFO - mkdir: /builds/slave/test/properties 01:25:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:25:54 INFO - Writing to file /builds/slave/test/properties/build_url 01:25:54 INFO - Contents: 01:25:54 INFO - build_url:https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:25:55 INFO - Running post-action listener: _resource_record_post_action 01:25:55 INFO - Running post-action listener: set_extra_try_arguments 01:25:55 INFO - ##### 01:25:55 INFO - ##### Running populate-webroot step. 01:25:55 INFO - ##### 01:25:55 INFO - Running pre-action listener: _resource_record_pre_action 01:25:55 INFO - Running main action method: populate_webroot 01:25:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:25:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:25:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:25:55 INFO - '--tppagecycles', 01:25:55 INFO - '7'], 01:25:55 INFO - 'tests': ['tsvgm']}}, 01:25:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:25:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:25:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:25:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:25:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:25:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:25:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:55 INFO - 'talos_options': ['--disable-e10s'], 01:25:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:55 INFO - 'talos_options': ['--disable-e10s'], 01:25:55 INFO - 'tests': ['damp', 'tps']}, 01:25:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:55 INFO - 'tests': ['damp', 'tps']}, 01:25:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:25:55 INFO - 'tests': ['dromaeo_dom']}, 01:25:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:25:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:25:55 INFO - 'tests': ['a11yr', 01:25:55 INFO - 'ts_paint', 01:25:55 INFO - 'tpaint', 01:25:55 INFO - 'sessionrestore', 01:25:55 INFO - 'sessionrestore_no_auto_restore', 01:25:55 INFO - 'tabpaint']}, 01:25:55 INFO - 'other-e10s': {'tests': ['a11yr', 01:25:55 INFO - 'ts_paint', 01:25:55 INFO - 'tpaint', 01:25:55 INFO - 'sessionrestore', 01:25:55 INFO - 'sessionrestore_no_auto_restore', 01:25:55 INFO - 'tabpaint']}, 01:25:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:25:55 INFO - 'ts_paint', 01:25:55 INFO - 'tpaint', 01:25:55 INFO - 'sessionrestore', 01:25:55 INFO - 'sessionrestore_no_auto_restore', 01:25:55 INFO - 'tabpaint']}, 01:25:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:25:55 INFO - 'ts_paint', 01:25:55 INFO - 'tpaint', 01:25:55 INFO - 'sessionrestore', 01:25:55 INFO - 'sessionrestore_no_auto_restore', 01:25:55 INFO - 'tabpaint']}, 01:25:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:25:55 INFO - 'tests': ['a11yr', 01:25:55 INFO - 'ts_paint', 01:25:55 INFO - 'tpaint', 01:25:55 INFO - 'sessionrestore', 01:25:55 INFO - 'sessionrestore_no_auto_restore', 01:25:55 INFO - 'tabpaint']}, 01:25:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:25:55 INFO - 'tests': ['a11yr', 01:25:55 INFO - 'ts_paint', 01:25:55 INFO - 'tpaint', 01:25:55 INFO - 'sessionrestore', 01:25:55 INFO - 'sessionrestore_no_auto_restore', 01:25:55 INFO - 'tabpaint']}, 01:25:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:25:55 INFO - 'tests': ['tsvgx', 01:25:55 INFO - 'tsvgr_opacity', 01:25:55 INFO - 'tart', 01:25:55 INFO - 'tscrollx', 01:25:55 INFO - 'cart']}, 01:25:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:25:55 INFO - 'tsvgr_opacity', 01:25:55 INFO - 'tart', 01:25:55 INFO - 'tscrollx', 01:25:55 INFO - 'cart']}, 01:25:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:55 INFO - 'talos_options': ['--disable-e10s'], 01:25:55 INFO - 'tests': ['tp5o']}, 01:25:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:55 INFO - 'tests': ['tp5o']}, 01:25:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:55 INFO - 'talos_options': ['--disable-e10s', 01:25:55 INFO - '--xperf_path', 01:25:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:55 INFO - 'tests': ['tp5n']}, 01:25:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:55 INFO - 'talos_options': ['--xperf_path', 01:25:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:55 INFO - 'tests': ['tp5n']}}, 01:25:55 INFO - 'talos.zip': {'path': '', 01:25:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:25:55 INFO - Running post-action listener: _resource_record_post_action 01:25:55 INFO - ##### 01:25:55 INFO - ##### Running create-virtualenv step. 01:25:55 INFO - ##### 01:25:55 INFO - Running pre-action listener: _resource_record_pre_action 01:25:55 INFO - Running main action method: create_virtualenv 01:25:55 INFO - Creating virtualenv /builds/slave/test/build/venv 01:25:55 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 01:25:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:25:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:25:55 INFO - Using real prefix '/tools/python27' 01:25:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:25:56 INFO - Installing distribute.............................................................................................................................................................................................done. 01:25:59 INFO - Installing pip.................done. 01:25:59 INFO - Return code: 0 01:25:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:59 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 0x1021d1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021e1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b85876d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102070e00>, '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 0x101ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10206bb20>, '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.E4NAAeDxLR/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.S7oxffyII8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 01:25:59 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 01:25:59 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 01:25:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E4NAAeDxLR/Render', 01:25:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:25:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:25:59 INFO - 'HOME': '/Users/cltbld', 01:25:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:25:59 INFO - 'LOGNAME': 'cltbld', 01:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:59 INFO - 'MOZ_NO_REMOTE': '1', 01:25:59 INFO - 'NO_EM_RESTART': '1', 01:25:59 INFO - 'PAGER': '/bin/cat', 01:25:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:59 INFO - 'PWD': '/builds/slave/test', 01:25:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:25:59 INFO - 'SHELL': '/bin/bash', 01:25:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S7oxffyII8/Listeners', 01:25:59 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 01:25:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:25:59 INFO - 'USER': 'cltbld', 01:25:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:25:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:59 INFO - 'XPC_FLAGS': '0x0', 01:25:59 INFO - 'XPC_SERVICE_NAME': '0', 01:25:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:59 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 01:25:59 INFO - Cleaning up... 01:25:59 INFO - Return code: 0 01:25:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:59 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 0x1021d1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021e1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b85876d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102070e00>, '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 0x101ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10206bb20>, '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.E4NAAeDxLR/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.S7oxffyII8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 01:25:59 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 01:25:59 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 01:25:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E4NAAeDxLR/Render', 01:25:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:25:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:25:59 INFO - 'HOME': '/Users/cltbld', 01:25:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:25:59 INFO - 'LOGNAME': 'cltbld', 01:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:59 INFO - 'MOZ_NO_REMOTE': '1', 01:25:59 INFO - 'NO_EM_RESTART': '1', 01:25:59 INFO - 'PAGER': '/bin/cat', 01:25:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:59 INFO - 'PWD': '/builds/slave/test', 01:25:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:25:59 INFO - 'SHELL': '/bin/bash', 01:25:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S7oxffyII8/Listeners', 01:25:59 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 01:25:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:25:59 INFO - 'USER': 'cltbld', 01:25:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:25:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:59 INFO - 'XPC_FLAGS': '0x0', 01:25:59 INFO - 'XPC_SERVICE_NAME': '0', 01:25:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:59 INFO - Downloading/unpacking psutil>=0.7.1 01:25:59 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 01:25:59 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 01:25:59 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 01:25:59 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 01:25:59 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 01:25:59 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 01:26:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:26:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:02 INFO - Installing collected packages: psutil 01:26:02 INFO - Running setup.py install for psutil 01:26:02 INFO - building 'psutil._psutil_osx' extension 01:26:02 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 01:26:03 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 01:26:03 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 01:26:03 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 01:26:03 INFO - building 'psutil._psutil_posix' extension 01:26:03 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 01:26:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:26:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:26:03 INFO - ^ 01:26:03 INFO - 1 warning generated. 01:26:03 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 01:26:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:03 INFO - Successfully installed psutil 01:26:03 INFO - Cleaning up... 01:26:03 INFO - Return code: 0 01:26:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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')]} 01:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:03 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 0x1021d1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021e1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b85876d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102070e00>, '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 0x101ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10206bb20>, '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.E4NAAeDxLR/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.S7oxffyII8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 01:26:03 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 01:26:03 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 01:26:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E4NAAeDxLR/Render', 01:26:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:03 INFO - 'HOME': '/Users/cltbld', 01:26:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:03 INFO - 'LOGNAME': 'cltbld', 01:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:03 INFO - 'MOZ_NO_REMOTE': '1', 01:26:03 INFO - 'NO_EM_RESTART': '1', 01:26:03 INFO - 'PAGER': '/bin/cat', 01:26:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:03 INFO - 'PWD': '/builds/slave/test', 01:26:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:03 INFO - 'SHELL': '/bin/bash', 01:26:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S7oxffyII8/Listeners', 01:26:03 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 01:26:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:03 INFO - 'USER': 'cltbld', 01:26:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:03 INFO - 'XPC_FLAGS': '0x0', 01:26:03 INFO - 'XPC_SERVICE_NAME': '0', 01:26:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:26:03 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 01:26:03 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 01:26:03 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 01:26:03 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 01:26:03 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 01:26:03 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 01:26:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:26:06 INFO - Installing collected packages: mozsystemmonitor 01:26:06 INFO - Running setup.py install for mozsystemmonitor 01:26:06 INFO - Successfully installed mozsystemmonitor 01:26:06 INFO - Cleaning up... 01:26:06 INFO - Return code: 0 01:26:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:26:06 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')]} 01:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:06 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')]} 01:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:06 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 0x1021d1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021e1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b85876d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102070e00>, '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 0x101ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10206bb20>, '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.E4NAAeDxLR/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.S7oxffyII8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 01:26:06 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 01:26:06 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 01:26:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E4NAAeDxLR/Render', 01:26:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:06 INFO - 'HOME': '/Users/cltbld', 01:26:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:06 INFO - 'LOGNAME': 'cltbld', 01:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:06 INFO - 'MOZ_NO_REMOTE': '1', 01:26:06 INFO - 'NO_EM_RESTART': '1', 01:26:06 INFO - 'PAGER': '/bin/cat', 01:26:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:06 INFO - 'PWD': '/builds/slave/test', 01:26:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:06 INFO - 'SHELL': '/bin/bash', 01:26:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S7oxffyII8/Listeners', 01:26:06 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 01:26:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:06 INFO - 'USER': 'cltbld', 01:26:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:06 INFO - 'XPC_FLAGS': '0x0', 01:26:06 INFO - 'XPC_SERVICE_NAME': '0', 01:26:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:06 INFO - Downloading/unpacking blobuploader==1.2.4 01:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:09 INFO - Downloading blobuploader-1.2.4.tar.gz 01:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:26:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:26:09 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 01:26:09 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 01:26:09 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 01:26:09 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 01:26:09 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 01:26:09 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 01:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:26:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:26:09 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 01:26:09 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 01:26:09 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 01:26:09 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 01:26:09 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 01:26:09 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 01:26:10 INFO - Downloading docopt-0.6.1.tar.gz 01:26:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:26:10 INFO - Installing collected packages: blobuploader, requests, docopt 01:26:10 INFO - Running setup.py install for blobuploader 01:26:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:26:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:26:10 INFO - Running setup.py install for requests 01:26:11 INFO - Running setup.py install for docopt 01:26:11 INFO - Successfully installed blobuploader requests docopt 01:26:11 INFO - Cleaning up... 01:26:11 INFO - Return code: 0 01:26:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26:11 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')]} 01:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:11 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')]} 01:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:11 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 0x1021d1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021e1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b85876d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102070e00>, '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 0x101ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10206bb20>, '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.E4NAAeDxLR/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.S7oxffyII8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 01:26:11 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 01:26:11 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 01:26:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E4NAAeDxLR/Render', 01:26:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:11 INFO - 'HOME': '/Users/cltbld', 01:26:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:11 INFO - 'LOGNAME': 'cltbld', 01:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:11 INFO - 'MOZ_NO_REMOTE': '1', 01:26:11 INFO - 'NO_EM_RESTART': '1', 01:26:11 INFO - 'PAGER': '/bin/cat', 01:26:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:11 INFO - 'PWD': '/builds/slave/test', 01:26:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:11 INFO - 'SHELL': '/bin/bash', 01:26:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S7oxffyII8/Listeners', 01:26:11 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 01:26:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:11 INFO - 'USER': 'cltbld', 01:26:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:11 INFO - 'XPC_FLAGS': '0x0', 01:26:11 INFO - 'XPC_SERVICE_NAME': '0', 01:26:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:26:11 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-Qby3OY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:26:11 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-3_RLhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:26:11 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-bi4wvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:26:11 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-pnFfpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:26:12 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-vdCgx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:26:12 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-vvaKOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:26:12 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-kfbtPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:26:12 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-Pz_Tta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:26:12 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-h_azzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:26:12 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-hybSQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:26:12 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-seyF21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:26:12 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-f48BjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:26:12 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-v5O2S1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:26:13 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-Rew7OJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:13 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-FoSsA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:26:13 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-S4MZtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:26:13 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-zZRLXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:26:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:26:13 INFO - Running setup.py install for manifestparser 01:26:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:26:13 INFO - Running setup.py install for mozcrash 01:26:13 INFO - Running setup.py install for mozdebug 01:26:13 INFO - Running setup.py install for mozdevice 01:26:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for mozfile 01:26:14 INFO - Running setup.py install for mozhttpd 01:26:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for mozinfo 01:26:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for mozInstall 01:26:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for mozleak 01:26:14 INFO - Running setup.py install for mozlog 01:26:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for moznetwork 01:26:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Running setup.py install for mozprocess 01:26:15 INFO - Running setup.py install for mozprofile 01:26:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Running setup.py install for mozrunner 01:26:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Running setup.py install for mozscreenshot 01:26:15 INFO - Running setup.py install for moztest 01:26:15 INFO - Running setup.py install for mozversion 01:26:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:26:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:26:16 INFO - Cleaning up... 01:26:16 INFO - Return code: 0 01:26:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26:16 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')]} 01:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:16 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')]} 01:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:16 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 0x1021d1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021e1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b85876d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102070e00>, '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 0x101ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10206bb20>, '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.E4NAAeDxLR/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.S7oxffyII8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 01:26:16 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 01:26:16 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 01:26:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E4NAAeDxLR/Render', 01:26:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:16 INFO - 'HOME': '/Users/cltbld', 01:26:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:16 INFO - 'LOGNAME': 'cltbld', 01:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:16 INFO - 'MOZ_NO_REMOTE': '1', 01:26:16 INFO - 'NO_EM_RESTART': '1', 01:26:16 INFO - 'PAGER': '/bin/cat', 01:26:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:16 INFO - 'PWD': '/builds/slave/test', 01:26:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:16 INFO - 'SHELL': '/bin/bash', 01:26:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S7oxffyII8/Listeners', 01:26:16 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 01:26:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:16 INFO - 'USER': 'cltbld', 01:26:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:16 INFO - 'XPC_FLAGS': '0x0', 01:26:16 INFO - 'XPC_SERVICE_NAME': '0', 01:26:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:26:16 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-v0DwJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:26:16 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-iX4ff4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:26:16 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-unssDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:26:16 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-QEHVgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:26:16 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-l_AXKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:26:16 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-RWmlpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:26:16 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-VnJx3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:26:17 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-u_xoOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:26:17 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-QoUxsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:26:17 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-PdnO9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:26:17 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-sPBKhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:26:17 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-K7PZom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:26:17 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-aD6xWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:26:17 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-iSU8b9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:17 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-1Aglje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:26:17 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-3lMEVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:26:18 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)) 01:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:26:18 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-VD_pAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:26:18 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)) 01:26:18 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)) 01:26:18 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)) 01:26:18 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)) 01:26:18 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)) 01:26:18 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)) 01:26:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:26:18 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 01:26:18 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 01:26:18 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 01:26:18 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 01:26:18 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 01:26:18 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 01:26:20 INFO - Downloading blessings-1.6.tar.gz 01:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:26:20 INFO - Installing collected packages: blessings 01:26:20 INFO - Running setup.py install for blessings 01:26:20 INFO - Successfully installed blessings 01:26:20 INFO - Cleaning up... 01:26:20 INFO - Return code: 0 01:26:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:26:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:26:21 INFO - Reading from file tmpfile_stdout 01:26:21 INFO - Current package versions: 01:26:21 INFO - blessings == 1.6 01:26:21 INFO - blobuploader == 1.2.4 01:26:21 INFO - docopt == 0.6.1 01:26:21 INFO - manifestparser == 1.1 01:26:21 INFO - mozInstall == 1.12 01:26:21 INFO - mozcrash == 0.17 01:26:21 INFO - mozdebug == 0.1 01:26:21 INFO - mozdevice == 0.48 01:26:21 INFO - mozfile == 1.2 01:26:21 INFO - mozhttpd == 0.7 01:26:21 INFO - mozinfo == 0.9 01:26:21 INFO - mozleak == 0.1 01:26:21 INFO - mozlog == 3.1 01:26:21 INFO - moznetwork == 0.27 01:26:21 INFO - mozprocess == 0.22 01:26:21 INFO - mozprofile == 0.28 01:26:21 INFO - mozrunner == 6.11 01:26:21 INFO - mozscreenshot == 0.1 01:26:21 INFO - mozsystemmonitor == 0.0 01:26:21 INFO - moztest == 0.7 01:26:21 INFO - mozversion == 1.4 01:26:21 INFO - psutil == 3.1.1 01:26:21 INFO - requests == 1.2.3 01:26:21 INFO - wsgiref == 0.1.2 01:26:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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')]} 01:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:21 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 0x1021d1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021e1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b85876d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102070e00>, '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 0x101ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10206bb20>, '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.E4NAAeDxLR/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.S7oxffyII8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 01:26:21 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 01:26:21 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 01:26:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E4NAAeDxLR/Render', 01:26:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:21 INFO - 'HOME': '/Users/cltbld', 01:26:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:21 INFO - 'LOGNAME': 'cltbld', 01:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:21 INFO - 'MOZ_NO_REMOTE': '1', 01:26:21 INFO - 'NO_EM_RESTART': '1', 01:26:21 INFO - 'PAGER': '/bin/cat', 01:26:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:21 INFO - 'PWD': '/builds/slave/test', 01:26:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:21 INFO - 'SHELL': '/bin/bash', 01:26:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S7oxffyII8/Listeners', 01:26:21 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 01:26:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:21 INFO - 'USER': 'cltbld', 01:26:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:21 INFO - 'XPC_FLAGS': '0x0', 01:26:21 INFO - 'XPC_SERVICE_NAME': '0', 01:26:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:21 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)) 01:26:21 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)) 01:26:21 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)) 01:26:21 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)) 01:26:21 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)) 01:26:21 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)) 01:26:21 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)) 01:26:21 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)) 01:26:21 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)) 01:26:21 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)) 01:26:21 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)) 01:26:21 INFO - Cleaning up... 01:26:21 INFO - Return code: 0 01:26:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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')]} 01:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1021d1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021e1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b85876d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102070e00>, '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 0x101ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10206bb20>, '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.E4NAAeDxLR/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.S7oxffyII8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 01:26: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', 'jsonschema'] in /builds/slave/test/build 01:26: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 jsonschema 01:26:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E4NAAeDxLR/Render', 01:26:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:21 INFO - 'HOME': '/Users/cltbld', 01:26:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:21 INFO - 'LOGNAME': 'cltbld', 01:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:21 INFO - 'MOZ_NO_REMOTE': '1', 01:26:21 INFO - 'NO_EM_RESTART': '1', 01:26:21 INFO - 'PAGER': '/bin/cat', 01:26:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:21 INFO - 'PWD': '/builds/slave/test', 01:26:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:21 INFO - 'SHELL': '/bin/bash', 01:26:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S7oxffyII8/Listeners', 01:26:21 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 01:26:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:21 INFO - 'USER': 'cltbld', 01:26:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:21 INFO - 'XPC_FLAGS': '0x0', 01:26:21 INFO - 'XPC_SERVICE_NAME': '0', 01:26:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:21 INFO - Downloading/unpacking jsonschema 01:26:21 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 01:26:21 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 01:26:21 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 01:26:21 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 01:26:21 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 01:26:21 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 01:26:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:26:24 INFO - Downloading/unpacking functools32 (from jsonschema) 01:26:24 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 01:26:24 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 01:26:24 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 01:26:24 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 01:26:24 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 01:26:24 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 01:26:24 INFO - Downloading functools32-3.2.3-2.tar.gz 01:26:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:26:24 INFO - warning: no files found matching '*.txt' 01:26:24 INFO - no previously-included directories found matching 'build' 01:26:24 INFO - no previously-included directories found matching 'dist' 01:26:24 INFO - no previously-included directories found matching '.git*' 01:26:24 INFO - Installing collected packages: jsonschema, functools32 01:26:24 INFO - Running setup.py install for functools32 01:26:24 INFO - warning: no files found matching '*.txt' 01:26:24 INFO - no previously-included directories found matching 'build' 01:26:24 INFO - no previously-included directories found matching 'dist' 01:26:24 INFO - no previously-included directories found matching '.git*' 01:26:24 INFO - Successfully installed jsonschema functools32 01:26:24 INFO - Cleaning up... 01:26:25 INFO - Return code: 0 01:26:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1021d1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021e1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b85876d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102070e00>, '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 0x101ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10206bb20>, '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.E4NAAeDxLR/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.S7oxffyII8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 01:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:26:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E4NAAeDxLR/Render', 01:26:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:25 INFO - 'HOME': '/Users/cltbld', 01:26:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:25 INFO - 'LOGNAME': 'cltbld', 01:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:25 INFO - 'MOZ_NO_REMOTE': '1', 01:26:25 INFO - 'NO_EM_RESTART': '1', 01:26:25 INFO - 'PAGER': '/bin/cat', 01:26:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:25 INFO - 'PWD': '/builds/slave/test', 01:26:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:25 INFO - 'SHELL': '/bin/bash', 01:26:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S7oxffyII8/Listeners', 01:26:25 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 01:26:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:25 INFO - 'USER': 'cltbld', 01:26:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:25 INFO - 'XPC_FLAGS': '0x0', 01:26:25 INFO - 'XPC_SERVICE_NAME': '0', 01:26:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:25 INFO - Downloading/unpacking flake8 01:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:26:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:26: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 01:26: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 01:26: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 01:26: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 01:26: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 01:26: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 01:26:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:26:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:26:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:26:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:26:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:26:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:26:29 INFO - no previously-included directories found matching 'docs/_build' 01:26:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:26:29 INFO - Running setup.py install for pep8 01:26:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:26:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:26:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:26:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:26:29 INFO - no previously-included directories found matching 'docs/_build' 01:26:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:26:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:26:29 INFO - Cleaning up... 01:26:29 INFO - Return code: 0 01:26:29 INFO - Running post-action listener: _resource_record_post_action 01:26:29 INFO - Running post-action listener: _start_resource_monitoring 01:26:29 INFO - Starting resource monitoring. 01:26:29 INFO - ##### 01:26:29 INFO - ##### Running install step. 01:26:29 INFO - ##### 01:26:29 INFO - Running pre-action listener: _resource_record_pre_action 01:26:29 INFO - Running main action method: install 01:26:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:26:29 INFO - Reading from file tmpfile_stdout 01:26:29 INFO - Detecting whether we're running mozinstall >=1.0... 01:26:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:26:29 INFO - Reading from file tmpfile_stdout 01:26:29 INFO - Output received: 01:26:29 INFO - Usage: mozinstall [options] installer 01:26:29 INFO - Options: 01:26:29 INFO - -h, --help show this help message and exit 01:26:29 INFO - -d DEST, --destination=DEST 01:26:29 INFO - Directory to install application into. [default: 01:26:29 INFO - "/builds/slave/test"] 01:26:29 INFO - --app=APP Application being installed. [default: firefox] 01:26:29 INFO - mkdir: /builds/slave/test/build/application 01:26:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 01:26:51 INFO - Reading from file tmpfile_stdout 01:26:51 INFO - Output received: 01:26:51 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 01:26:51 INFO - Running post-action listener: _resource_record_post_action 01:26:51 INFO - ##### 01:26:51 INFO - ##### Running run-tests step. 01:26:51 INFO - ##### 01:26:51 INFO - Running pre-action listener: _resource_record_pre_action 01:26:51 INFO - Running main action method: run_tests 01:26:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:26:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:26:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:26:51 INFO - 2016-06-28 01:26:51.525 screenresolution[1644:7314] starting screenresolution argv=screenresolution get 01:26:51 INFO - 2016-06-28 01:26:51.527 screenresolution[1644:7314] Display 0: 1600x1200x32@60 01:26:51 INFO - 2016-06-28 01:26:51.533 screenresolution[1645:7316] starting screenresolution argv=screenresolution list 01:26:51 INFO - Available Modes on Display 0 01:26:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:26:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:26:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:26:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:26:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:26:51 INFO - Intel Iris: 01:26:51 INFO - Chipset Model: Intel Iris 01:26:51 INFO - Type: GPU 01:26:51 INFO - Bus: Built-In 01:26:51 INFO - VRAM (Dynamic, Max): 1536 MB 01:26:51 INFO - Vendor: Intel (0x8086) 01:26:51 INFO - Device ID: 0x0a2e 01:26:51 INFO - Revision ID: 0x0009 01:26:51 INFO - Displays: 01:26:51 INFO - Display: 01:26:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:26:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:26:51 INFO - Display Serial Number: 1600x1200 60 01:26:51 INFO - Main Display: Yes 01:26:51 INFO - Mirror: Off 01:26:51 INFO - Online: Yes 01:26:51 INFO - Rotation: Supported 01:26:51 INFO - Return code: 0 01:26:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:26:51 INFO - Python 2.7.3 01:26:51 INFO - Return code: 0 01:26:51 INFO - grabbing minidump binary from tooltool 01:26:51 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')]} 01:26:51 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 0x102070e00>, '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 0x101ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10206bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:26:51 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 01:26:51 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 01:26:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:26:51 INFO - Return code: 0 01:26:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:26:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:26:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:26:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:26:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:26:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:26:52 INFO - Return code: 0 01:26:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0343', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0343 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:26:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E4NAAeDxLR/Render', 01:26:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:52 INFO - 'HOME': '/Users/cltbld', 01:26:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:52 INFO - 'LOGNAME': 'cltbld', 01:26:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:26:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:52 INFO - 'MOZ_NO_REMOTE': '1', 01:26:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:26:52 INFO - 'NO_EM_RESTART': '1', 01:26:52 INFO - 'PAGER': '/bin/cat', 01:26:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:52 INFO - 'PWD': '/builds/slave/test', 01:26:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:26:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:52 INFO - 'SHELL': '/bin/bash', 01:26:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S7oxffyII8/Listeners', 01:26:52 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 01:26:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:52 INFO - 'USER': 'cltbld', 01:26:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:52 INFO - 'XPC_FLAGS': '0x0', 01:26:52 INFO - 'XPC_SERVICE_NAME': '0', 01:26:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0343', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:26:53 INFO - mozversion application_buildid: 20160627053125 01:26:53 INFO - mozversion application_changeset: 8664ad5c52883cb66cb9b46879eb062fb6600756 01:26:53 INFO - mozversion application_display_name: Firefox 01:26:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:26:53 INFO - mozversion application_name: Firefox 01:26:53 INFO - mozversion application_remotingname: firefox 01:26:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:26:53 INFO - mozversion application_vendor: Mozilla 01:26:53 INFO - mozversion application_version: 48.0 01:26:53 INFO - mozversion platform_buildid: 20160627053125 01:26:53 INFO - mozversion platform_changeset: 8664ad5c52883cb66cb9b46879eb062fb6600756 01:26:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:26:53 INFO - mozversion platform_version: 48.0 01:26:53 INFO - using testdate: 1467102413 01:26:53 INFO - actual date: 1467102413 01:26:53 INFO - starting webserver on 'localhost:49273' 01:26:53 INFO - SUITE-START | Running 2 tests 01:26:53 INFO - TEST-START | dromaeo_css 01:26:53 INFO - operating with platform_type : mac_ 01:26:53 INFO - Initialising browser for dromaeo_css test... 01:26:53 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpanWCwt/profile http://localhost:49273/getInfo.html) 01:26:55 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 01:26:55 INFO - PROCESS | 1663 | colorDepth:24 01:26:55 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 01:26:55 INFO - PROCESS | 1663 | __metrics 01:26:55 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:26:55 ERROR - PROCESS | 1663 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:26:56 INFO - TEST-INFO | 1663: exit 0 01:26:56 INFO - Browser initialized. 01:26:56 INFO - Running cycle 1/1 for dromaeo_css test... 01:26:56 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpanWCwt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:27:08 INFO - PROCESS | 1666 | RSS: Main: 161325056 01:27:08 INFO - PROCESS | 1666 | 01:27:59 INFO - PROCESS | 1666 | 1467102479496 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] 01:30:09 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 01:30:11 INFO - PROCESS | 1666 | RSS: Main: 303362048 01:30:11 INFO - PROCESS | 1666 | 01:33:13 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 01:33:14 INFO - PROCESS | 1666 | RSS: Main: 303202304 01:33:14 INFO - PROCESS | 1666 | 01:36:16 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 01:36:16 INFO - PROCESS | 1666 | RSS: Main: 312053760 01:36:16 INFO - PROCESS | 1666 | 01:39:18 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 01:39:19 INFO - PROCESS | 1666 | RSS: Main: 304803840 01:39:19 INFO - PROCESS | 1666 | 01:42:22 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 01:42:23 INFO - PROCESS | 1666 | RSS: Main: 274685952 01:42:23 INFO - PROCESS | 1666 | 01:45:25 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 01:45:26 INFO - PROCESS | 1666 | RSS: Main: 316809216 01:45:26 INFO - PROCESS | 1666 | 01:45:26 INFO - PROCESS | 1666 | __start_tp_report 01:45:26 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 01:45:26 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 01:45:26 INFO - PROCESS | 1666 | |i|pagename|runs| 01:45:26 INFO - PROCESS | 1666 | |0;dojo.html;3595.209054008118;3605.0807044203725;3624.8006359650226;3630.5280313559233;3690.0221441318054;4546.659000574962;5567.192757050226;5877.853053673661;5881.382454842239;5929.34777174511;5887.587868849182;5923.644581325124;5930.199423077883;5956.731947062382;5959.374265702104;5339.70631615261;5384.434634363394;5390.056740070491;5402.432744561824;5423.457654234565;5457.536109430703;5495.763453223013;5496.862578435551;5513.972430137844;5514.172874068881;5334.466553344654;5442.074847275972;5479.808206712766;5483.8080667176655;5518.034343989786;5473.397926228092;5476.945230547723;5498.532624726863;5501.202325662796;5516.531094856942;5252.894942101137;5409.26974858393;5417.431169727161;5434.755436005389;5482.588805839578;5799.449052340021;5842.444967728059;5854.238948936653;5874.3244526879525;5961.493273071794;5665.206871038058;6055.364186760415;6333.8416539586415;6356.459700925427;6356.459700925427;6271.184745982993;6310;6316.147320111772;6374.139491168679;6384.138141350904;6069.6054756441135;6104.938950610437;6108.511319094462;6136.794807788362;6153.692315384257;5641.774329026793;6320.146780184708;6442.226932768098;6451.516136289797;6472.385123413268;6164.352742962014;6380.840478988062;6390.968045159744;6402.167718196604;6413.3266007069515;6280.434760871452;6300.243970723451;6331.493480521547;6359.713812878432;6381.042843573408;6303.086052522359;6333.145025421509;6344.714487848058;6346.555741098079;6363.172787537591;6320.905186422207;6330.335314791972;6335.65153916539;6338.936610633835;6342.460890824332;4615.423072115986;4880.170371036861;4994.375703037121;5054.873628159326;5056.64603477753;4601.953980460219;4609.723416595015;4616.630669546428;4616.907661846744;4656.837010704609;6015.939840601625;6016.759329626853;6025.728842202024;6041.516678665696;6053.636781793107;6227.377262273736;6287.245530536365;6303.432691057827;6351.333110023474;6365.140706004723;5997.580169388101;6053.061775424816;6053.3946605339115;6053.848653783691;6086.756529738849;5603.523700485504;5620.409856965041;5629.183768353648;5632.97183514088;5633.859153521113;6347.619142851351;6464.191976003;6501.772437964649;6529.379708927644;6535.379138981789;6326.525510586633;6346.841328966812;6357.1735674362035;6363.427291543598;6380.617162970237;6369.713362898588;6524.739010439529;6527.379898909596;6528.151340325728;6534.771283005072;6260.060990851409;6313.779017734358;6340.048992651139;6341.587796793378;6362.77730279438;5389.434109418611;6333.96833015832;6374.74501019954;6377.713002914973;6380.968095159495;6200.255969283535;6282;6344.904826427515;6379.617222966451;6388.361163883575;5407.648502847303;6346.619202847844;6356.2054743157105;6364.968175159094;6375.5218358624215;5209.244659524272;6228.096925945803;6246.906296405648;6255.874882502416;6262.405071518198;6219.720112595034;6289.6540690260645;6323.9683801580695;6366.681665916593;6387.840303992251;6117.553376797748;6127.325994140552;6179.84550386244;6218.160548325918;6231.906521402092 01:45:26 INFO - PROCESS | 1666 | |1;ext.html;557.9023670857599;562.6089867542058;566.6939852479661;597.474222684038;600.5285850607274;32350.19124521885;32863.1784205395;32892.83553582229;32894.506582401285;32899.013029609094;36706.26587468249;39586.812395628105;40749;41480.96297592562;41777.79111104448;9672.56473458696;9847.60609575616;9852.507374631276;9865.556049977733;9870.358426702278;9187.081291870792;9702.854457183148;9813.754656133582;9816.460094694788;11815.645530634094;11744.29534227949;11810.58662946797;11812.350320732356;11812.940935295355;11820.527178912833;11725.882741172607;11827.763444731101;11841.052715782716;11842.822357664641;11844.526218951232;11512.539498420138;11622.244554104042;11629.767404651859;11654.184207105505;11656.417179141094;39118.80440597807;39513.40729889054;39581.60418395808;41748.58251417477;41913;3328.467445208755;3413.675700808419;3541.929161416783;3555.4489054196383;3957.485526881487;27071.729282707314;27845.72154278472;27969.440611187867;28130.859345703346;28172.718272817216;2777.1529683446543;2782.234885406509;2799.888004479839;2820;2894.305366711995;370666;373814;373872;373959.99999999726;374402;37336.87989360323;60217.69891150516;63471.36528634747;63483.6825815868;63568.68215658984;36225.275494489964;36501.63498364983;36546.8172659135;36549.08627284339;36568.817155914585;15956.920215398848;16222.269997850126;16225.35098596043;16233.918830406008;16247.51257462278;13666.453341866412;13718.451261949609;13735.313234338244;13737.313134343243;13745.862541374658;7799.986001819841;8055.7583272501915;8133.633986470623;8426.957865210634;8576.1423857615;2990.878420592278;3377.6453472385047;3540.805255710909;3565.16218688608;3588.2105936693883;1005.6178652112151;1042.374575254841;1062.888396718349;1121.4448847820381;1148.4315263944402;29645.851770741006;29855.850720746257;30089.645965931584;30118.24704382364;30321.24196895051;1166.5916929074756;1193.4927655746446;1200.7658506591306;1204.0608325506118;1213.7754515414676;15454.690906182039;15828.604284892739;15885.046897186206;15913.476286129939;16108.516744497683;530841;612899;613022;613989;619276;63080.89974151757;63567.68216158982;63755.043674344925;63772.36227637757;63777;1305.106002388348;1427.150845247097;1518.544436669017;1579.423510418689;1586.904785712861;28815.855920720263;29326.853365733034;29420.411591768472;30678.539821902243;31135.53296700506;50155.74922125366;50615.240771389195;51026;51030;51107.744461277456;436609;440232;440404;440841;441141;24337.39156521101;24864.37839054038;27216.455670886076;27738.722612773614;28058.859705702158;43320.78339608282;43894.12211755683;43944;44160;44515.332270016625;35516.64483355237;36391.63608363883;36536;36589.902302930954;37019.25961480809;35777.28445431129;35987;36192.63807361998;36587.268254634226;36604.63395366012;37182;37658.62341376551;37966.620333797415;38176.618233818415;38692;31522.434229115544;32896.1775955603;33097.50353744744;33168.66831331656;33415;25077;25127.49745005126;25211.87394063018;25337.493250135263;25615.6157657639 01:45:26 INFO - PROCESS | 1666 | |2;jquery.html;415.70692661673525;416.06593198269877;416.69789402683057;418.9329707246841;429.04537404275493;20433.693494597574;20954.790452095476;21143.894280528595;21159.894200528994;22127.89360531971;12206.328651924141;12532.561360352389;16892.324307027706;21369;21420;5202.947970520294;5311.495407936259;5503;5515.007298686235;6138.600990935597;5178.404483484391;6054.424829641199;6059.303180134275;6094.847628809293;6097.298810636767;6073.362296958822;6079.848003799896;6109.266887973427;6685.598864068147;6698.363655452748;6653.800385988404;6666.0667506549125;6679.833004174886;6682.766103186389;6691.76578819739;5518.33779946405;5810.099434587646;5831.271091113611;5832.912506312408;5957.493613042897;13408.597742067754;13661.97535184865;19158;25532.744672553406;25566.977320907143;2286.2683941138844;2388.3193289912465;2487.3905893056317;2506.4736405354897;2858.9857050714613;10002.699919002442;10277.79444411115;10421.218408619385;10477.790444191074;14972.550823475312;1764.4353806781835;1834.4313262888413;1837.173272027593;1839.2734869726382;1853.4624958761942;111983;113606.43196784046;115528.42235788767;121970;124281;11500.654980350602;11674.474648640831;11877.940610296893;11894.583689570823;11917.821232681517;12637.93681031589;15288.923555382153;15365.539033829004;15403.92298038525;15418.768718469231;7326.6663668030915;9037.322200834964;9098.044705305847;9147.222486088756;9187.219086377732;9118.316126290421;9138;9150.130737579919;9238.445693258425;9256.166944974984;3995.6603688686205;4668.929966050512;4678.95321046792;4694.976525117352;4747.643926705511;1971.960560788776;2023.585165041163;2034.7558293004934;2050.1901748809437;2088.321295578943;851.4891065360735;918.5453200665713;987.8639564500882;1005.8591797148405;1093.1855767453299;17399.06843851842;19700.31048913281;20078.698819517427;20475.283365082152;20533.58932821335;1017.7150397888603;1024.1857723109997;1037.4605205293205;1039.0856046679025;1105.3312745788842;8635.481871087755;10474.070688301757;10644.308119972176;10664.41345725977;10706.143508519455;627243;634586;644657;644994;647095.7645211744;74607.25392746112;76487;76503.61748191334;122949.38525307317;122983.3850830758;1026.9794604107876;1030.6598822388594;1055.498638146874;1056;1058.7406085509099;17798.46604601864;17804.46586602404;17860.285588576313;17899.642007160044;18655.16051777646;49792.25311620256;51900.74049629728;51925.44223673296;53252.73373633107;55599.72200138973;56806.43193568011;74297.25702742903;76775;79031.62905112856;79312.20687793048;7728.613569321624;7998.842338476129;8059.032916050111;8200.974878140232;8251;10389.740256493647;10884.346939183675;11791.823122653339;12030.578929737418;12404.875951240372;9215.58529866171;10077.496125193564;10936.289141205796;11009;11019.283746556448;9114.680986165453;10528.157747380037;10542.894571054498;10682.57269709203;10950.288231264942;9131.406458580172;10880.129589632652;10955.34267943926;11079.113670906469;11792.587259445878;8194.877076843972;8258.710945116893;8325.500469971821;8418.989721233245;8627.525486098324;10604.204684648528;10879.891201088205;11023.118150548098;11032.338059716443;11156.832647510457 01:45:26 INFO - PROCESS | 1666 | |3;mootools.html;1501.1593507635732;1623.0586259969218;1656.4782093640501;1920.654282229198;2021.1713197588992;8231.958840205798;8895.733128006163;9037.277017838574;9037.412568183063;9046.23107035902;8623.87064194036;8856.645734170625;8893.24407425368;8896.065913079114;8930.37487375884;2541.987290063547;2562.8334158279745;2563.077292174825;2566.089038391372;2566.7048289446766;2489.676342075528;2556.4503631719176;2562.3978365084286;2562.9615555766677;2565.1663209456906;2494.9376265593323;2525.532776436365;2540.7586279303528;2541.0598078710905;2542.8092893033095;2512.371907023244;2514.8365356251875;2526.343150780801;2576.896924123033;2580.5871060630398;2255.616545187322;2430.5989511730545;2545.8472491650373;2562.0264299566047;2562.4234547226724;7748.496347737436;8764.649414023432;8967.148120928501;8999.640014399416;9053.909460905372;5595.63628364155;5665.575081868877;5714.000049991235;5718.142278658193;5722.399148089474;3567.161716996504;3621.981890090559;3670.9082272943124;3690.76010059348;3711.9072023199637;1040.5733649203867;1054.641421916552;1059.3855563772993;1060.0565496707936;1065.0680654427376;12151.939240303831;12259.019278457701;12263.69340766479;12265.754684906342;12283.324417157053;4689.882752931204;4701.529847015271;4840.975795121072;4864.197407427806;4877.12211801879;9672;9690.46702431373;9691.563879625433;9696.321257511907;9704.175145112604;5551.444855514416;5568.777248910079;5611.3266408031295;5614.606977511535;5617.101263797773;4254.510731265882;4666.906661866811;4809.927851082237;5192.169252919514;5230.320058392384;3971.7418367806576;4009.2182024505523;4053.7365071270865;4090.7136500444685;4096.938545921814;1216.920900141488;1259.603224984127;1261.255859043169;1268.3277862732766;1273.5224290890917;843.4896887383045;861.4701958295603;945.5177859291811;962.0956301077105;964.4309857184155;6101.60339577926;6134.754609815557;6205.100260462208;6251.4061164189325;6273.968630156911;484.5638924967487;486.7931129270046;488.5578551410979;496.1169118968242;496.62504808869073;3935.4883865097354;4000.2599519089063;4203.936940945889;4233.7883105844585;4321.78391080451;10791;10906.672799816019;10967.945160274148;10977;11113.166512511594;10918.126549875991;10936.125109991182;10953.945230273797;10974.615888444026;10979.83530247047;7560.8280716489035;8480.83038339242;8508.829823403621;8630.78423039429;8642.438241514406;6024.246969128859;6026.487748541248;6158.889586384899;6185.010398336244;6192.81421557354;9663.082007209305;9675.758106047406;9684.75788105303;9866.753331166778;9869.407835529892;9741.951290243787;10035.14701250402;10114.342567733074;10133.391996480235;10235.181185505291;7098.503104782616;7304.013958115799;7566.583837888969;7687.500312479895;7830.530168189927;7309.488335816442;8541.402101852811;8591.054983951884;8615.870761938451;8617.095205003385;7453.40372770188;7532.397408207221;7602.087749470099;7609.010828592248;7677.232276772278;7369.668364923484;7408;7419.332260096618;7494.775156745306;7544.47188696786;7147.428205743632;7252.202257751537;7277.090363704537;7295.124585049828;7302.634868256459;4945.851624451272;4980.950190498049;5049.495050494921;5124.692518448905;5149.48505149482;5028.949710502849;5108.131617624938;5182.429932707324;5204.271402003798;5379.946200538101 01:45:26 INFO - PROCESS | 1666 | |4;prototype.html;333.1438203816192;335.3226482505339;343.135299046403;343.5894106542681;350.05834305717633;6669.066330713698;6670.433013193872;6689.598624082552;6708.765193218238;6722.966385168067;5413;6675.165604299463;6679.499037572177;6701.195856497215;6705.195376554808;4783.449903261126;4870.926936095943;4949.950500495003;4994.425641051271;4998.5001499849905;4310.633596144332;4318.870433886988;4947.950520494803;5000.249962505635;5028.7737051832755;4931.975340123312;4938.530839570253;4939.456659767423;4950.579200767939;4958.355413796201;4202.739178246514;4734.644901632374;4813.566778989873;4958.107540642683;4962;4246.660267178619;4250.04374015847;4262.318029115358;4272.508661503935;4281.871543853689;6369.4585960193435;6436.967815160941;6474.4820414367205;6475.93524064758;6490.188726409199;5971.462568368867;5978.551608629326;5984.905283150906;5987.670678112702;5994.190784244115;6937.7224911003495;7162.856742865113;7171.211166771651;7180.7845764627145;7187.604681742502;4862.781174847105;4905.386826646669;4911.8772030699165;4919.188333924933;4925.088858561177;7571.469997100206;7665.540067595962;7677.577733224671;7689.269519395649;7697.191794861571;4198;4959.454460009396;4963.925541116886;4978.950210497848;4998.925016124761;4516.864494065183;4807.759612019385;5060.987802439527;5062.088824011713;5070.797168113234;5810.056967140434;5915.231019967463;5988.550858685616;5994.340622531518;6001.699915004319;5925.525957923356;7224.530405523624;7251.3836323912;7264.963675181591;7299.781006569811;1727.145063193727;1762.8854124481868;1768.9027103509172;1769.7699299091037;1777.2269062957655;898.8674270419318;1112.9443527823576;1113.7438389170536;1145.4272863568217;1145.5360578965533;6622.205335359788;6677.964915438018;6844.28135045823;6853.691583878737;6864.656767161622;7614.771556853303;7633.69465221385;7650.120236172911;7650.19672934345;7659.157492675801;5797.898399304118;6853.623050732258;6882.931170688229;6918.8616227676175;6920.8961865572055;3886.9222615548097;3987.0829709167056;4027.4562934003534;4034.1931613677384;4037.152198038386;7932.849736788134;7949.443538952218;7965.960170199228;7965.968677987192;7973.365460080669;6732.831679208059;7496.512726672749;7770.650320735581;7825.100113486908;7874.05511338643;7982.481138725964;7984.281414672591;7989.600519973978;7992.240737129963;7997.880031799527;7070.257622949516;7324.853502929805;7612.391008719178;7618.200088990576;7618.352440042659;5543.861403464945;6238.469730072995;7155.928440715526;7458.627068646654;7471.290227428385;7982.321502672338;7990.480618759762;7999.400044996532;8009.279164875189;8011.599420029092;4751.572358487752;4803.615710743063;4820.108279968217;4821.758912054313;4826.227803551415;7312.926870731225;7598.392128629807;7631.465797394129;7632.771016869503;7645.426593005658;7300.12398512182;7335.963320183365;7338.412926965937;7342.3758980487255;7350.338469537767;7330.340269375782;7339.486235963432;7340.926590734024;7362.558246505227;7363.926360736538;7196.856062878608;7206.927930720625;7212.170600380813;7216.3505284524645;7249.311315425026;7124.002639630352;7301.853962920605;7353.374963128194;7366.594837283787;7372.815679607838;6921.550099243735;6962.1993470749485;7129.572225666477;7136.6788494518905;7203.495755297079 01:45:26 INFO - PROCESS | 1666 | |5;yui.html;739.9297066778656;774.1523032279651;787.0673252196148;790.766723816474;799.1888233443054;15376.308066137022;15723.056616603011;15732.97735647185;15743.527694169179;15744.763828542567;14332;14413.711725765479;14461.493847715332;14473.059251148668;14479.42082316706;768.684839215923;783.9764807055798;935.434062392253;955.2405837359281;957.6935380678186;936.0826390137669;948.2319321349729;952.2382094324547;952.8094381123803;953.270747877874;827.234807802783;1013.761765984993;1016.7153197104823;1018.0633816888443;1018.2007124407342;991.5240684471459;1012.559536601577;1014.6499457687086;1016.0296916444778;1016.9949150254201;760.3878877503607;763.9800865844105;765.6516285090271;767.5241350362755;767.7274567528502;15296.923515382463;15363;15372.154531500762;15399.461018864286;15401.845981540153;12931.094823362368;13055.673608159777;13203.537876174289;13337.799933001013;13389.531366402227;10193.694189174337;11071.778564428667;11101.500432480558;11129.387883666395;11558.19092663514;3514.121469632592;3529.94705079424;3558.190519080112;3606.801625910574;3771.434284857266;83660;84088;85700;86337;86775;9512.809743805223;9558.856617150748;9562.235021198427;9617.27870409722;9787.265955053399;22036.89815509218;22089;22129.557408852055;22192.112315507522;22397.216097436838;7673.271039251262;7676.80807979805;7844.843103137905;7906.841863162705;8033.3974951878845;4172.5410204877435;4227.894302642397;4228.175505776344;4479.081788233404;4502.347159661831;3797.582265950743;3852.7110466715108;3862.2661694278;3862.9227415451533;3865.033741564609;682.2529330383222;700.9964950175319;702.8594281143792;705.3087973785719;719.5251134251473;601.6690820048956;622.3434276837979;622.6730966242668;633.4425705379329;648.7242921758234;7322.633868306563;7715.729949451742;8378.79053023667;8482.957585212034;8557.786055348666;507.42407367638;585.1369230385147;596.1058412381428;610.8869859075996;635.1362147479424;3892.4355968384425;3905.628965248297;3945.6251656092627;4002.1795531915886;4188.476440444944;84398;84547;85913;93371.0662893376;94149.05850941403;76579;77263;79215.41569168585;79803;82693;66153.33846661568;66479;66783.33216667868;66816.33183668199;67389.66305168443;7555.962220189083;7621.923780762121;8579.442336248125;8741.868871967054;8978.685745998859;48605;51413.97172056463;51478.48521514887;51753.7412312936;52152.739236303576;58271.54321142005;65968;66735.66632166808;67990;69106.65446672935;10968.725781855517;11010.174236932102;11334.093272538343;11350.659480215607;11575.594854180401;10409.011143941314;11428.314301141958;11562.248453850472;12154.149209555246;12405.565805196775;11083.445827708743;11142.442877855912;11225.550977960791;11313.264637798517;12245.265284082983;11179.105671546095;11184.664460066211;11288.040516556184;11477.483513241757;12286.201396909173;11099.44502774842;11232.887671123512;11255.155863310449;11473.713157171138;12203.755924881276;9730.075642813921;9834.655787047419;10015.24885633595;10128.645497407555;10210.693679189637;9690.95154524223;9744.464054477072;9752.756181095529;9807.558659860466;9808.411495310304 01:45:26 INFO - PROCESS | 1666 | __end_tp_report 01:45:26 INFO - PROCESS | 1666 | __start_cc_report 01:45:26 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1285 01:45:26 INFO - PROCESS | 1666 | __end_cc_report 01:45:26 INFO - PROCESS | 1666 | __startTimestamp1467103526248__endTimestamp 01:45:26 INFO - PROCESS | 1666 | 01:45:26 INFO - PROCESS | 1666 | ------- Summary: start ------- 01:45:26 INFO - PROCESS | 1666 | Number of tests: 6 01:45:26 INFO - PROCESS | 1666 | 01:45:26 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5903.92 Median:6153.69 stddev:630.96 (10.3%) stddev-sans-first:606.35 01:45:26 INFO - PROCESS | 1666 | Values: 3595.2 3605.1 3624.8 3630.5 3690.0 4546.7 5567.2 5877.9 5881.4 5929.3 5887.6 5923.6 5930.2 5956.7 5959.4 5339.7 5384.4 5390.1 5402.4 5423.5 5457.5 5495.8 5496.9 5514.0 5514.2 5334.5 5442.1 5479.8 5483.8 5518.0 5473.4 5476.9 5498.5 5501.2 5516.5 5252.9 5409.3 5417.4 5434.8 5482.6 5799.4 5842.4 5854.2 5874.3 5961.5 5665.2 6055.4 6333.8 6356.5 6356.5 6271.2 6310.0 6316.1 6374.1 6384.1 6069.6 6104.9 6108.5 6136.8 6153.7 5641.8 6320.1 6442.2 6451.5 6472.4 6164.4 6380.8 6391.0 6402.2 6413.3 6280.4 6300.2 6331.5 6359.7 6381.0 6303.1 6333.1 6344.7 6346.6 6363.2 6320.9 6330.3 6335.7 6338.9 6342.5 4615.4 4880.2 4994.4 5054.9 5056.6 4602.0 4609.7 4616.6 4616.9 4656.8 6015.9 6016.8 6025.7 6041.5 6053.6 6227.4 6287.2 6303.4 6351.3 6365.1 5997.6 6053.1 6053.4 6053.8 6086.8 5603.5 5620.4 5629.2 5633.0 5633.9 6347.6 6464.2 6501.8 6529.4 6535.4 6326.5 6346.8 6357.2 6363.4 6380.6 6369.7 6524.7 6527.4 6528.2 6534.8 6260.1 6313.8 6340.0 6341.6 6362.8 5389.4 6334.0 6374.7 6377.7 6381.0 6200.3 6282.0 6344.9 6379.6 6388.4 5407.6 6346.6 6356.2 6365.0 6375.5 5209.2 6228.1 6246.9 6255.9 6262.4 6219.7 6289.7 6324.0 6366.7 6387.8 6117.6 6127.3 6179.8 6218.2 6231.9 01:45:26 INFO - PROCESS | 1666 | 01:45:26 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:60634.82 Median:3541.37 stddev:128087.42 (3616.9%) stddev-sans-first:128367.32 01:45:26 INFO - PROCESS | 1666 | Values: 557.9 562.6 566.7 597.5 600.5 32350.2 32863.2 32892.8 32894.5 32899.0 36706.3 39586.8 40749.0 41481.0 41777.8 9672.6 9847.6 9852.5 9865.6 9870.4 9187.1 9702.9 9813.8 9816.5 11815.6 11744.3 11810.6 11812.4 11812.9 11820.5 11725.9 11827.8 11841.1 11842.8 11844.5 11512.5 11622.2 11629.8 11654.2 11656.4 39118.8 39513.4 39581.6 41748.6 41913.0 3328.5 3413.7 3541.9 3555.4 3957.5 27071.7 27845.7 27969.4 28130.9 28172.7 2777.2 2782.2 2799.9 2820.0 2894.3 370666.0 373814.0 373872.0 373960.0 374402.0 37336.9 60217.7 63471.4 63483.7 63568.7 36225.3 36501.6 36546.8 36549.1 36568.8 15956.9 16222.3 16225.4 16233.9 16247.5 13666.5 13718.5 13735.3 13737.3 13745.9 7800.0 8055.8 8133.6 8427.0 8576.1 2990.9 3377.6 3540.8 3565.2 3588.2 1005.6 1042.4 1062.9 1121.4 1148.4 29645.9 29855.9 30089.6 30118.2 30321.2 1166.6 1193.5 1200.8 1204.1 1213.8 15454.7 15828.6 15885.0 15913.5 16108.5 530841.0 612899.0 613022.0 613989.0 619276.0 63080.9 63567.7 63755.0 63772.4 63777.0 1305.1 1427.2 1518.5 1579.4 1586.9 28815.9 29326.9 29420.4 30678.5 31135.5 50155.7 50615.2 51026.0 51030.0 51107.7 436609.0 440232.0 440404.0 440841.0 441141.0 24337.4 24864.4 27216.5 27738.7 28058.9 43320.8 43894.1 43944.0 44160.0 44515.3 35516.6 36391.6 36536.0 36589.9 37019.3 35777.3 35987.0 36192.6 36587.3 36604.6 37182.0 37658.6 37966.6 38176.6 38692.0 31522.4 32896.2 33097.5 33168.7 33415.0 25077.0 25127.5 25211.9 25337.5 25615.6 01:45:26 INFO - PROCESS | 1666 | 01:45:26 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:34828.98 Median:21394.50 stddev:105797.22 (494.5%) stddev-sans-first:106062.45 01:45:26 INFO - PROCESS | 1666 | Values: 415.7 416.1 416.7 418.9 429.0 20433.7 20954.8 21143.9 21159.9 22127.9 12206.3 12532.6 16892.3 21369.0 21420.0 5202.9 5311.5 5503.0 5515.0 6138.6 5178.4 6054.4 6059.3 6094.8 6097.3 6073.4 6079.8 6109.3 6685.6 6698.4 6653.8 6666.1 6679.8 6682.8 6691.8 5518.3 5810.1 5831.3 5832.9 5957.5 13408.6 13662.0 19158.0 25532.7 25567.0 2286.3 2388.3 2487.4 2506.5 2859.0 10002.7 10277.8 10421.2 10477.8 14972.6 1764.4 1834.4 1837.2 1839.3 1853.5 111983.0 113606.4 115528.4 121970.0 124281.0 11500.7 11674.5 11877.9 11894.6 11917.8 12637.9 15288.9 15365.5 15403.9 15418.8 7326.7 9037.3 9098.0 9147.2 9187.2 9118.3 9138.0 9150.1 9238.4 9256.2 3995.7 4668.9 4679.0 4695.0 4747.6 1972.0 2023.6 2034.8 2050.2 2088.3 851.5 918.5 987.9 1005.9 1093.2 17399.1 19700.3 20078.7 20475.3 20533.6 1017.7 1024.2 1037.5 1039.1 1105.3 8635.5 10474.1 10644.3 10664.4 10706.1 627243.0 634586.0 644657.0 644994.0 647095.8 74607.3 76487.0 76503.6 122949.4 122983.4 1027.0 1030.7 1055.5 1056.0 1058.7 17798.5 17804.5 17860.3 17899.6 18655.2 49792.3 51900.7 51925.4 53252.7 55599.7 56806.4 74297.3 76775.0 79031.6 79312.2 7728.6 7998.8 8059.0 8201.0 8251.0 10389.7 10884.3 11791.8 12030.6 12404.9 9215.6 10077.5 10936.3 11009.0 11019.3 9114.7 10528.2 10542.9 10682.6 10950.3 9131.4 10880.1 10955.3 11079.1 11792.6 8194.9 8258.7 8325.5 8419.0 8627.5 10604.2 10879.9 11023.1 11032.3 11156.8 01:45:26 INFO - PROCESS | 1666 | 01:45:26 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5830.70 Median:5078.81 stddev:3233.14 (63.7%) stddev-sans-first:3225.84 01:45:26 INFO - PROCESS | 1666 | Values: 1501.2 1623.1 1656.5 1920.7 2021.2 8232.0 8895.7 9037.3 9037.4 9046.2 8623.9 8856.6 8893.2 8896.1 8930.4 2542.0 2562.8 2563.1 2566.1 2566.7 2489.7 2556.5 2562.4 2563.0 2565.2 2494.9 2525.5 2540.8 2541.1 2542.8 2512.4 2514.8 2526.3 2576.9 2580.6 2255.6 2430.6 2545.8 2562.0 2562.4 7748.5 8764.6 8967.1 8999.6 9053.9 5595.6 5665.6 5714.0 5718.1 5722.4 3567.2 3622.0 3670.9 3690.8 3711.9 1040.6 1054.6 1059.4 1060.1 1065.1 12151.9 12259.0 12263.7 12265.8 12283.3 4689.9 4701.5 4841.0 4864.2 4877.1 9672.0 9690.5 9691.6 9696.3 9704.2 5551.4 5568.8 5611.3 5614.6 5617.1 4254.5 4666.9 4809.9 5192.2 5230.3 3971.7 4009.2 4053.7 4090.7 4096.9 1216.9 1259.6 1261.3 1268.3 1273.5 843.5 861.5 945.5 962.1 964.4 6101.6 6134.8 6205.1 6251.4 6274.0 484.6 486.8 488.6 496.1 496.6 3935.5 4000.3 4203.9 4233.8 4321.8 10791.0 10906.7 10967.9 10977.0 11113.2 10918.1 10936.1 10953.9 10974.6 10979.8 7560.8 8480.8 8508.8 8630.8 8642.4 6024.2 6026.5 6158.9 6185.0 6192.8 9663.1 9675.8 9684.8 9866.8 9869.4 9742.0 10035.1 10114.3 10133.4 10235.2 7098.5 7304.0 7566.6 7687.5 7830.5 7309.5 8541.4 8591.1 8615.9 8617.1 7453.4 7532.4 7602.1 7609.0 7677.2 7369.7 7408.0 7419.3 7494.8 7544.5 7147.4 7252.2 7277.1 7295.1 7302.6 4945.9 4981.0 5049.5 5124.7 5149.5 5028.9 5108.1 5182.4 5204.3 5379.9 01:45:26 INFO - PROCESS | 1666 | 01:45:26 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:5947.51 Median:6695.40 stddev:1910.52 (28.5%) stddev-sans-first:1868.83 01:45:26 INFO - PROCESS | 1666 | Values: 333.1 335.3 343.1 343.6 350.1 6669.1 6670.4 6689.6 6708.8 6723.0 5413.0 6675.2 6679.5 6701.2 6705.2 4783.4 4870.9 4950.0 4994.4 4998.5 4310.6 4318.9 4948.0 5000.2 5028.8 4932.0 4938.5 4939.5 4950.6 4958.4 4202.7 4734.6 4813.6 4958.1 4962.0 4246.7 4250.0 4262.3 4272.5 4281.9 6369.5 6437.0 6474.5 6475.9 6490.2 5971.5 5978.6 5984.9 5987.7 5994.2 6937.7 7162.9 7171.2 7180.8 7187.6 4862.8 4905.4 4911.9 4919.2 4925.1 7571.5 7665.5 7677.6 7689.3 7697.2 4198.0 4959.5 4963.9 4979.0 4998.9 4516.9 4807.8 5061.0 5062.1 5070.8 5810.1 5915.2 5988.6 5994.3 6001.7 5925.5 7224.5 7251.4 7265.0 7299.8 1727.1 1762.9 1768.9 1769.8 1777.2 898.9 1112.9 1113.7 1145.4 1145.5 6622.2 6678.0 6844.3 6853.7 6864.7 7614.8 7633.7 7650.1 7650.2 7659.2 5797.9 6853.6 6882.9 6918.9 6920.9 3886.9 3987.1 4027.5 4034.2 4037.2 7932.8 7949.4 7966.0 7966.0 7973.4 6732.8 7496.5 7770.7 7825.1 7874.1 7982.5 7984.3 7989.6 7992.2 7997.9 7070.3 7324.9 7612.4 7618.2 7618.4 5543.9 6238.5 7155.9 7458.6 7471.3 7982.3 7990.5 7999.4 8009.3 8011.6 4751.6 4803.6 4820.1 4821.8 4826.2 7312.9 7598.4 7631.5 7632.8 7645.4 7300.1 7336.0 7338.4 7342.4 7350.3 7330.3 7339.5 7340.9 7362.6 7363.9 7196.9 7206.9 7212.2 7216.4 7249.3 7124.0 7301.9 7353.4 7366.6 7372.8 6921.6 6962.2 7129.6 7136.7 7203.5 01:45:26 INFO - PROCESS | 1666 | 01:45:26 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:18386.60 Median:51953.24 stddev:25503.71 (49.1%) stddev-sans-first:25540.83 01:45:26 INFO - PROCESS | 1666 | Values: 739.9 774.2 787.1 790.8 799.2 15376.3 15723.1 15733.0 15743.5 15744.8 14332.0 14413.7 14461.5 14473.1 14479.4 768.7 784.0 935.4 955.2 957.7 936.1 948.2 952.2 952.8 953.3 827.2 1013.8 1016.7 1018.1 1018.2 991.5 1012.6 1014.6 1016.0 1017.0 760.4 764.0 765.7 767.5 767.7 15296.9 15363.0 15372.2 15399.5 15401.8 12931.1 13055.7 13203.5 13337.8 13389.5 10193.7 11071.8 11101.5 11129.4 11558.2 3514.1 3529.9 3558.2 3606.8 3771.4 83660.0 84088.0 85700.0 86337.0 86775.0 9512.8 9558.9 9562.2 9617.3 9787.3 22036.9 22089.0 22129.6 22192.1 22397.2 7673.3 7676.8 7844.8 7906.8 8033.4 4172.5 4227.9 4228.2 4479.1 4502.3 3797.6 3852.7 3862.3 3862.9 3865.0 682.3 701.0 702.9 705.3 719.5 601.7 622.3 622.7 633.4 648.7 7322.6 7715.7 8378.8 8483.0 8557.8 507.4 585.1 596.1 610.9 635.1 3892.4 3905.6 3945.6 4002.2 4188.5 84398.0 84547.0 85913.0 93371.1 94149.1 76579.0 77263.0 79215.4 79803.0 82693.0 66153.3 66479.0 66783.3 66816.3 67389.7 7556.0 7621.9 8579.4 8741.9 8978.7 48605.0 51414.0 51478.5 51753.7 52152.7 58271.5 65968.0 66735.7 67990.0 69106.7 10968.7 11010.2 11334.1 11350.7 11575.6 10409.0 11428.3 11562.2 12154.1 12405.6 11083.4 11142.4 11225.6 11313.3 12245.3 11179.1 11184.7 11288.0 11477.5 12286.2 11099.4 11232.9 11255.2 11473.7 12203.8 9730.1 9834.7 10015.2 10128.6 10210.7 9691.0 9744.5 9752.8 9807.6 9808.4 01:45:26 INFO - PROCESS | 1666 | -------- Summary: end -------- 01:45:26 INFO - PROCESS | 1666 | 01:45:26 INFO - TEST-INFO | 1666: exit 0 01:45:26 INFO - TEST-OK | dromaeo_css | took 1113609ms 01:45:26 INFO - TEST-START | kraken 01:45:26 INFO - operating with platform_type : mac_ 01:45:26 INFO - Initialising browser for kraken test... 01:45:26 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpteo_34/profile http://localhost:49273/getInfo.html) 01:45:28 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 01:45:28 INFO - PROCESS | 1676 | colorDepth:24 01:45:28 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 01:45:28 INFO - PROCESS | 1676 | __metrics 01:45:28 INFO - PROCESS | 1676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:45:28 ERROR - PROCESS | 1676 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:45:29 INFO - TEST-INFO | 1676: exit 0 01:45:29 INFO - Browser initialized. 01:45:29 INFO - Running cycle 1/1 for kraken test... 01:45:29 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpteo_34/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:45:41 INFO - PROCESS | 1679 | RSS: Main: 161480704 01:45:41 INFO - PROCESS | 1679 | 01:45:43 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 01:45:44 INFO - PROCESS | 1679 | RSS: Main: 224346112 01:45:44 INFO - PROCESS | 1679 | 01:45:47 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 01:45:48 INFO - PROCESS | 1679 | RSS: Main: 239931392 01:45:48 INFO - PROCESS | 1679 | 01:45:51 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 01:45:51 INFO - PROCESS | 1679 | RSS: Main: 324513792 01:45:51 INFO - PROCESS | 1679 | 01:45:53 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 01:45:54 INFO - PROCESS | 1679 | RSS: Main: 232075264 01:45:54 INFO - PROCESS | 1679 | 01:45:56 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:45:57 INFO - PROCESS | 1679 | RSS: Main: 232624128 01:45:57 INFO - PROCESS | 1679 | 01:45:59 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 01:46:00 INFO - PROCESS | 1679 | RSS: Main: 270364672 01:46:00 INFO - PROCESS | 1679 | 01:46:03 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 01:46:03 INFO - PROCESS | 1679 | RSS: Main: 270266368 01:46:03 INFO - PROCESS | 1679 | 01:46:06 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 01:46:07 INFO - PROCESS | 1679 | RSS: Main: 269631488 01:46:07 INFO - PROCESS | 1679 | 01:46:08 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:46:09 INFO - PROCESS | 1679 | RSS: Main: 261214208 01:46:09 INFO - PROCESS | 1679 | 01:46:11 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:46:11 INFO - PROCESS | 1679 | RSS: Main: 267452416 01:46:11 INFO - PROCESS | 1679 | 01:46:13 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:46:14 INFO - PROCESS | 1679 | RSS: Main: 271368192 01:46:14 INFO - PROCESS | 1679 | 01:46:17 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:46:17 INFO - PROCESS | 1679 | RSS: Main: 278560768 01:46:17 INFO - PROCESS | 1679 | 01:46:20 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:46:21 INFO - PROCESS | 1679 | RSS: Main: 275648512 01:46:21 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 01:46:23 INFO - PROCESS | 1679 | RSS: Main: 336269312 01:46:23 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | __start_tp_report 01:46:23 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 01:46:23 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 01:46:23 INFO - PROCESS | 1679 | |i|pagename|runs| 01:46:23 INFO - PROCESS | 1679 | |0;ai-astar;113;113;121;116;119;116;114;112;114;133 01:46:23 INFO - PROCESS | 1679 | |1;audio-beat-detection;155;119;149;201;153;140;117;149;155;117 01:46:23 INFO - PROCESS | 1679 | |2;audio-dft;186;188;184;185;185;185;184;185;183;183 01:46:23 INFO - PROCESS | 1679 | |3;audio-fft;70;76;73;142;74;83;87;95;131;56 01:46:23 INFO - PROCESS | 1679 | |4;audio-oscillator;91;92;139;78;78;93;117;78;74;121 01:46:23 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;117;131;100;85;86;84;86;83;87;83 01:46:23 INFO - PROCESS | 1679 | |6;imaging-darkroom;92;92;92;91;91;93;100;92;92;92 01:46:23 INFO - PROCESS | 1679 | |7;imaging-desaturate;85;84;83;85;84;91;84;84;86;87 01:46:23 INFO - PROCESS | 1679 | |8;json-parse-financial;57;63;61;61;61;63;61;77;59;56 01:46:23 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;59;62;60;74;69;69;63;64;65;64 01:46:23 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;80;78;93;102;101;80;78;80;78;83 01:46:23 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;126;127;127;125;123;113;130;136;169;160 01:46:23 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;208;180;166;163;162;165;159;166;163;159 01:46:23 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;62;83;68;65;66;68;66;67;68;66 01:46:23 INFO - PROCESS | 1679 | __end_tp_report 01:46:23 INFO - PROCESS | 1679 | __start_cc_report 01:46:23 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1875 01:46:23 INFO - PROCESS | 1679 | __end_cc_report 01:46:23 INFO - PROCESS | 1679 | __startTimestamp1467103583365__endTimestamp 01:46:23 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | ------- Summary: start ------- 01:46:23 INFO - PROCESS | 1679 | Number of tests: 14 01:46:23 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:117.10 Median:116.00 stddev:6.26 (5.4%) stddev-sans-first:6.46 01:46:23 INFO - PROCESS | 1679 | Values: 113.0 113.0 121.0 116.0 119.0 116.0 114.0 112.0 114.0 133.0 01:46:23 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:151.00 stddev:25.16 (16.7%) stddev-sans-first:26.45 01:46:23 INFO - PROCESS | 1679 | Values: 155.0 119.0 149.0 201.0 153.0 140.0 117.0 149.0 155.0 117.0 01:46:23 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.00 stddev:1.48 (0.8%) stddev-sans-first:1.50 01:46:23 INFO - PROCESS | 1679 | Values: 186.0 188.0 184.0 185.0 185.0 185.0 184.0 185.0 183.0 183.0 01:46:23 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:88.70 Median:75.00 stddev:27.38 (36.5%) stddev-sans-first:28.19 01:46:23 INFO - PROCESS | 1679 | Values: 70.0 76.0 73.0 142.0 74.0 83.0 87.0 95.0 131.0 56.0 01:46:23 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:78.00 stddev:22.16 (28.4%) stddev-sans-first:23.43 01:46:23 INFO - PROCESS | 1679 | Values: 91.0 92.0 139.0 78.0 78.0 93.0 117.0 78.0 74.0 121.0 01:46:23 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:94.20 Median:84.50 stddev:16.78 (19.9%) stddev-sans-first:15.64 01:46:23 INFO - PROCESS | 1679 | Values: 117.0 131.0 100.0 85.0 86.0 84.0 86.0 83.0 87.0 83.0 01:46:23 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:92.00 stddev:2.63 (2.9%) stddev-sans-first:2.77 01:46:23 INFO - PROCESS | 1679 | Values: 92.0 92.0 92.0 91.0 91.0 93.0 100.0 92.0 92.0 92.0 01:46:23 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.00 stddev:2.31 (2.7%) stddev-sans-first:2.45 01:46:23 INFO - PROCESS | 1679 | Values: 85.0 84.0 83.0 85.0 84.0 91.0 84.0 84.0 86.0 87.0 01:46:23 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:61.00 stddev:5.78 (9.5%) stddev-sans-first:5.85 01:46:23 INFO - PROCESS | 1679 | Values: 57.0 63.0 61.0 61.0 61.0 63.0 61.0 77.0 59.0 56.0 01:46:23 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:64.50 stddev:4.58 (7.1%) stddev-sans-first:4.33 01:46:23 INFO - PROCESS | 1679 | Values: 59.0 62.0 60.0 74.0 69.0 69.0 63.0 64.0 65.0 64.0 01:46:23 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:80.00 stddev:9.63 (12.0%) stddev-sans-first:10.02 01:46:23 INFO - PROCESS | 1679 | Values: 80.0 78.0 93.0 102.0 101.0 80.0 78.0 80.0 78.0 83.0 01:46:23 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:128.50 stddev:17.40 (13.5%) stddev-sans-first:18.24 01:46:23 INFO - PROCESS | 1679 | Values: 126.0 127.0 127.0 125.0 123.0 113.0 130.0 136.0 169.0 160.0 01:46:23 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:165.50 stddev:14.90 (9.0%) stddev-sans-first:6.28 01:46:23 INFO - PROCESS | 1679 | Values: 208.0 180.0 166.0 163.0 162.0 165.0 159.0 166.0 163.0 159.0 01:46:23 INFO - PROCESS | 1679 | 01:46:23 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:5.61 (8.3%) stddev-sans-first:5.53 01:46:23 INFO - PROCESS | 1679 | Values: 62.0 83.0 68.0 65.0 66.0 68.0 66.0 67.0 68.0 66.0 01:46:23 INFO - PROCESS | 1679 | -------- Summary: end -------- 01:46:23 INFO - PROCESS | 1679 | 01:46:24 INFO - TEST-INFO | 1679: exit 0 01:46:24 INFO - TEST-OK | kraken | took 57321ms 01:46:24 INFO - SUITE-END | took 1170s 01:46:24 INFO - Completed test suite (00:19:31) 01:46:24 INFO - javascript benchmark 01:46:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3595.209054008118, 3605.0807044203725, 3624.8006359650226, 3630.5280313559233, 3690.0221441318054, 4546.659000574962, 5567.192757050226, 5877.853053673661, 5881.382454842239, 5929.34777174511, 5887.587868849182, 5923.644581325124, 5930.199423077883, 5956.731947062382, 5959.374265702104, 5339.70631615261, 5384.434634363394, 5390.056740070491, 5402.432744561824, 5423.457654234565, 5457.536109430703, 5495.763453223013, 5496.862578435551, 5513.972430137844, 5514.172874068881, 5334.466553344654, 5442.074847275972, 5479.808206712766, 5483.8080667176655, 5518.034343989786, 5473.397926228092, 5476.945230547723, 5498.532624726863, 5501.202325662796, 5516.531094856942, 5252.894942101137, 5409.26974858393, 5417.431169727161, 5434.755436005389, 5482.588805839578, 5799.449052340021, 5842.444967728059, 5854.238948936653, 5874.3244526879525, 5961.493273071794, 5665.206871038058, 6055.364186760415, 6333.8416539586415, 6356.459700925427, 6356.459700925427, 6271.184745982993, 6310.0, 6316.147320111772, 6374.139491168679, 6384.138141350904, 6069.6054756441135, 6104.938950610437, 6108.511319094462, 6136.794807788362, 6153.692315384257, 5641.774329026793, 6320.146780184708, 6442.226932768098, 6451.516136289797, 6472.385123413268, 6164.352742962014, 6380.840478988062, 6390.968045159744, 6402.167718196604, 6413.3266007069515, 6280.434760871452, 6300.243970723451, 6331.493480521547, 6359.713812878432, 6381.042843573408, 6303.086052522359, 6333.145025421509, 6344.714487848058, 6346.555741098079, 6363.172787537591, 6320.905186422207, 6330.335314791972, 6335.65153916539, 6338.936610633835, 6342.460890824332, 4615.423072115986, 4880.170371036861, 4994.375703037121, 5054.873628159326, 5056.64603477753, 4601.953980460219, 4609.723416595015, 4616.630669546428, 4616.907661846744, 4656.837010704609, 6015.939840601625, 6016.759329626853, 6025.728842202024, 6041.516678665696, 6053.636781793107, 6227.377262273736, 6287.245530536365, 6303.432691057827, 6351.333110023474, 6365.140706004723, 5997.580169388101, 6053.061775424816, 6053.3946605339115, 6053.848653783691, 6086.756529738849, 5603.523700485504, 5620.409856965041, 5629.183768353648, 5632.97183514088, 5633.859153521113, 6347.619142851351, 6464.191976003, 6501.772437964649, 6529.379708927644, 6535.379138981789, 6326.525510586633, 6346.841328966812, 6357.1735674362035, 6363.427291543598, 6380.617162970237, 6369.713362898588, 6524.739010439529, 6527.379898909596, 6528.151340325728, 6534.771283005072, 6260.060990851409, 6313.779017734358, 6340.048992651139, 6341.587796793378, 6362.77730279438, 5389.434109418611, 6333.96833015832, 6374.74501019954, 6377.713002914973, 6380.968095159495, 6200.255969283535, 6282.0, 6344.904826427515, 6379.617222966451, 6388.361163883575, 5407.648502847303, 6346.619202847844, 6356.2054743157105, 6364.968175159094, 6375.5218358624215, 5209.244659524272, 6228.096925945803, 6246.906296405648, 6255.874882502416, 6262.405071518198, 6219.720112595034, 6289.6540690260645, 6323.9683801580695, 6366.681665916593, 6387.840303992251, 6117.553376797748, 6127.325994140552, 6179.84550386244, 6218.160548325918, 6231.906521402092], "value": 5867.380781235716, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.9023670857599, 562.6089867542058, 566.6939852479661, 597.474222684038, 600.5285850607274, 32350.19124521885, 32863.1784205395, 32892.83553582229, 32894.506582401285, 32899.013029609094, 36706.26587468249, 39586.812395628105, 40749.0, 41480.96297592562, 41777.79111104448, 9672.56473458696, 9847.60609575616, 9852.507374631276, 9865.556049977733, 9870.358426702278, 9187.081291870792, 9702.854457183148, 9813.754656133582, 9816.460094694788, 11815.645530634094, 11744.29534227949, 11810.58662946797, 11812.350320732356, 11812.940935295355, 11820.527178912833, 11725.882741172607, 11827.763444731101, 11841.052715782716, 11842.822357664641, 11844.526218951232, 11512.539498420138, 11622.244554104042, 11629.767404651859, 11654.184207105505, 11656.417179141094, 39118.80440597807, 39513.40729889054, 39581.60418395808, 41748.58251417477, 41913.0, 3328.467445208755, 3413.675700808419, 3541.929161416783, 3555.4489054196383, 3957.485526881487, 27071.729282707314, 27845.72154278472, 27969.440611187867, 28130.859345703346, 28172.718272817216, 2777.1529683446543, 2782.234885406509, 2799.888004479839, 2820.0, 2894.305366711995, 370666.0, 373814.0, 373872.0, 373959.99999999726, 374402.0, 37336.87989360323, 60217.69891150516, 63471.36528634747, 63483.6825815868, 63568.68215658984, 36225.275494489964, 36501.63498364983, 36546.8172659135, 36549.08627284339, 36568.817155914585, 15956.920215398848, 16222.269997850126, 16225.35098596043, 16233.918830406008, 16247.51257462278, 13666.453341866412, 13718.451261949609, 13735.313234338244, 13737.313134343243, 13745.862541374658, 7799.986001819841, 8055.7583272501915, 8133.633986470623, 8426.957865210634, 8576.1423857615, 2990.878420592278, 3377.6453472385047, 3540.805255710909, 3565.16218688608, 3588.2105936693883, 1005.6178652112151, 1042.374575254841, 1062.888396718349, 1121.4448847820381, 1148.4315263944402, 29645.851770741006, 29855.850720746257, 30089.645965931584, 30118.24704382364, 30321.24196895051, 1166.5916929074756, 1193.4927655746446, 1200.7658506591306, 1204.0608325506118, 1213.7754515414676, 15454.690906182039, 15828.604284892739, 15885.046897186206, 15913.476286129939, 16108.516744497683, 530841.0, 612899.0, 613022.0, 613989.0, 619276.0, 63080.89974151757, 63567.68216158982, 63755.043674344925, 63772.36227637757, 63777.0, 1305.106002388348, 1427.150845247097, 1518.544436669017, 1579.423510418689, 1586.904785712861, 28815.855920720263, 29326.853365733034, 29420.411591768472, 30678.539821902243, 31135.53296700506, 50155.74922125366, 50615.240771389195, 51026.0, 51030.0, 51107.744461277456, 436609.0, 440232.0, 440404.0, 440841.0, 441141.0, 24337.39156521101, 24864.37839054038, 27216.455670886076, 27738.722612773614, 28058.859705702158, 43320.78339608282, 43894.12211755683, 43944.0, 44160.0, 44515.332270016625, 35516.64483355237, 36391.63608363883, 36536.0, 36589.902302930954, 37019.25961480809, 35777.28445431129, 35987.0, 36192.63807361998, 36587.268254634226, 36604.63395366012, 37182.0, 37658.62341376551, 37966.620333797415, 38176.618233818415, 38692.0, 31522.434229115544, 32896.1775955603, 33097.50353744744, 33168.66831331656, 33415.0, 25077.0, 25127.49745005126, 25211.87394063018, 25337.493250135263, 25615.6157657639], "value": 18801.60960581199, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.70692661673525, 416.06593198269877, 416.69789402683057, 418.9329707246841, 429.04537404275493, 20433.693494597574, 20954.790452095476, 21143.894280528595, 21159.894200528994, 22127.89360531971, 12206.328651924141, 12532.561360352389, 16892.324307027706, 21369.0, 21420.0, 5202.947970520294, 5311.495407936259, 5503.0, 5515.007298686235, 6138.600990935597, 5178.404483484391, 6054.424829641199, 6059.303180134275, 6094.847628809293, 6097.298810636767, 6073.362296958822, 6079.848003799896, 6109.266887973427, 6685.598864068147, 6698.363655452748, 6653.800385988404, 6666.0667506549125, 6679.833004174886, 6682.766103186389, 6691.76578819739, 5518.33779946405, 5810.099434587646, 5831.271091113611, 5832.912506312408, 5957.493613042897, 13408.597742067754, 13661.97535184865, 19158.0, 25532.744672553406, 25566.977320907143, 2286.2683941138844, 2388.3193289912465, 2487.3905893056317, 2506.4736405354897, 2858.9857050714613, 10002.699919002442, 10277.79444411115, 10421.218408619385, 10477.790444191074, 14972.550823475312, 1764.4353806781835, 1834.4313262888413, 1837.173272027593, 1839.2734869726382, 1853.4624958761942, 111983.0, 113606.43196784046, 115528.42235788767, 121970.0, 124281.0, 11500.654980350602, 11674.474648640831, 11877.940610296893, 11894.583689570823, 11917.821232681517, 12637.93681031589, 15288.923555382153, 15365.539033829004, 15403.92298038525, 15418.768718469231, 7326.6663668030915, 9037.322200834964, 9098.044705305847, 9147.222486088756, 9187.219086377732, 9118.316126290421, 9138.0, 9150.130737579919, 9238.445693258425, 9256.166944974984, 3995.6603688686205, 4668.929966050512, 4678.95321046792, 4694.976525117352, 4747.643926705511, 1971.960560788776, 2023.585165041163, 2034.7558293004934, 2050.1901748809437, 2088.321295578943, 851.4891065360735, 918.5453200665713, 987.8639564500882, 1005.8591797148405, 1093.1855767453299, 17399.06843851842, 19700.31048913281, 20078.698819517427, 20475.283365082152, 20533.58932821335, 1017.7150397888603, 1024.1857723109997, 1037.4605205293205, 1039.0856046679025, 1105.3312745788842, 8635.481871087755, 10474.070688301757, 10644.308119972176, 10664.41345725977, 10706.143508519455, 627243.0, 634586.0, 644657.0, 644994.0, 647095.7645211744, 74607.25392746112, 76487.0, 76503.61748191334, 122949.38525307317, 122983.3850830758, 1026.9794604107876, 1030.6598822388594, 1055.498638146874, 1056.0, 1058.7406085509099, 17798.46604601864, 17804.46586602404, 17860.285588576313, 17899.642007160044, 18655.16051777646, 49792.25311620256, 51900.74049629728, 51925.44223673296, 53252.73373633107, 55599.72200138973, 56806.43193568011, 74297.25702742903, 76775.0, 79031.62905112856, 79312.20687793048, 7728.613569321624, 7998.842338476129, 8059.032916050111, 8200.974878140232, 8251.0, 10389.740256493647, 10884.346939183675, 11791.823122653339, 12030.578929737418, 12404.875951240372, 9215.58529866171, 10077.496125193564, 10936.289141205796, 11009.0, 11019.283746556448, 9114.680986165453, 10528.157747380037, 10542.894571054498, 10682.57269709203, 10950.288231264942, 9131.406458580172, 10880.129589632652, 10955.34267943926, 11079.113670906469, 11792.587259445878, 8194.877076843972, 8258.710945116893, 8325.500469971821, 8418.989721233245, 8627.525486098324, 10604.204684648528, 10879.891201088205, 11023.118150548098, 11032.338059716443, 11156.832647510457], "value": 9507.291824823376, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.1593507635732, 1623.0586259969218, 1656.4782093640501, 1920.654282229198, 2021.1713197588992, 8231.958840205798, 8895.733128006163, 9037.277017838574, 9037.412568183063, 9046.23107035902, 8623.87064194036, 8856.645734170625, 8893.24407425368, 8896.065913079114, 8930.37487375884, 2541.987290063547, 2562.8334158279745, 2563.077292174825, 2566.089038391372, 2566.7048289446766, 2489.676342075528, 2556.4503631719176, 2562.3978365084286, 2562.9615555766677, 2565.1663209456906, 2494.9376265593323, 2525.532776436365, 2540.7586279303528, 2541.0598078710905, 2542.8092893033095, 2512.371907023244, 2514.8365356251875, 2526.343150780801, 2576.896924123033, 2580.5871060630398, 2255.616545187322, 2430.5989511730545, 2545.8472491650373, 2562.0264299566047, 2562.4234547226724, 7748.496347737436, 8764.649414023432, 8967.148120928501, 8999.640014399416, 9053.909460905372, 5595.63628364155, 5665.575081868877, 5714.000049991235, 5718.142278658193, 5722.399148089474, 3567.161716996504, 3621.981890090559, 3670.9082272943124, 3690.76010059348, 3711.9072023199637, 1040.5733649203867, 1054.641421916552, 1059.3855563772993, 1060.0565496707936, 1065.0680654427376, 12151.939240303831, 12259.019278457701, 12263.69340766479, 12265.754684906342, 12283.324417157053, 4689.882752931204, 4701.529847015271, 4840.975795121072, 4864.197407427806, 4877.12211801879, 9672.0, 9690.46702431373, 9691.563879625433, 9696.321257511907, 9704.175145112604, 5551.444855514416, 5568.777248910079, 5611.3266408031295, 5614.606977511535, 5617.101263797773, 4254.510731265882, 4666.906661866811, 4809.927851082237, 5192.169252919514, 5230.320058392384, 3971.7418367806576, 4009.2182024505523, 4053.7365071270865, 4090.7136500444685, 4096.938545921814, 1216.920900141488, 1259.603224984127, 1261.255859043169, 1268.3277862732766, 1273.5224290890917, 843.4896887383045, 861.4701958295603, 945.5177859291811, 962.0956301077105, 964.4309857184155, 6101.60339577926, 6134.754609815557, 6205.100260462208, 6251.4061164189325, 6273.968630156911, 484.5638924967487, 486.7931129270046, 488.5578551410979, 496.1169118968242, 496.62504808869073, 3935.4883865097354, 4000.2599519089063, 4203.936940945889, 4233.7883105844585, 4321.78391080451, 10791.0, 10906.672799816019, 10967.945160274148, 10977.0, 11113.166512511594, 10918.126549875991, 10936.125109991182, 10953.945230273797, 10974.615888444026, 10979.83530247047, 7560.8280716489035, 8480.83038339242, 8508.829823403621, 8630.78423039429, 8642.438241514406, 6024.246969128859, 6026.487748541248, 6158.889586384899, 6185.010398336244, 6192.81421557354, 9663.082007209305, 9675.758106047406, 9684.75788105303, 9866.753331166778, 9869.407835529892, 9741.951290243787, 10035.14701250402, 10114.342567733074, 10133.391996480235, 10235.181185505291, 7098.503104782616, 7304.013958115799, 7566.583837888969, 7687.500312479895, 7830.530168189927, 7309.488335816442, 8541.402101852811, 8591.054983951884, 8615.870761938451, 8617.095205003385, 7453.40372770188, 7532.397408207221, 7602.087749470099, 7609.010828592248, 7677.232276772278, 7369.668364923484, 7408.0, 7419.332260096618, 7494.775156745306, 7544.47188696786, 7147.428205743632, 7252.202257751537, 7277.090363704537, 7295.124585049828, 7302.634868256459, 4945.851624451272, 4980.950190498049, 5049.495050494921, 5124.692518448905, 5149.48505149482, 5028.949710502849, 5108.131617624938, 5182.429932707324, 5204.271402003798, 5379.946200538101], "value": 4638.98774442103, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.1438203816192, 335.3226482505339, 343.135299046403, 343.5894106542681, 350.05834305717633, 6669.066330713698, 6670.433013193872, 6689.598624082552, 6708.765193218238, 6722.966385168067, 5413.0, 6675.165604299463, 6679.499037572177, 6701.195856497215, 6705.195376554808, 4783.449903261126, 4870.926936095943, 4949.950500495003, 4994.425641051271, 4998.5001499849905, 4310.633596144332, 4318.870433886988, 4947.950520494803, 5000.249962505635, 5028.7737051832755, 4931.975340123312, 4938.530839570253, 4939.456659767423, 4950.579200767939, 4958.355413796201, 4202.739178246514, 4734.644901632374, 4813.566778989873, 4958.107540642683, 4962.0, 4246.660267178619, 4250.04374015847, 4262.318029115358, 4272.508661503935, 4281.871543853689, 6369.4585960193435, 6436.967815160941, 6474.4820414367205, 6475.93524064758, 6490.188726409199, 5971.462568368867, 5978.551608629326, 5984.905283150906, 5987.670678112702, 5994.190784244115, 6937.7224911003495, 7162.856742865113, 7171.211166771651, 7180.7845764627145, 7187.604681742502, 4862.781174847105, 4905.386826646669, 4911.8772030699165, 4919.188333924933, 4925.088858561177, 7571.469997100206, 7665.540067595962, 7677.577733224671, 7689.269519395649, 7697.191794861571, 4198.0, 4959.454460009396, 4963.925541116886, 4978.950210497848, 4998.925016124761, 4516.864494065183, 4807.759612019385, 5060.987802439527, 5062.088824011713, 5070.797168113234, 5810.056967140434, 5915.231019967463, 5988.550858685616, 5994.340622531518, 6001.699915004319, 5925.525957923356, 7224.530405523624, 7251.3836323912, 7264.963675181591, 7299.781006569811, 1727.145063193727, 1762.8854124481868, 1768.9027103509172, 1769.7699299091037, 1777.2269062957655, 898.8674270419318, 1112.9443527823576, 1113.7438389170536, 1145.4272863568217, 1145.5360578965533, 6622.205335359788, 6677.964915438018, 6844.28135045823, 6853.691583878737, 6864.656767161622, 7614.771556853303, 7633.69465221385, 7650.120236172911, 7650.19672934345, 7659.157492675801, 5797.898399304118, 6853.623050732258, 6882.931170688229, 6918.8616227676175, 6920.8961865572055, 3886.9222615548097, 3987.0829709167056, 4027.4562934003534, 4034.1931613677384, 4037.152198038386, 7932.849736788134, 7949.443538952218, 7965.960170199228, 7965.968677987192, 7973.365460080669, 6732.831679208059, 7496.512726672749, 7770.650320735581, 7825.100113486908, 7874.05511338643, 7982.481138725964, 7984.281414672591, 7989.600519973978, 7992.240737129963, 7997.880031799527, 7070.257622949516, 7324.853502929805, 7612.391008719178, 7618.200088990576, 7618.352440042659, 5543.861403464945, 6238.469730072995, 7155.928440715526, 7458.627068646654, 7471.290227428385, 7982.321502672338, 7990.480618759762, 7999.400044996532, 8009.279164875189, 8011.599420029092, 4751.572358487752, 4803.615710743063, 4820.108279968217, 4821.758912054313, 4826.227803551415, 7312.926870731225, 7598.392128629807, 7631.465797394129, 7632.771016869503, 7645.426593005658, 7300.12398512182, 7335.963320183365, 7338.412926965937, 7342.3758980487255, 7350.338469537767, 7330.340269375782, 7339.486235963432, 7340.926590734024, 7362.558246505227, 7363.926360736538, 7196.856062878608, 7206.927930720625, 7212.170600380813, 7216.3505284524645, 7249.311315425026, 7124.002639630352, 7301.853962920605, 7353.374963128194, 7366.594837283787, 7372.815679607838, 6921.550099243735, 6962.1993470749485, 7129.572225666477, 7136.6788494518905, 7203.495755297079], "value": 5312.185868396316, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.9297066778656, 774.1523032279651, 787.0673252196148, 790.766723816474, 799.1888233443054, 15376.308066137022, 15723.056616603011, 15732.97735647185, 15743.527694169179, 15744.763828542567, 14332.0, 14413.711725765479, 14461.493847715332, 14473.059251148668, 14479.42082316706, 768.684839215923, 783.9764807055798, 935.434062392253, 955.2405837359281, 957.6935380678186, 936.0826390137669, 948.2319321349729, 952.2382094324547, 952.8094381123803, 953.270747877874, 827.234807802783, 1013.761765984993, 1016.7153197104823, 1018.0633816888443, 1018.2007124407342, 991.5240684471459, 1012.559536601577, 1014.6499457687086, 1016.0296916444778, 1016.9949150254201, 760.3878877503607, 763.9800865844105, 765.6516285090271, 767.5241350362755, 767.7274567528502, 15296.923515382463, 15363.0, 15372.154531500762, 15399.461018864286, 15401.845981540153, 12931.094823362368, 13055.673608159777, 13203.537876174289, 13337.799933001013, 13389.531366402227, 10193.694189174337, 11071.778564428667, 11101.500432480558, 11129.387883666395, 11558.19092663514, 3514.121469632592, 3529.94705079424, 3558.190519080112, 3606.801625910574, 3771.434284857266, 83660.0, 84088.0, 85700.0, 86337.0, 86775.0, 9512.809743805223, 9558.856617150748, 9562.235021198427, 9617.27870409722, 9787.265955053399, 22036.89815509218, 22089.0, 22129.557408852055, 22192.112315507522, 22397.216097436838, 7673.271039251262, 7676.80807979805, 7844.843103137905, 7906.841863162705, 8033.3974951878845, 4172.5410204877435, 4227.894302642397, 4228.175505776344, 4479.081788233404, 4502.347159661831, 3797.582265950743, 3852.7110466715108, 3862.2661694278, 3862.9227415451533, 3865.033741564609, 682.2529330383222, 700.9964950175319, 702.8594281143792, 705.3087973785719, 719.5251134251473, 601.6690820048956, 622.3434276837979, 622.6730966242668, 633.4425705379329, 648.7242921758234, 7322.633868306563, 7715.729949451742, 8378.79053023667, 8482.957585212034, 8557.786055348666, 507.42407367638, 585.1369230385147, 596.1058412381428, 610.8869859075996, 635.1362147479424, 3892.4355968384425, 3905.628965248297, 3945.6251656092627, 4002.1795531915886, 4188.476440444944, 84398.0, 84547.0, 85913.0, 93371.0662893376, 94149.05850941403, 76579.0, 77263.0, 79215.41569168585, 79803.0, 82693.0, 66153.33846661568, 66479.0, 66783.33216667868, 66816.33183668199, 67389.66305168443, 7555.962220189083, 7621.923780762121, 8579.442336248125, 8741.868871967054, 8978.685745998859, 48605.0, 51413.97172056463, 51478.48521514887, 51753.7412312936, 52152.739236303576, 58271.54321142005, 65968.0, 66735.66632166808, 67990.0, 69106.65446672935, 10968.725781855517, 11010.174236932102, 11334.093272538343, 11350.659480215607, 11575.594854180401, 10409.011143941314, 11428.314301141958, 11562.248453850472, 12154.149209555246, 12405.565805196775, 11083.445827708743, 11142.442877855912, 11225.550977960791, 11313.264637798517, 12245.265284082983, 11179.105671546095, 11184.664460066211, 11288.040516556184, 11477.483513241757, 12286.201396909173, 11099.44502774842, 11232.887671123512, 11255.155863310449, 11473.713157171138, 12203.755924881276, 9730.075642813921, 9834.655787047419, 10015.24885633595, 10128.645497407555, 10210.693679189637, 9690.95154524223, 9744.464054477072, 9752.756181095529, 9807.558659860466, 9808.411495310304], "value": 7098.262278421342, "unit": "score"}], "name": "dromaeo_css", "value": 7538.12013021266, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 121.0, 116.0, 119.0, 116.0, 114.0, 112.0, 114.0, 133.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 119.0, 149.0, 201.0, 153.0, 140.0, 117.0, 149.0, 155.0, 117.0], "value": 145.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 188.0, 184.0, 185.0, 185.0, 185.0, 184.0, 185.0, 183.0, 183.0], "value": 184.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 73.0, 142.0, 74.0, 83.0, 87.0, 95.0, 131.0, 56.0], "value": 88.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 139.0, 78.0, 78.0, 93.0, 117.0, 78.0, 74.0, 121.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 131.0, 100.0, 85.0, 86.0, 84.0, 86.0, 83.0, 87.0, 83.0], "value": 94.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 92.0, 91.0, 91.0, 93.0, 100.0, 92.0, 92.0, 92.0], "value": 92.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 85.0, 84.0, 91.0, 84.0, 84.0, 86.0, 87.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 63.0, 61.0, 61.0, 61.0, 63.0, 61.0, 77.0, 59.0, 56.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 60.0, 74.0, 69.0, 69.0, 63.0, 64.0, 65.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 93.0, 102.0, 101.0, 80.0, 78.0, 80.0, 78.0, 83.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 127.0, 125.0, 123.0, 113.0, 130.0, 136.0, 169.0, 160.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 180.0, 166.0, 163.0, 162.0, 165.0, 159.0, 166.0, 163.0, 159.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 83.0, 68.0, 65.0, 66.0, 68.0, 66.0, 67.0, 68.0, 66.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1487.1, "alertThreshold": 2.0}]} 01:46:24 INFO - Return code: 0 01:46:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:46:24 ERROR - # TBPL SUCCESS # 01:46:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:46:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:46:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:46:24 INFO - 2016-06-28 01:46:24.665 screenresolution[1683:9650] starting screenresolution argv=screenresolution get 01:46:24 INFO - 2016-06-28 01:46:24.667 screenresolution[1683:9650] Display 0: 1600x1200x32@60 01:46:24 INFO - 2016-06-28 01:46:24.673 screenresolution[1684:9653] starting screenresolution argv=screenresolution list 01:46:24 INFO - Available Modes on Display 0 01:46:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:46:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:46:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:46:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:46:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:46:24 INFO - Intel Iris: 01:46:24 INFO - Chipset Model: Intel Iris 01:46:24 INFO - Type: GPU 01:46:24 INFO - Bus: Built-In 01:46:24 INFO - VRAM (Dynamic, Max): 1536 MB 01:46:24 INFO - Vendor: Intel (0x8086) 01:46:24 INFO - Device ID: 0x0a2e 01:46:24 INFO - Revision ID: 0x0009 01:46:24 INFO - Displays: 01:46:24 INFO - Display: 01:46:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:46:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:46:24 INFO - Display Serial Number: 1600x1200 60 01:46:24 INFO - Main Display: Yes 01:46:24 INFO - Mirror: Off 01:46:24 INFO - Online: Yes 01:46:24 INFO - Rotation: Supported 01:46:24 INFO - Return code: 0 01:46:24 INFO - Running post-action listener: _resource_record_post_action 01:46:24 INFO - Running post-run listener: _resource_record_post_run 01:46:25 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 36992512; Write bytes: 493705216; Read time: 245; Write time: 1528 01:46:25 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194875904; Write bytes: 194609152; Read time: 17629; Write time: 441 01:46:25 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 35210752; Write bytes: 298248192; Read time: 229; Write time: 1085 01:46:25 INFO - Running post-run listener: _upload_blobber_files 01:46:25 INFO - Blob upload gear active. 01:46:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:46:25 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 01:46:25 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'] 01:46:25 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 01:46:26 INFO - (blobuploader) - INFO - Open directory for files ... 01:46:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:46:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:46:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:27 INFO - (blobuploader) - INFO - Done attempting. 01:46:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:46:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:46:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:28 INFO - (blobuploader) - INFO - Done attempting. 01:46:28 INFO - (blobuploader) - INFO - Iteration through files over. 01:46:28 INFO - Return code: 0 01:46:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:46:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:46:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f6c92d2fa9100b01061ec0d977c3b0dae65c736cdb92adb10724ff276d910d9491330b430cecdc4d2acde63c426a3073f34d4ebbad77729f8d7f561357dc7b98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cbae238b7d679234fc840b3406dbc8ce49328fa72bd9c56489b3818502502137dad2e3be5a319bba7a6097a0c5159f3efb6750bccab84012a7707eafdacc8d19"} 01:46:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:46:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:46:28 INFO - Contents: 01:46:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f6c92d2fa9100b01061ec0d977c3b0dae65c736cdb92adb10724ff276d910d9491330b430cecdc4d2acde63c426a3073f34d4ebbad77729f8d7f561357dc7b98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cbae238b7d679234fc840b3406dbc8ce49328fa72bd9c56489b3818502502137dad2e3be5a319bba7a6097a0c5159f3efb6750bccab84012a7707eafdacc8d19"} 01:46:28 INFO - Running post-run listener: copy_logs_to_upload_dir 01:46:28 INFO - Copying logs to upload dir... 01:46:28 INFO - mkdir: /builds/slave/test/build/upload/logs 01:46:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.975161 ========= master_lag: 286.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 36 secs) (at 2016-06-28 01:51:14.998321) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-06-28 01:51:15.002113) ========= 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.E4NAAeDxLR/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.S7oxffyII8/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f6c92d2fa9100b01061ec0d977c3b0dae65c736cdb92adb10724ff276d910d9491330b430cecdc4d2acde63c426a3073f34d4ebbad77729f8d7f561357dc7b98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cbae238b7d679234fc840b3406dbc8ce49328fa72bd9c56489b3818502502137dad2e3be5a319bba7a6097a0c5159f3efb6750bccab84012a7707eafdacc8d19"} build_url:https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010822 build_url: 'https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f6c92d2fa9100b01061ec0d977c3b0dae65c736cdb92adb10724ff276d910d9491330b430cecdc4d2acde63c426a3073f34d4ebbad77729f8d7f561357dc7b98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cbae238b7d679234fc840b3406dbc8ce49328fa72bd9c56489b3818502502137dad2e3be5a319bba7a6097a0c5159f3efb6750bccab84012a7707eafdacc8d19"}' ========= master_lag: 2.48 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-06-28 01:51:17.497146) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 01:51:17.497462) ========= 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.E4NAAeDxLR/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.S7oxffyII8/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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.005167 ========= master_lag: 1.88 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 01:51:19.385112) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-06-28 01:51:19.385444) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-06-28 01:51:22.447049) ========= ========= Total master_lag: 290.88 =========