builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0172 starttime: 1462476987.83 results: success (0) buildid: 20160505103549 builduid: 8361b36a9884444a90c4aecf69086259 revision: d053b705b3695004dfd4f0103de8a148b0ded450 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 12:36:27.832505) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 12:36:27.832921) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 12:36:27.833188) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 12:36:27.859367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 12:36:27.859725) ========= 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.9VedmZxqqL/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.yJLzkfCmdM/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-05 12:36:27-- 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% 181M=0s 2016-05-05 12:36:28 (181 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138747 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 12:36:28.117101) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 12:36:28.117418) ========= 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.9VedmZxqqL/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.yJLzkfCmdM/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.026974 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 12:36:28.160945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 12:36:28.161266) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d053b705b3695004dfd4f0103de8a148b0ded450 --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 d053b705b3695004dfd4f0103de8a148b0ded450 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9VedmZxqqL/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.yJLzkfCmdM/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-05 12:36:28,240 truncating revision to first 12 chars 2016-05-05 12:36:28,240 Setting DEBUG logging. 2016-05-05 12:36:28,240 attempt 1/10 2016-05-05 12:36:28,240 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d053b705b369?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 12:36:29,284 unpacking tar archive at: mozilla-beta-d053b705b369/testing/mozharness/ program finished with exit code 0 elapsedTime=1.294761 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 12:36:29.472561) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 12:36:29.472869) ========= script_repo_revision: d053b705b3695004dfd4f0103de8a148b0ded450 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 12:36:29.473240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 12:36:29.473498) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 12:36:29.486566) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-05 12:36:29.486861) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9VedmZxqqL/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.yJLzkfCmdM/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 12:36:29 INFO - MultiFileLogger online at 20160505 12:36:29 in /builds/slave/test 12:36:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:36:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:36:29 INFO - {'append_to_log': False, 12:36:29 INFO - 'base_work_dir': '/builds/slave/test', 12:36:29 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:36:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:36:29 INFO - 'branch': 'Mozilla-Beta', 12:36:29 INFO - 'buildbot_json_path': 'buildprops.json', 12:36:29 INFO - 'config_files': ('talos/mac_config.py',), 12:36:29 INFO - 'default_actions': ('clobber', 12:36:29 INFO - 'read-buildbot-config', 12:36:29 INFO - 'download-and-extract', 12:36:29 INFO - 'populate-webroot', 12:36:29 INFO - 'create-virtualenv', 12:36:29 INFO - 'install', 12:36:29 INFO - 'run-tests'), 12:36:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:36:29 INFO - 'download_minidump_stackwalk': True, 12:36:29 INFO - 'download_symbols': 'ondemand', 12:36:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:36:29 INFO - 'tooltool.py': '/tools/tooltool.py', 12:36:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:36:29 INFO - '/tools/misc-python/virtualenv.py')}, 12:36:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:36:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:36:29 INFO - 'installer_path': 'installer.exe', 12:36:29 INFO - 'log_level': 'info', 12:36:29 INFO - 'log_name': 'talos', 12:36:29 INFO - 'log_to_console': True, 12:36:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:36:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:36:29 INFO - 'opt_config_files': (), 12:36:29 INFO - 'pip_index': False, 12:36:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:36:29 INFO - 'cmd': ('bash', 12:36:29 INFO - '-c', 12:36:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:36:29 INFO - 'enabled': True, 12:36:29 INFO - 'halt_on_failure': False, 12:36:29 INFO - 'name': 'check_screen_resolution'},), 12:36:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:36:29 INFO - 'cmd': ('bash', 12:36:29 INFO - '-c', 12:36:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:36:29 INFO - 'enabled': True, 12:36:29 INFO - 'halt_on_failure': False, 12:36:29 INFO - 'name': 'check_screen_resolution'},), 12:36:29 INFO - 'run_cmd_checks_enabled': True, 12:36:29 INFO - 'sps_profile': False, 12:36:29 INFO - 'sps_profile_interval': 0, 12:36:29 INFO - 'suite': 'dromaeojs-e10s', 12:36:29 INFO - 'system_bits': '32', 12:36:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:36:29 INFO - 'title': 't-yosemite-r7-0172', 12:36:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:36:29 INFO - 'use_talos_json': True, 12:36:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:36:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:36:29 INFO - 'work_dir': 'build'} 12:36:29 INFO - ##### 12:36:29 INFO - ##### Running clobber step. 12:36:29 INFO - ##### 12:36:29 INFO - Running pre-action listener: _resource_record_pre_action 12:36:29 INFO - Running main action method: clobber 12:36:29 INFO - rmtree: /builds/slave/test/build 12:36:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:36:31 INFO - Running post-action listener: _resource_record_post_action 12:36:31 INFO - ##### 12:36:31 INFO - ##### Running read-buildbot-config step. 12:36:31 INFO - ##### 12:36:31 INFO - Running pre-action listener: _resource_record_pre_action 12:36:31 INFO - Running main action method: read_buildbot_config 12:36:31 INFO - Using buildbot properties: 12:36:31 INFO - { 12:36:31 INFO - "project": "", 12:36:31 INFO - "product": "firefox", 12:36:31 INFO - "script_repo_revision": "production", 12:36:31 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 12:36:31 INFO - "repository": "", 12:36:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 12:36:31 INFO - "buildid": "20160505103549", 12:36:31 INFO - "pgo_build": "False", 12:36:31 INFO - "basedir": "/builds/slave/test", 12:36:31 INFO - "buildnumber": 0, 12:36:31 INFO - "slavename": "t-yosemite-r7-0172", 12:36:31 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 12:36:31 INFO - "platform": "yosemite_r7", 12:36:31 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:36:31 INFO - "branch": "mozilla-beta", 12:36:31 INFO - "repo_path": "releases/mozilla-beta", 12:36:31 INFO - "revision": "d053b705b3695004dfd4f0103de8a148b0ded450", 12:36:31 INFO - "stage_platform": "macosx64", 12:36:31 INFO - "builduid": "8361b36a9884444a90c4aecf69086259", 12:36:31 INFO - "slavebuilddir": "test" 12:36:31 INFO - } 12:36:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 12:36:31 INFO - Running post-action listener: _resource_record_post_action 12:36:31 INFO - ##### 12:36:31 INFO - ##### Running download-and-extract step. 12:36:31 INFO - ##### 12:36:31 INFO - Running pre-action listener: _resource_record_pre_action 12:36:31 INFO - Running main action method: download_and_extract 12:36:31 INFO - mkdir: /builds/slave/test/build/tests 12:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:31 INFO - https://queue.taskcluster.net/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:36:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 12:36:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 12:36:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 12:36:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 12:36:32 INFO - Downloaded 1241 bytes. 12:36:32 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 12:36:32 INFO - Using the following test package requirements: 12:36:32 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 12:36:32 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 12:36:32 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 12:36:32 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 12:36:32 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 12:36:32 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:36:32 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 12:36:32 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 12:36:32 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 12:36:32 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 12:36:32 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 12:36:32 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 12:36:32 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 12:36:32 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 12:36:32 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 12:36:32 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 12:36:32 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 12:36:32 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 12:36:32 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 12:36:32 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')]} 12:36:32 INFO - https://queue.taskcluster.net/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:36:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 12:36:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 12:36:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 12:36:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 12:36:34 INFO - Downloaded 17747489 bytes. 12:36:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:36:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:36:37 INFO - Return code: 0 12:36:37 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 12:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:37 INFO - https://queue.taskcluster.net/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:36:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 12:36:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 12:36:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 12:36:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 12:36:40 INFO - Downloaded 17747489 bytes. 12:36:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:36:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:36:44 INFO - Return code: 0 12:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:44 INFO - https://queue.taskcluster.net/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:36:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 12:36:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 12:36:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 12:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 12:36:45 INFO - Downloaded 10845194 bytes. 12:36:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:36:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 12:36:45 INFO - Return code: 0 12:36:45 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')]} 12:36:45 INFO - https://queue.taskcluster.net/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 12:36:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 12:36:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 12:36:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 12:36:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 12:36:48 INFO - Downloaded 88358879 bytes. 12:36:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 12:36:48 INFO - mkdir: /builds/slave/test/properties 12:36:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:36:48 INFO - Writing to file /builds/slave/test/properties/build_url 12:36:48 INFO - Contents: 12:36:48 INFO - build_url:https://queue.taskcluster.net/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 12:36:49 INFO - Running post-action listener: _resource_record_post_action 12:36:49 INFO - Running post-action listener: set_extra_try_arguments 12:36:49 INFO - ##### 12:36:49 INFO - ##### Running populate-webroot step. 12:36:49 INFO - ##### 12:36:49 INFO - Running pre-action listener: _resource_record_pre_action 12:36:49 INFO - Running main action method: populate_webroot 12:36:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:36:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:36:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:36:49 INFO - '--tppagecycles', 12:36:49 INFO - '7'], 12:36:49 INFO - 'tests': ['tsvgm']}}, 12:36:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:36:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:36:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:36:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:36:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:36:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:36:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:36:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:49 INFO - 'talos_options': ['--e10s'], 12:36:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:36:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:49 INFO - 'tests': ['damp', 'tps']}, 12:36:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:49 INFO - 'talos_options': ['--e10s'], 12:36:49 INFO - 'tests': ['damp', 'tps']}, 12:36:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:36:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:36:49 INFO - 'other': {'tests': ['a11yr', 12:36:49 INFO - 'ts_paint', 12:36:49 INFO - 'tpaint', 12:36:49 INFO - 'sessionrestore', 12:36:49 INFO - 'sessionrestore_no_auto_restore', 12:36:49 INFO - 'tabpaint']}, 12:36:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:36:49 INFO - 'tests': ['a11yr', 12:36:49 INFO - 'ts_paint', 12:36:49 INFO - 'tpaint', 12:36:49 INFO - 'sessionrestore', 12:36:49 INFO - 'sessionrestore_no_auto_restore', 12:36:49 INFO - 'tabpaint']}, 12:36:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:36:49 INFO - 'tests': ['a11yr', 12:36:49 INFO - 'ts_paint', 12:36:49 INFO - 'tpaint', 12:36:49 INFO - 'sessionrestore', 12:36:49 INFO - 'sessionrestore_no_auto_restore', 12:36:49 INFO - 'tabpaint']}, 12:36:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:36:49 INFO - 'tests': ['a11yr', 12:36:49 INFO - 'ts_paint', 12:36:49 INFO - 'tpaint', 12:36:49 INFO - 'sessionrestore', 12:36:49 INFO - 'sessionrestore_no_auto_restore', 12:36:49 INFO - 'tabpaint']}, 12:36:49 INFO - 'other_l64': {'tests': ['a11yr', 12:36:49 INFO - 'ts_paint', 12:36:49 INFO - 'tpaint', 12:36:49 INFO - 'sessionrestore', 12:36:49 INFO - 'sessionrestore_no_auto_restore', 12:36:49 INFO - 'tabpaint']}, 12:36:49 INFO - 'other_nol64': {'tests': ['a11yr', 12:36:49 INFO - 'ts_paint', 12:36:49 INFO - 'tpaint', 12:36:49 INFO - 'sessionrestore', 12:36:49 INFO - 'sessionrestore_no_auto_restore', 12:36:49 INFO - 'tabpaint']}, 12:36:49 INFO - 'svgr': {'tests': ['tsvgx', 12:36:49 INFO - 'tsvgr_opacity', 12:36:49 INFO - 'tart', 12:36:49 INFO - 'tscrollx', 12:36:49 INFO - 'cart']}, 12:36:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:36:49 INFO - 'tests': ['tsvgx', 12:36:49 INFO - 'tsvgr_opacity', 12:36:49 INFO - 'tart', 12:36:49 INFO - 'tscrollx', 12:36:49 INFO - 'cart']}, 12:36:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:49 INFO - 'tests': ['tp5o']}, 12:36:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:49 INFO - 'talos_options': ['--e10s'], 12:36:49 INFO - 'tests': ['tp5o']}, 12:36:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:49 INFO - 'talos_options': ['--xperf_path', 12:36:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:36:49 INFO - 'tests': ['tp5n']}, 12:36:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:49 INFO - 'talos_options': ['--e10s', 12:36:49 INFO - '--xperf_path', 12:36:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:36:49 INFO - 'tests': ['tp5n']}}, 12:36:49 INFO - 'talos.zip': {'path': '', 12:36:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:36:49 INFO - Running post-action listener: _resource_record_post_action 12:36:49 INFO - ##### 12:36:49 INFO - ##### Running create-virtualenv step. 12:36:49 INFO - ##### 12:36:49 INFO - Running pre-action listener: _resource_record_pre_action 12:36:49 INFO - Running main action method: create_virtualenv 12:36:49 INFO - Creating virtualenv /builds/slave/test/build/venv 12:36:49 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 12:36:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:36:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:36:49 INFO - Using real prefix '/tools/python27' 12:36:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:36:50 INFO - Installing distribute.............................................................................................................................................................................................done. 12:36:53 INFO - Installing pip.................done. 12:36:53 INFO - Return code: 0 12:36:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:36:53 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')]} 12:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:53 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')]} 12:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:53 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 0x10bb67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e68d76e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba0bd30>, '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 0x10b86fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba02b20>, '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.9VedmZxqqL/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.yJLzkfCmdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 12:36:53 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 12:36:53 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 12:36:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9VedmZxqqL/Render', 12:36:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:36:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:36:53 INFO - 'HOME': '/Users/cltbld', 12:36:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:36:53 INFO - 'LOGNAME': 'cltbld', 12:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:53 INFO - 'MOZ_NO_REMOTE': '1', 12:36:53 INFO - 'NO_EM_RESTART': '1', 12:36:53 INFO - 'PAGER': '/bin/cat', 12:36:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:53 INFO - 'PWD': '/builds/slave/test', 12:36:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:36:53 INFO - 'SHELL': '/bin/bash', 12:36:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yJLzkfCmdM/Listeners', 12:36:53 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 12:36:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:36:53 INFO - 'USER': 'cltbld', 12:36:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:36:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:53 INFO - 'XPC_FLAGS': '0x0', 12:36:53 INFO - 'XPC_SERVICE_NAME': '0', 12:36:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:53 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 12:36:53 INFO - Cleaning up... 12:36:53 INFO - Return code: 0 12:36:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:36:53 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')]} 12:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:53 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')]} 12:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:53 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 0x10bb67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e68d76e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba0bd30>, '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 0x10b86fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba02b20>, '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.9VedmZxqqL/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.yJLzkfCmdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 12:36:53 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 12:36:53 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 12:36:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9VedmZxqqL/Render', 12:36:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:36:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:36:53 INFO - 'HOME': '/Users/cltbld', 12:36:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:36:53 INFO - 'LOGNAME': 'cltbld', 12:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:53 INFO - 'MOZ_NO_REMOTE': '1', 12:36:53 INFO - 'NO_EM_RESTART': '1', 12:36:53 INFO - 'PAGER': '/bin/cat', 12:36:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:53 INFO - 'PWD': '/builds/slave/test', 12:36:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:36:53 INFO - 'SHELL': '/bin/bash', 12:36:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yJLzkfCmdM/Listeners', 12:36:53 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 12:36:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:36:53 INFO - 'USER': 'cltbld', 12:36:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:36:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:53 INFO - 'XPC_FLAGS': '0x0', 12:36:53 INFO - 'XPC_SERVICE_NAME': '0', 12:36:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:54 INFO - Downloading/unpacking psutil>=0.7.1 12:36:54 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 12:36:54 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 12:36:54 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 12:36:54 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 12:36:54 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 12:36:54 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 12:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:36:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:36:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:36:56 INFO - Installing collected packages: psutil 12:36:56 INFO - Running setup.py install for psutil 12:36:57 INFO - building 'psutil._psutil_osx' extension 12:36:57 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 12:36:57 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 12:36:57 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 12:36:57 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 12:36:57 INFO - building 'psutil._psutil_posix' extension 12:36:57 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 12:36:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:36:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:36:58 INFO - ^ 12:36:58 INFO - 1 warning generated. 12:36:58 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 12:36:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:36:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:36:58 INFO - Successfully installed psutil 12:36:58 INFO - Cleaning up... 12:36:58 INFO - Return code: 0 12:36:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:58 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 0x10bb67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e68d76e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba0bd30>, '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 0x10b86fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba02b20>, '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.9VedmZxqqL/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.yJLzkfCmdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 12:36:58 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 12:36:58 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 12:36:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9VedmZxqqL/Render', 12:36:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:36:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:36:58 INFO - 'HOME': '/Users/cltbld', 12:36:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:36:58 INFO - 'LOGNAME': 'cltbld', 12:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:58 INFO - 'MOZ_NO_REMOTE': '1', 12:36:58 INFO - 'NO_EM_RESTART': '1', 12:36:58 INFO - 'PAGER': '/bin/cat', 12:36:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:58 INFO - 'PWD': '/builds/slave/test', 12:36:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:36:58 INFO - 'SHELL': '/bin/bash', 12:36:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yJLzkfCmdM/Listeners', 12:36:58 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 12:36:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:36:58 INFO - 'USER': 'cltbld', 12:36:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:36:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:58 INFO - 'XPC_FLAGS': '0x0', 12:36:58 INFO - 'XPC_SERVICE_NAME': '0', 12:36:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:36:58 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 12:36:58 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 12:36:58 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 12:36:58 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 12:36:58 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 12:36:58 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 12:37:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:37:00 INFO - Installing collected packages: mozsystemmonitor 12:37:00 INFO - Running setup.py install for mozsystemmonitor 12:37:01 INFO - Successfully installed mozsystemmonitor 12:37:01 INFO - Cleaning up... 12:37:01 INFO - Return code: 0 12:37:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:37:01 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')]} 12:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:01 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')]} 12:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:01 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 0x10bb67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e68d76e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba0bd30>, '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 0x10b86fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba02b20>, '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.9VedmZxqqL/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.yJLzkfCmdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 12:37:01 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 12:37:01 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 12:37:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9VedmZxqqL/Render', 12:37:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:37:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:37:01 INFO - 'HOME': '/Users/cltbld', 12:37:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:37:01 INFO - 'LOGNAME': 'cltbld', 12:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:01 INFO - 'MOZ_NO_REMOTE': '1', 12:37:01 INFO - 'NO_EM_RESTART': '1', 12:37:01 INFO - 'PAGER': '/bin/cat', 12:37:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:01 INFO - 'PWD': '/builds/slave/test', 12:37:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:37:01 INFO - 'SHELL': '/bin/bash', 12:37:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yJLzkfCmdM/Listeners', 12:37:01 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 12:37:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:37:01 INFO - 'USER': 'cltbld', 12:37:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:37:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:01 INFO - 'XPC_FLAGS': '0x0', 12:37:01 INFO - 'XPC_SERVICE_NAME': '0', 12:37:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:37:01 INFO - Downloading/unpacking blobuploader==1.2.4 12:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:03 INFO - Downloading blobuploader-1.2.4.tar.gz 12:37:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:37:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:37: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 12:37: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 12:37: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 12:37: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 12:37: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 12:37: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 12:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:37:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:04 INFO - Downloading docopt-0.6.1.tar.gz 12:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:37:05 INFO - Installing collected packages: blobuploader, requests, docopt 12:37:05 INFO - Running setup.py install for blobuploader 12:37:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:37:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:37:05 INFO - Running setup.py install for requests 12:37:05 INFO - Running setup.py install for docopt 12:37:05 INFO - Successfully installed blobuploader requests docopt 12:37:05 INFO - Cleaning up... 12:37:05 INFO - Return code: 0 12:37:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:37:05 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')]} 12:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:05 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')]} 12:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:05 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 0x10bb67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e68d76e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba0bd30>, '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 0x10b86fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba02b20>, '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.9VedmZxqqL/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.yJLzkfCmdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 12:37:05 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 12:37:05 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 12:37:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9VedmZxqqL/Render', 12:37:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:37:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:37:05 INFO - 'HOME': '/Users/cltbld', 12:37:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:37:05 INFO - 'LOGNAME': 'cltbld', 12:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:05 INFO - 'MOZ_NO_REMOTE': '1', 12:37:05 INFO - 'NO_EM_RESTART': '1', 12:37:05 INFO - 'PAGER': '/bin/cat', 12:37:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:05 INFO - 'PWD': '/builds/slave/test', 12:37:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:37:05 INFO - 'SHELL': '/bin/bash', 12:37:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yJLzkfCmdM/Listeners', 12:37:05 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 12:37:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:37:05 INFO - 'USER': 'cltbld', 12:37:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:37:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:05 INFO - 'XPC_FLAGS': '0x0', 12:37:05 INFO - 'XPC_SERVICE_NAME': '0', 12:37:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:37:06 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-LSrA3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:37:06 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-tIJ_RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:37:06 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-njF_bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:37:06 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-hFOqx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:37:06 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-XhqSk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:37:06 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-XZCTZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:37:06 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-OxYYKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:37:06 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-t7Gagi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:37:07 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-duEU50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:37:07 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-iG_kSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:37:07 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-wDeW8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:37:07 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-fcmJ43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:37:07 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-fAfr5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:37:07 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-w8K2Ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:37:07 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-DYbW5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:37:07 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-Vic24m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:37:07 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-EG8sCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:37:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:37:07 INFO - Running setup.py install for manifestparser 12:37:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:37:08 INFO - Running setup.py install for mozcrash 12:37:08 INFO - Running setup.py install for mozdebug 12:37:08 INFO - Running setup.py install for mozdevice 12:37:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:37:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:37:08 INFO - Running setup.py install for mozfile 12:37:08 INFO - Running setup.py install for mozhttpd 12:37:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:37:08 INFO - Running setup.py install for mozinfo 12:37:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:37:08 INFO - Running setup.py install for mozInstall 12:37:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:37:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:37:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:37:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:37:09 INFO - Running setup.py install for mozleak 12:37:09 INFO - Running setup.py install for mozlog 12:37:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:37:09 INFO - Running setup.py install for moznetwork 12:37:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:37:09 INFO - Running setup.py install for mozprocess 12:37:09 INFO - Running setup.py install for mozprofile 12:37:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:37:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:37:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:37:09 INFO - Running setup.py install for mozrunner 12:37:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:37:10 INFO - Running setup.py install for mozscreenshot 12:37:10 INFO - Running setup.py install for moztest 12:37:10 INFO - Running setup.py install for mozversion 12:37:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:37:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:37:10 INFO - Cleaning up... 12:37:10 INFO - Return code: 0 12:37:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:37:10 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')]} 12:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:10 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')]} 12:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:10 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 0x10bb67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e68d76e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba0bd30>, '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 0x10b86fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba02b20>, '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.9VedmZxqqL/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.yJLzkfCmdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 12:37:10 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 12:37:10 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 12:37:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9VedmZxqqL/Render', 12:37:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:37:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:37:10 INFO - 'HOME': '/Users/cltbld', 12:37:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:37:10 INFO - 'LOGNAME': 'cltbld', 12:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:10 INFO - 'MOZ_NO_REMOTE': '1', 12:37:10 INFO - 'NO_EM_RESTART': '1', 12:37:10 INFO - 'PAGER': '/bin/cat', 12:37:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:10 INFO - 'PWD': '/builds/slave/test', 12:37:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:37:10 INFO - 'SHELL': '/bin/bash', 12:37:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yJLzkfCmdM/Listeners', 12:37:10 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 12:37:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:37:10 INFO - 'USER': 'cltbld', 12:37:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:37:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:10 INFO - 'XPC_FLAGS': '0x0', 12:37:10 INFO - 'XPC_SERVICE_NAME': '0', 12:37:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:37:10 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-7JgpIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:37:10 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)) 12:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:37:10 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-Bfbjt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:37:11 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)) 12:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:37:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-vViydu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:37:11 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)) 12:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:37:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-pugqdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:37:11 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)) 12:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:37:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-6TEKqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:37:11 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)) 12:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:37:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-dGsuYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:37:11 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)) 12:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:37:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-ro5e4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:37:11 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)) 12:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:37:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-ZzBanh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:37:11 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)) 12:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:37:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-UdYb09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:37:11 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)) 12:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:37:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-l5c5JF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:37:11 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)) 12:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:37:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-d2LL0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:37:11 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)) 12:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:37:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-uDIZIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:37:12 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)) 12:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:37:12 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-A78dx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:37:12 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)) 12:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:37:12 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-rp8FPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:37:12 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)) 12:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:37:12 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-497PVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:37:12 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)) 12:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:37:12 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-EO5YBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:37:12 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)) 12:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:37:12 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-d5CKLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:37:12 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)) 12:37:12 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)) 12:37:12 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)) 12:37:12 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)) 12:37:12 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)) 12:37:12 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)) 12:37:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:37:12 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 12:37:12 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 12:37:12 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 12:37:12 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 12:37:12 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 12:37:12 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 12:37:14 INFO - Downloading blessings-1.6.tar.gz 12:37:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:37:15 INFO - Installing collected packages: blessings 12:37:15 INFO - Running setup.py install for blessings 12:37:15 INFO - Successfully installed blessings 12:37:15 INFO - Cleaning up... 12:37:15 INFO - Return code: 0 12:37:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:37:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:37:15 INFO - Reading from file tmpfile_stdout 12:37:15 INFO - Current package versions: 12:37:15 INFO - blessings == 1.6 12:37:15 INFO - blobuploader == 1.2.4 12:37:15 INFO - docopt == 0.6.1 12:37:15 INFO - manifestparser == 1.1 12:37:15 INFO - mozInstall == 1.12 12:37:15 INFO - mozcrash == 0.17 12:37:15 INFO - mozdebug == 0.1 12:37:15 INFO - mozdevice == 0.48 12:37:15 INFO - mozfile == 1.2 12:37:15 INFO - mozhttpd == 0.7 12:37:15 INFO - mozinfo == 0.9 12:37:15 INFO - mozleak == 0.1 12:37:15 INFO - mozlog == 3.1 12:37:15 INFO - moznetwork == 0.27 12:37:15 INFO - mozprocess == 0.22 12:37:15 INFO - mozprofile == 0.28 12:37:15 INFO - mozrunner == 6.11 12:37:15 INFO - mozscreenshot == 0.1 12:37:15 INFO - mozsystemmonitor == 0.0 12:37:15 INFO - moztest == 0.7 12:37:15 INFO - mozversion == 1.4 12:37:15 INFO - psutil == 3.1.1 12:37:15 INFO - requests == 1.2.3 12:37:15 INFO - wsgiref == 0.1.2 12:37:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:15 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 0x10bb67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e68d76e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba0bd30>, '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 0x10b86fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba02b20>, '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.9VedmZxqqL/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.yJLzkfCmdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 12:37:15 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 12:37:15 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 12:37:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9VedmZxqqL/Render', 12:37:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:37:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:37:15 INFO - 'HOME': '/Users/cltbld', 12:37:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:37:15 INFO - 'LOGNAME': 'cltbld', 12:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:15 INFO - 'MOZ_NO_REMOTE': '1', 12:37:15 INFO - 'NO_EM_RESTART': '1', 12:37:15 INFO - 'PAGER': '/bin/cat', 12:37:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:15 INFO - 'PWD': '/builds/slave/test', 12:37:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:37:15 INFO - 'SHELL': '/bin/bash', 12:37:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yJLzkfCmdM/Listeners', 12:37:15 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 12:37:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:37:15 INFO - 'USER': 'cltbld', 12:37:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:37:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:15 INFO - 'XPC_FLAGS': '0x0', 12:37:15 INFO - 'XPC_SERVICE_NAME': '0', 12:37:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:37:15 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)) 12:37:15 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)) 12:37:15 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)) 12:37:15 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)) 12:37:15 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)) 12:37:15 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)) 12:37:15 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)) 12:37:15 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)) 12:37:15 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)) 12:37:15 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)) 12:37:15 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)) 12:37:15 INFO - Cleaning up... 12:37:15 INFO - Return code: 0 12:37:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:15 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 0x10bb67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e68d76e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba0bd30>, '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 0x10b86fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba02b20>, '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.9VedmZxqqL/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.yJLzkfCmdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 12:37:15 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 12:37:15 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 12:37:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9VedmZxqqL/Render', 12:37:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:37:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:37:15 INFO - 'HOME': '/Users/cltbld', 12:37:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:37:15 INFO - 'LOGNAME': 'cltbld', 12:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:15 INFO - 'MOZ_NO_REMOTE': '1', 12:37:15 INFO - 'NO_EM_RESTART': '1', 12:37:15 INFO - 'PAGER': '/bin/cat', 12:37:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:15 INFO - 'PWD': '/builds/slave/test', 12:37:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:37:15 INFO - 'SHELL': '/bin/bash', 12:37:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yJLzkfCmdM/Listeners', 12:37:15 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 12:37:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:37:15 INFO - 'USER': 'cltbld', 12:37:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:37:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:15 INFO - 'XPC_FLAGS': '0x0', 12:37:15 INFO - 'XPC_SERVICE_NAME': '0', 12:37:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:37:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:37:16 INFO - Downloading/unpacking jsonschema 12:37:16 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 12:37:16 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 12:37:16 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 12:37:16 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 12:37:16 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 12:37:16 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 12:37:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:37:18 INFO - Downloading/unpacking functools32 (from jsonschema) 12:37: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 12:37: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 12:37: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 12:37: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 12:37: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 12:37: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 12:37:18 INFO - Downloading functools32-3.2.3-2.tar.gz 12:37:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:37:18 INFO - warning: no files found matching '*.txt' 12:37:18 INFO - no previously-included directories found matching 'build' 12:37:18 INFO - no previously-included directories found matching 'dist' 12:37:18 INFO - no previously-included directories found matching '.git*' 12:37:18 INFO - Installing collected packages: jsonschema, functools32 12:37:19 INFO - Running setup.py install for functools32 12:37:19 INFO - warning: no files found matching '*.txt' 12:37:19 INFO - no previously-included directories found matching 'build' 12:37:19 INFO - no previously-included directories found matching 'dist' 12:37:19 INFO - no previously-included directories found matching '.git*' 12:37:19 INFO - Successfully installed jsonschema functools32 12:37:19 INFO - Cleaning up... 12:37:19 INFO - Return code: 0 12:37:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:19 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 0x10bb67a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb6e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e68d76e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba0bd30>, '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 0x10b86fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba02b20>, '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.9VedmZxqqL/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.yJLzkfCmdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 12:37:19 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 12:37:19 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 12:37:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9VedmZxqqL/Render', 12:37:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:37:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:37:19 INFO - 'HOME': '/Users/cltbld', 12:37:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:37:19 INFO - 'LOGNAME': 'cltbld', 12:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:19 INFO - 'MOZ_NO_REMOTE': '1', 12:37:19 INFO - 'NO_EM_RESTART': '1', 12:37:19 INFO - 'PAGER': '/bin/cat', 12:37:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:19 INFO - 'PWD': '/builds/slave/test', 12:37:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:37:19 INFO - 'SHELL': '/bin/bash', 12:37:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yJLzkfCmdM/Listeners', 12:37:19 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 12:37:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:37:19 INFO - 'USER': 'cltbld', 12:37:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:37:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:19 INFO - 'XPC_FLAGS': '0x0', 12:37:19 INFO - 'XPC_SERVICE_NAME': '0', 12:37:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:37:19 INFO - Downloading/unpacking flake8 12:37:19 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 12:37:19 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 12:37:19 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 12:37:19 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 12:37:19 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 12:37:19 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 12:37:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:37:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:37: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 12:37: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 12:37: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 12:37: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 12:37: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 12:37: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 12:37:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:37:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:37:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:37:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:37:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:37:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:37:23 INFO - no previously-included directories found matching 'docs/_build' 12:37:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:37:23 INFO - Running setup.py install for pep8 12:37:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:37:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:37:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:37:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:37:23 INFO - no previously-included directories found matching 'docs/_build' 12:37:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:37:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:37:23 INFO - Cleaning up... 12:37:23 INFO - Return code: 0 12:37:23 INFO - Running post-action listener: _resource_record_post_action 12:37:23 INFO - Running post-action listener: _start_resource_monitoring 12:37:23 INFO - Starting resource monitoring. 12:37:23 INFO - ##### 12:37:23 INFO - ##### Running install step. 12:37:23 INFO - ##### 12:37:23 INFO - Running pre-action listener: _resource_record_pre_action 12:37:23 INFO - Running main action method: install 12:37:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:37:23 INFO - Reading from file tmpfile_stdout 12:37:23 INFO - Detecting whether we're running mozinstall >=1.0... 12:37:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:37:24 INFO - Reading from file tmpfile_stdout 12:37:24 INFO - Output received: 12:37:24 INFO - Usage: mozinstall [options] installer 12:37:24 INFO - Options: 12:37:24 INFO - -h, --help show this help message and exit 12:37:24 INFO - -d DEST, --destination=DEST 12:37:24 INFO - Directory to install application into. [default: 12:37:24 INFO - "/builds/slave/test"] 12:37:24 INFO - --app=APP Application being installed. [default: firefox] 12:37:24 INFO - mkdir: /builds/slave/test/build/application 12:37:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:37:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 12:37:46 INFO - Reading from file tmpfile_stdout 12:37:46 INFO - Output received: 12:37:46 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:37:46 INFO - Running post-action listener: _resource_record_post_action 12:37:46 INFO - ##### 12:37:46 INFO - ##### Running run-tests step. 12:37:46 INFO - ##### 12:37:46 INFO - Running pre-action listener: _resource_record_pre_action 12:37:46 INFO - Running main action method: run_tests 12:37:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:37:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:37:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:37:46 INFO - 2016-05-05 12:37:46.191 screenresolution[1642:7404] starting screenresolution argv=screenresolution get 12:37:46 INFO - 2016-05-05 12:37:46.193 screenresolution[1642:7404] Display 0: 1600x1200x32@60 12:37:46 INFO - 2016-05-05 12:37:46.199 screenresolution[1643:7407] starting screenresolution argv=screenresolution list 12:37:46 INFO - Available Modes on Display 0 12:37:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:37:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:37:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:37:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:37:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:37:46 INFO - Intel Iris: 12:37:46 INFO - Chipset Model: Intel Iris 12:37:46 INFO - Type: GPU 12:37:46 INFO - Bus: Built-In 12:37:46 INFO - VRAM (Dynamic, Max): 1536 MB 12:37:46 INFO - Vendor: Intel (0x8086) 12:37:46 INFO - Device ID: 0x0a2e 12:37:46 INFO - Revision ID: 0x0009 12:37:46 INFO - Displays: 12:37:46 INFO - Display: 12:37:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:37:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:37:46 INFO - Display Serial Number: 1600x1200 60 12:37:46 INFO - Main Display: Yes 12:37:46 INFO - Mirror: Off 12:37:46 INFO - Online: Yes 12:37:46 INFO - Rotation: Supported 12:37:46 INFO - Return code: 0 12:37:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:37:46 INFO - Python 2.7.3 12:37:46 INFO - Return code: 0 12:37:46 INFO - grabbing minidump binary from tooltool 12:37: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')]} 12:37:46 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba0bd30>, '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 0x10b86fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba02b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:37:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:37:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:37:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:37:46 INFO - Return code: 0 12:37:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:37:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:37:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:37:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:37:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:37:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:37:47 INFO - Return code: 0 12:37:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0172', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0172 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:37:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9VedmZxqqL/Render', 12:37:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:37:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:37:47 INFO - 'HOME': '/Users/cltbld', 12:37:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:37:47 INFO - 'LOGNAME': 'cltbld', 12:37:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:37:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:47 INFO - 'MOZ_NO_REMOTE': '1', 12:37:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:37:47 INFO - 'NO_EM_RESTART': '1', 12:37:47 INFO - 'PAGER': '/bin/cat', 12:37:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:47 INFO - 'PWD': '/builds/slave/test', 12:37:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:37:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:37:47 INFO - 'SHELL': '/bin/bash', 12:37:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yJLzkfCmdM/Listeners', 12:37:47 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 12:37:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:37:47 INFO - 'USER': 'cltbld', 12:37:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:37:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:47 INFO - 'XPC_FLAGS': '0x0', 12:37:47 INFO - 'XPC_SERVICE_NAME': '0', 12:37:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:37:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0172', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:37:47 INFO - mozversion application_buildid: 20160505103549 12:37:47 INFO - mozversion application_changeset: d053b705b3695004dfd4f0103de8a148b0ded450 12:37:47 INFO - mozversion application_display_name: Firefox 12:37:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:37:47 INFO - mozversion application_name: Firefox 12:37:47 INFO - mozversion application_remotingname: firefox 12:37:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:37:47 INFO - mozversion application_vendor: Mozilla 12:37:47 INFO - mozversion application_version: 47.0 12:37:47 INFO - mozversion platform_buildid: 20160505103549 12:37:47 INFO - mozversion platform_changeset: d053b705b3695004dfd4f0103de8a148b0ded450 12:37:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:37:47 INFO - mozversion platform_version: 47.0 12:37:47 INFO - using testdate: 1462477067 12:37:47 INFO - actual date: 1462477067 12:37:47 INFO - starting webserver on 'localhost:49269' 12:37:47 INFO - SUITE-START | Running 2 tests 12:37:47 INFO - TEST-START | dromaeo_css 12:37:47 INFO - operating with platform_type : mac_ 12:37:47 INFO - Initialising browser for dromaeo_css test... 12:37:47 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmp4nKXwg/profile http://localhost:49269/getInfo.html) 12:37:50 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 12:37:50 INFO - PROCESS | 1661 | colorDepth:24 12:37:50 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 12:37:50 INFO - PROCESS | 1661 | __metrics 12:37:50 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 12:37:51 INFO - TEST-INFO | 1661: exit 0 12:37:51 INFO - Browser initialized. 12:37:51 INFO - Running cycle 1/1 for dromaeo_css test... 12:37:51 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmp4nKXwg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:38:03 INFO - PROCESS | 1665 | RSS: Main: 167731200 12:38:03 INFO - PROCESS | 1665 | 12:38:53 INFO - PROCESS | 1665 | 1462477133078 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] 12:41:03 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 12:41:04 INFO - PROCESS | 1665 | RSS: Main: 179302400 12:41:04 INFO - PROCESS | 1665 | 12:44:06 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 12:44:06 INFO - PROCESS | 1665 | RSS: Main: 190431232 12:44:06 INFO - PROCESS | 1665 | 12:47:08 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 12:47:09 INFO - PROCESS | 1665 | RSS: Main: 191942656 12:47:09 INFO - PROCESS | 1665 | 12:50:10 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 12:50:11 INFO - PROCESS | 1665 | RSS: Main: 195493888 12:50:11 INFO - PROCESS | 1665 | 12:53:13 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 12:53:14 INFO - PROCESS | 1665 | RSS: Main: 194703360 12:53:14 INFO - PROCESS | 1665 | 12:56:16 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 12:56:16 INFO - PROCESS | 1665 | RSS: Main: 200327168 12:56:16 INFO - PROCESS | 1665 | 12:56:16 INFO - PROCESS | 1665 | __start_tp_report 12:56:16 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 12:56:16 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 12:56:16 INFO - PROCESS | 1665 | |i|pagename|runs| 12:56:16 INFO - PROCESS | 1665 | |0;dojo.html;3652.525171727675;3707.6848467880227;3714.238581090875;3766.07731105879;3775.339315619766;4820.734859582731;5958.4041595840445;5982.910256346147;5996.370381109986;6053.788117415891;5977.40225977402;5986.132010858434;6010.06843939189;6021.819345419644;6036.034234522477;5308.840734777963;5361.865953351178;5407.567394608422;5423.240746295522;5521.558275337963;5306.416294207634;5405.351357837065;5432.076546987002;5442.455754424565;5450;5359.062164121283;5417.918731219035;5467.890642187154;5494.120940649497;5514.531264842473;5359.062164121283;5440.564754819605;5471.917921231165;5475.534579560742;5478.808241711521;5306.920396194021;5350.30446042016;5410.5401040911565;5430.864228394283;5470.194835704208;5055.494450554952;5721.742521586539;5805.071188609802;5960.165576819249;6026.96986515069;6256.15541901842;6305.653189074599;6309.337519560426;6313.494920406357;6325.746970121189;6370.0763389308295;6377.07532407803;6382.968085159591;6389.744410223586;6455.354464553554;5163.948360516422;5970.791022314242;6080.452759251689;6108.358622344679;6130.141780150782;6455.386738259858;6482.092507049017;6499.415052645285;6523.902141467882;6539.803805885831;6217.253929528486;6300.59046161998;6313.43179113882;6313.810585682437;6337.841553961188;5777.855553611109;6063.090536419484;6267;6316.715747791361;6353.714082866282;6270.529710271748;6280.403361680633;6292.4966002719675;6325.462335701425;6337.7781777637565;6055.636661800306;6223.222097237845;6231.719572619243;6260.749570017239;6293.937060629335;4989.176785830297;5079.644424890296;5086.92369614456;5090.440051594395;5092.770825312869;4516.6160876325885;4537.75042372666;4546.227141385973;4558.088382323548;4564.520725323793;5820.970895145497;5957.374475680078;6046.183765191643;6166.136740856284;6193.876122477525;6315.652639104894;6322.146510221153;6325.05124231369;6330.873382532323;6362.9045564316575;5974.581779275409;6031.909521357183;6039.54703397247;6040.637561746309;6044.818655440344;5506.64206826555;5507.03626865297;5552.333719953551;5562.916556251659;5568.749406276727;6531.575447595891;6629.7679581214425;6633.535652504278;6639;6642.501812364092;6355.809325720235;6358.427741503102;6428.678566071584;6437.291897891322;6575.4410875076155;6385.553011289165;6498.350164983463;6570.507211959027;6575.112359831553;6604.801855944329;6277.435030847246;6322.0516922462;6335.271443784024;6344.333844946399;6357.586756860789;6352.809415717536;6376.776812811529;6385;6387.968060159669;6402.1357116790505;6182.721777519932;6202.81391558254;6277.246730392382;6281.654509002049;6282.717277722605;5621.409751975983;6248.352621135129;6257.56197066201;6282.403171698681;6291;5910.438508341701;6208.906866396917;6250.843728906813;6251.4061164189325;6273.905891411724;6199.5660303780105;6213.65824879636;6245.750169993331;6270.184875966095;6285.49716022708;6204.317525072148;6246.718897649525;6253.906191407042;6255.46828519581;6280.434760871543 12:56:16 INFO - PROCESS | 1665 | |1;ext.html;498.3571193160823;529.9692098867699;586.8679547101902;678.5013015433657;680.7855525509464;32290.99999999997;38960.831175064755;39563.40654890175;39630.801845990805;39740.205195896066;38123;40383.39424908629;40770.59229407705;40885.79557102218;40997;9624.903750962505;9826.852597211047;9827.115559599635;9838.016198380175;9876.259280553952;9646.662366817163;9773;9843.803123937518;9952.104310612043;9993;9805.31362804604;9910.256730745223;9912.107910288072;9965.651202207924;10065.245106616996;9864;9946.055124763136;9954.651587194487;9966.9501652492;9978.151857092156;9787.559559819825;9918.702438926844;9934;9940.552675129637;9992.400455972665;39790.40314395286;39939.80030099831;39959.80020099881;40020.59979400227;40231;3364.7812892161933;3397.6602339765827;3547.255076433952;3567.30437564675;3658.70730341572;28554.428911421863;29300.41399172026;29538.85230573855;29539.40921181586;29648.555271670943;2843.6587609486787;2848.9715102848913;2853.7574306184;2861.756750676195;3024.803387779787;513984;529817;532812;536732;537587;48068.03863922702;48251.552453426455;57677.42322576804;67831.32168678349;69111;46336;46541.767291164004;46578.767106164254;46609.30086048712;46661.533384665716;17241.310347585957;17423.39018134359;17450.47648570545;17525.7371139433;17548.38580649671;13593.796093058612;13802.585922422344;13831.930840345734;13895.166290022631;13910.652233694238;14852.70294594102;15238.847611523965;15303.693926121416;15306.851986101086;15462.536123916301;5330.147176451826;5469.835904922858;6625.536212465177;6665.066890635315;6673.499487538454;987.2644879564771;1046.670298855858;1071.8392241163888;1126.7802778458286;1133.960311389114;25192.37019074538;30352.54471182934;30535.54196687007;31053.534196987064;31304.373912522078;1100.8844071372391;1121.8036843552345;1189.5658084799159;1226.4174517104304;1278.6276592576394;15532.844671553366;15686.215689215494;15706.97904636195;15999.600009999844;16115.355385784438;568111;568887;571784;572377;574898;49916.25125623118;61642.69178654078;62177.68911155415;62399;63135.6843215781;1533.5782659768654;1534.6777176792775;1564.7496400575853;1566.3029951671397;1568.192380923825;25915.740842592088;29008.984685535906;30520.847395762878;30775.692243078178;31140;41929.58070419379;51805;51849.22226166686;52314.47685523248;52451;525998;538216;538986;541140;541549;34508.65491345055;35420.291594168484;35516.11209719778;35637;35698.82150589334;42391.94020149521;45102.54897450984;47099;48678;48762;39112;39298.6070139295;39457.536327477144;39670;39974.60025399825;37323.62676373201;38308.80845595754;38565;38769.224615508094;39069.02327441837;35300.64699353076;38292.61707382891;38990.4151437723;39006.4149037759;39618;25072.49855002926;31857.362852743277;31993;32038.19904502406;32079.198020049684;20884.164633414493;21022.47443813917;25070.74929250684;25123.49753004893;25276.368090797878 12:56:16 INFO - PROCESS | 1665 | |2;jquery.html;368.2892018404479;381.2527446205437;388.6599225677532;389.3206354910681;393.3863173449421;19499.70750438743;20752.96235188242;21302.786972130274;21657.133714651434;21725.45686357842;12370.690732731686;12762.808557871616;20921.163153473844;21194.25820096297;21247.57504849902;5336.38631557371;5478.808241711541;5523.171524271352;5534.086875665531;5538;4174.8121334539865;5906.704664766766;5934.762609495637;6022.397760223965;6174.259088909337;5967;5998.25021872266;6102.206713127287;6118.8470288242925;6120.938790612104;6522.543421960465;6548.836279093013;6559.147310849583;6574.243961944389;6589.406953374171;5305.832716802297;5464.7814087436855;5654.660720356792;5733.426657334275;5789;10306.845397319046;13130.737385252241;14192.006559540836;14446.277686115653;14576.708465830625;1695.4066076873119;2210.668399740036;2302.9751760466597;2507.7993760499116;2577.832440891355;7962.203779622049;10136.442495662735;10143.847842282372;10389.37663740178;10433.16534677224;1523.8552337527917;1760.0407777761152;1777.5733823882304;1829.5517598188396;1832.5143836883237;102748;106652;107566;107841;110321.34517982157;12058.939705301418;12072.094592905392;12136.817947730791;12185.207961482476;12208.572699955459;14769.63075923089;14788.260586970608;14813.555593332218;14824.258787060604;14829.258537073103;9060.456372617664;9194.862077068849;9224.953875230582;9273.072692730808;9348.252139828934;7603.353714934293;7683.231676832272;7940.007499062617;9180.311476639145;9359;4671.95328046722;4677.017826256456;4693.48371679115;4721.197396442613;4757.119932812371;1457.9284226093812;1801.5856353038612;1990.6217818614416;1995.092233033966;1999.4901300168365;915.4644532948166;981.3572110267786;984.5717113055844;1031.118393773328;1037.444966942682;19561.1197496113;20361;20438;20557.48606284825;20657.483562911046;1002.9799404012025;1029.480112543176;1037.061459379263;1039.6257347354947;1052.5105825791045;11350.508116405796;11357.488912998935;11393.601223957121;11423.914728100817;11457.59898403552;688223;691056;694413;698875;705607;88766.11233887708;110369;117461;118734.40632796781;126238;1035.5857656937135;1051.5057922776282;1054.878688950765;1062.808694435009;1122.3041714137287;18392.448226553224;18644;18891.866488010764;18976.335828245945;19211.90394048021;50426.49573504218;52651.47348526466;53303;54010;55113;61675.691621541606;67496;67728;67836.321636783;68128;8157.469764465291;8163.591820409075;8246.752597422086;8326.167383261625;8353.099205536833;9529.99935006842;12728.490860365482;12971.740565188833;13966.511172108927;13973.580792576238;11761.529538818351;11918.22531535482;12011.819822702491;12133.514659413524;12228.32744199042;5361.35663720356;8647.221750042527;11646.080665147441;11780.469878855643;11784.882151178379;5972.761089556369;7761.4178936578855;11592.88407115918;12009.39953002329;12033.939830300793;8348.415610907421;8536.103709110454;8582.570871456526;8648.56757162152;8817.426867253607;9325.487098209393;12108.818367724314;12123.090768192244;12254.38728063611;12276.81584776247 12:56:16 INFO - PROCESS | 1665 | |3;mootools.html;1692.509172340021;1699.8810083294168;1775.5206094354526;2119.3747844385894;2145.8927053647312;7047.964760176204;8501.489910605353;9359.906400935988;9514.762130946721;9554.856677149839;9194.632214711404;9210.769730756734;9267.72196834096;9270.165685088341;9279.628814847398;2250.639897616382;2606;2616.5290247755397;2632.921012369632;2634.1570697376847;2584.2764026072728;2639.0631325879326;2651.7215692352315;2651.7745991590737;2654.32314759736;2600.7269236730153;2605.596132599441;2645.563482025473;2661.5874539446418;2661.640678508396;2202.3282898715966;2636.617690434886;2644.656194694687;2647.8676066196804;2655.721149279317;2614.738526147389;2617.41108250644;2647.761701446879;2658.2158263312367;2666.2934322404576;9397.530123493798;9432.622695092188;9440.055994400505;9477.241820654332;9624.807503849954;5841.532677385799;5952.821415357546;6007.879842403127;6035.456808887177;6070.6324533432;3178.666240044785;3234.951475727866;3711.758735682172;3822.866199682998;3879.35990561557;1075.7740874416381;1101.7576133250673;1106.756513567014;1119.44027986007;1124.886362501126;12531.874681253163;12681;12738.554150604778;12739.87260127396;12852;5148.661348049534;5205.47945205484;5210.869728256824;5331.333583302087;5340.786368545215;9529.237660987104;10969.23215374916;10980.890191098146;10998.230123891251;11096.61161859331;5743.827685169452;5760.36635970043;5923.022701254245;5936.762529498858;6034.939650603438;4776;5142.588592912558;5283.365996080418;5336.893262134813;5337.279467271868;4220.662347012231;4253.340732186516;4266.957330426656;4272.508661503967;4325.437693099877;1400.1319182107159;1416.6387571169491;1416.6458385403648;1419.2832619527073;1421.644588852787;1406.3249640172774;1415.709779495201;1435.8133442652388;1458.6207586027708;1489.7541905585674;8544.914550854537;8598.699045533502;8884.200421962054;8902.86645700315;8906.332025098014;534.8047962493662;546.5217934307481;547.8712502561895;549.7855836223875;550.6338285040404;6301.4328710416285;6332.430081292614;6407;6487.156669632917;6521.380468855451;11396.601118960796;11809;11915.344656043828;11918;11949.522019119138;11263.986241238164;11361.37512436824;11735.119866010084;11793.469293881795;11814.527418903319;8985.505797181218;9005.459672419676;9023.503707296031;9115.498647574315;9126.726198214064;8409.873851892104;8461.450005749606;8706.564671766513;8758.781030474289;8799.736007919773;10096.899031009596;10164.491775411348;10167.7458063549;10262.486875656337;10331.896681033093;10318.742031448974;10483.68548943533;10636.255462117577;10747.301425407324;10775.838362424727;7226.602536860523;7641.312281894434;7812.92187078122;7965.4822436541435;8061.9596902017465;8621.224089831945;8661.783455413413;8666.610002549774;8694.521801300989;8854.822903542023;7548.1697013329585;7783.143854176149;7798.610069496389;7869.803254918673;7909.564973926259;7614.961925190339;7618.123915749759;7678.5392876427595;7772.961135194288;7776.572288524186;8192;8254.504729716236;8258.587070646323;8260.710875119343;8274.503529788231;6328.367163283819;7291.30732580404;7416.147143078615;7438.814029649302;7469.290417410337;7534.510256833289;7537.660805263886;7606;7629.2370762923265;7660.195679453577 12:56:16 INFO - PROCESS | 1665 | |4;prototype.html;302.2805722380734;335.20221871944784;344.63985135533363;348.75412833952066;349.1620111731844;6776.42400395967;6779.72881084756;6814.4548436125115;6826.249112597617;6877.793666190009;6776.457883369331;6801.829954251146;6826.112605361309;6835.418989385908;6839.384455399026;4813.951860481386;4925.581325587312;5034.320366750497;5045.091883460976;5097.974510127444;4970.453250142481;5001.649884508086;5019.171836646949;5034.874128146807;5054.747262636872;4954.653174277802;4959.900801983958;4969.353983982077;4983.078130545842;4992.800287988494;4953.777080031407;4963.900721985576;4992.750362481861;5024.43753685623;5037.798488060474;4341.848035318781;4356.89107772305;4358.912821743579;4373.147236288925;4375.409319741826;6165.075238714184;6526.608403495758;6578.5395022347975;6593.9120045192485;6604.075429439882;4785.521447855222;5808.535317174616;5830;5906.173135760997;5913.408659134096;7297.087864016998;7311.1592166900955;7312.37844783194;7312.96343518279;7326.706931722725;4725.5510726480925;4735.763211839394;4737;4748.050389922029;4749.762511874393;7419.591922444263;7650.579218143;7693.346065584432;7731.961340193319;7732.884006739903;4643.535646435329;4695.131400690883;4785.736784476887;4811.4707382187935;4852.102361063144;4915.65590408668;4918.409790825124;4932.926006109911;4933;4936.777844996984;4799.3041009053495;5874.882502349929;5885.6468611882565;5901.203337549462;5912.615679980873;7328.267173282736;7328.303811137934;7350.044494215717;7369.336759691653;7372.520786148991;1657.693326734558;1679.638877641313;1704.5397742609425;1706.6671998960085;1720.3892618120387;890.7684002159356;1067.295584913953;1087.3910610058392;1088.357868857378;1090.231386872253;5566.916496252559;5613.438656134354;5994.970025149846;6573.769918052941;6936.028955946172;6582.605043697297;7119.64726701925;7607.505512141693;7631.3894888408795;7640.885386719204;6030.48740857032;6402.03969404593;6902.654867256718;6917.446604271646;6928.064711264015;3908.4528166056775;3989.3018721723583;4040.252553277653;4047.473828402348;4058.3100872851687;7923.48497347682;7969.163237860057;8001.47990380635;8053.677852885936;8054.919450805417;7842.5686587237105;7849.882251766228;7865.370770338359;7867.921320786719;7869.331106855867;7950.363970882316;7953;7961.880571791427;7991.160928102466;8009.8398032040195;7309.780706578811;7586.506877052974;7608.391328693802;7610.1628820828555;7664;6872.522407682372;7383.630818459163;7450.254974502724;7451.813704657427;7496.863393932703;6433.935660643521;7946.721864734938;7948.562829044226;7950.324222440926;7953.801154971172;4839.516048395132;4840.7337596432535;4854.2233242681;4855.34452848875;4858.174110401311;7267.600281984542;7535.171131175676;7536.8492630148185;7553.697852086075;7560.546367217985;7256.346928776436;7294.197638259893;7298.817529561591;7322.816929576803;7357.77926662201;6324.572799040782;6897.965510172417;7275.471396372649;7299.927000729925;7302.488825782144;6954.826129346807;7124.073870396815;7150.821229469305;7252.129744430702;7319.74380896666;7266.636668166676;7270.272972702687;7311.634418279171;7315.341619254293;7348.044754182136;5770.798022069207;7002.719891204499;7143.2499587544635;7150.64246787669;7164.749233776793 12:56:16 INFO - PROCESS | 1665 | |5;yui.html;692.4806395203598;707.2573797512614;781.9022622172229;809.3565615335807;820.1962077164379;15691;15935.920320398382;15967.201639918016;16003.679926401479;16069.116198609072;13293.202407855535;13323.933380333085;13325.400356983935;13338;13351.866481335184;797.214743477674;982.0915653020962;982.9410235385864;991.7024892532247;1025.0620682075892;998.2812375089924;1003.7992401519689;1014.614446510325;1016.8169729448696;1017.231989847664;1049.108257980718;1050.0077426831647;1050.2595670052594;1051.7002654243543;1053.2258789789498;1019.7654539455966;1029.0738335498036;1035.502958579882;1043.906048455635;1043.979120417595;771.5255118102383;783.5337973905517;783.8628240057967;785.2696991797626;790.7034861926777;11983.760324793542;14496.492622758153;14556.199409032499;14681.412743490248;14684.853151468455;13458.596242112751;13523;13533.729325413437;13569.389377478037;13669.794953075712;10394.064534191883;10420.79158416835;10501.21240906935;10540.472976351151;10773.515191816387;3616.4032934565766;3619.438986957026;3652.9086772830624;3667.21154951684;3891.9610803891883;82833.58583207105;82978.9999999994;83122;83198.16801831964;83453;9766.46284454362;9850.21198304134;9862.211023118134;10022.298439109192;10059.69820905374;23154.073837046668;23818.285451436484;24009.639855402183;24012.759872401402;24045.27864164078;6518.413342799171;7618.69525218985;7620.161782203953;7747.690092396241;7777.883331749915;4107.979460102681;4151;4166.375043743463;4179.059711564934;4196;3682.705383569308;3695.131644063643;3734.3838266685693;3735.6451137141926;3765.021094515446;654.7937399719074;671.8219671786981;673.461231015186;673.8847207870981;675.8377989282537;577.9017567013618;588.4115884115885;593.4273426143792;606.1150719948924;616.0881894795638;6927.134341862649;6949.861002779916;7334.816629584303;8523.95738021306;8530.232279094911;596.6897213448982;596.6956852005509;608.8812681527148;617.8949578571653;628.5066223015003;3940.645341919241;3968;4052.9392059119136;4056.1684854604737;4116.9794151029055;96336;97976.51011744895;100372.71301098114;100634;100768.49615751875;86953.56523217344;87445.56277218701;87676.5616171915;87804.1219587796;87818;56387;74158.62920685361;74568.62715686495;74629;75204;7641.503302285334;7892.881606776018;7956.283934445696;8169.591520424074;8515.48907065578;47688;49283.52149435523;50083;50458.49541504685;50884.49115508798;64033.679831600544;66663.66668166628;67652.661736691;68145.63708725898;68615;10214.32602929925;10429;10452.843207352047;10722.463876805972;10852.728681783019;11890.464929078385;12021.278723276631;12176.391180440765;12374.071944604011;12791.232526048467;11470.39729618554;11480.82778758336;11534.307941523535;11795.823062653895;11918.165728398928;11208.327500350006;11363.204575679623;11420.71448213768;11562.132840036862;12266.75466490683;11169.38568378747;11288.435578220891;11350.829737553779;11614.825777613174;11934.462949167135;7662.73180438682;8579.613917373608;9719.514024298898;10105.747356316151;10119.241056920613;9796.476080617294;9932.900670993487;9951.502424878583;10060.84908726355;10187.28688991793 12:56:16 INFO - PROCESS | 1665 | __end_tp_report 12:56:16 INFO - PROCESS | 1665 | __start_cc_report 12:56:16 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,355 12:56:16 INFO - PROCESS | 1665 | __end_cc_report 12:56:16 INFO - PROCESS | 1665 | __startTimestamp1462478176555__endTimestamp 12:56:16 INFO - PROCESS | 1665 | 12:56:16 INFO - PROCESS | 1665 | ------- Summary: start ------- 12:56:16 INFO - PROCESS | 1665 | Number of tests: 6 12:56:16 INFO - PROCESS | 1665 | 12:56:16 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5916.54 Median:6202.81 stddev:625.97 (10.1%) stddev-sans-first:602.17 12:56:16 INFO - PROCESS | 1665 | Values: 3652.5 3707.7 3714.2 3766.1 3775.3 4820.7 5958.4 5982.9 5996.4 6053.8 5977.4 5986.1 6010.1 6021.8 6036.0 5308.8 5361.9 5407.6 5423.2 5521.6 5306.4 5405.4 5432.1 5442.5 5450.0 5359.1 5417.9 5467.9 5494.1 5514.5 5359.1 5440.6 5471.9 5475.5 5478.8 5306.9 5350.3 5410.5 5430.9 5470.2 5055.5 5721.7 5805.1 5960.2 6027.0 6256.2 6305.7 6309.3 6313.5 6325.7 6370.1 6377.1 6383.0 6389.7 6455.4 5163.9 5970.8 6080.5 6108.4 6130.1 6455.4 6482.1 6499.4 6523.9 6539.8 6217.3 6300.6 6313.4 6313.8 6337.8 5777.9 6063.1 6267.0 6316.7 6353.7 6270.5 6280.4 6292.5 6325.5 6337.8 6055.6 6223.2 6231.7 6260.7 6293.9 4989.2 5079.6 5086.9 5090.4 5092.8 4516.6 4537.8 4546.2 4558.1 4564.5 5821.0 5957.4 6046.2 6166.1 6193.9 6315.7 6322.1 6325.1 6330.9 6362.9 5974.6 6031.9 6039.5 6040.6 6044.8 5506.6 5507.0 5552.3 5562.9 5568.7 6531.6 6629.8 6633.5 6639.0 6642.5 6355.8 6358.4 6428.7 6437.3 6575.4 6385.6 6498.4 6570.5 6575.1 6604.8 6277.4 6322.1 6335.3 6344.3 6357.6 6352.8 6376.8 6385.0 6388.0 6402.1 6182.7 6202.8 6277.2 6281.7 6282.7 5621.4 6248.4 6257.6 6282.4 6291.0 5910.4 6208.9 6250.8 6251.4 6273.9 6199.6 6213.7 6245.8 6270.2 6285.5 6204.3 6246.7 6253.9 6255.5 6280.4 12:56:16 INFO - PROCESS | 1665 | 12:56:16 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:67795.30 Median:39590.70 stddev:145758.24 (368.2%) stddev-sans-first:146079.55 12:56:16 INFO - PROCESS | 1665 | Values: 498.4 530.0 586.9 678.5 680.8 32291.0 38960.8 39563.4 39630.8 39740.2 38123.0 40383.4 40770.6 40885.8 40997.0 9624.9 9826.9 9827.1 9838.0 9876.3 9646.7 9773.0 9843.8 9952.1 9993.0 9805.3 9910.3 9912.1 9965.7 10065.2 9864.0 9946.1 9954.7 9967.0 9978.2 9787.6 9918.7 9934.0 9940.6 9992.4 39790.4 39939.8 39959.8 40020.6 40231.0 3364.8 3397.7 3547.3 3567.3 3658.7 28554.4 29300.4 29538.9 29539.4 29648.6 2843.7 2849.0 2853.8 2861.8 3024.8 513984.0 529817.0 532812.0 536732.0 537587.0 48068.0 48251.6 57677.4 67831.3 69111.0 46336.0 46541.8 46578.8 46609.3 46661.5 17241.3 17423.4 17450.5 17525.7 17548.4 13593.8 13802.6 13831.9 13895.2 13910.7 14852.7 15238.8 15303.7 15306.9 15462.5 5330.1 5469.8 6625.5 6665.1 6673.5 987.3 1046.7 1071.8 1126.8 1134.0 25192.4 30352.5 30535.5 31053.5 31304.4 1100.9 1121.8 1189.6 1226.4 1278.6 15532.8 15686.2 15707.0 15999.6 16115.4 568111.0 568887.0 571784.0 572377.0 574898.0 49916.3 61642.7 62177.7 62399.0 63135.7 1533.6 1534.7 1564.7 1566.3 1568.2 25915.7 29009.0 30520.8 30775.7 31140.0 41929.6 51805.0 51849.2 52314.5 52451.0 525998.0 538216.0 538986.0 541140.0 541549.0 34508.7 35420.3 35516.1 35637.0 35698.8 42391.9 45102.5 47099.0 48678.0 48762.0 39112.0 39298.6 39457.5 39670.0 39974.6 37323.6 38308.8 38565.0 38769.2 39069.0 35300.6 38292.6 38990.4 39006.4 39618.0 25072.5 31857.4 31993.0 32038.2 32079.2 20884.2 21022.5 25070.7 25123.5 25276.4 12:56:16 INFO - PROCESS | 1665 | 12:56:16 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:36325.10 Median:21220.92 stddev:114751.69 (540.7%) stddev-sans-first:115041.84 12:56:16 INFO - PROCESS | 1665 | Values: 368.3 381.3 388.7 389.3 393.4 19499.7 20753.0 21302.8 21657.1 21725.5 12370.7 12762.8 20921.2 21194.3 21247.6 5336.4 5478.8 5523.2 5534.1 5538.0 4174.8 5906.7 5934.8 6022.4 6174.3 5967.0 5998.3 6102.2 6118.8 6120.9 6522.5 6548.8 6559.1 6574.2 6589.4 5305.8 5464.8 5654.7 5733.4 5789.0 10306.8 13130.7 14192.0 14446.3 14576.7 1695.4 2210.7 2303.0 2507.8 2577.8 7962.2 10136.4 10143.8 10389.4 10433.2 1523.9 1760.0 1777.6 1829.6 1832.5 102748.0 106652.0 107566.0 107841.0 110321.3 12058.9 12072.1 12136.8 12185.2 12208.6 14769.6 14788.3 14813.6 14824.3 14829.3 9060.5 9194.9 9225.0 9273.1 9348.3 7603.4 7683.2 7940.0 9180.3 9359.0 4672.0 4677.0 4693.5 4721.2 4757.1 1457.9 1801.6 1990.6 1995.1 1999.5 915.5 981.4 984.6 1031.1 1037.4 19561.1 20361.0 20438.0 20557.5 20657.5 1003.0 1029.5 1037.1 1039.6 1052.5 11350.5 11357.5 11393.6 11423.9 11457.6 688223.0 691056.0 694413.0 698875.0 705607.0 88766.1 110369.0 117461.0 118734.4 126238.0 1035.6 1051.5 1054.9 1062.8 1122.3 18392.4 18644.0 18891.9 18976.3 19211.9 50426.5 52651.5 53303.0 54010.0 55113.0 61675.7 67496.0 67728.0 67836.3 68128.0 8157.5 8163.6 8246.8 8326.2 8353.1 9530.0 12728.5 12971.7 13966.5 13973.6 11761.5 11918.2 12011.8 12133.5 12228.3 5361.4 8647.2 11646.1 11780.5 11784.9 5972.8 7761.4 11592.9 12009.4 12033.9 8348.4 8536.1 8582.6 8648.6 8817.4 9325.5 12108.8 12123.1 12254.4 12276.8 12:56:16 INFO - PROCESS | 1665 | 12:56:16 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:6457.17 Median:5334.11 stddev:3447.74 (64.6%) stddev-sans-first:3438.81 12:56:16 INFO - PROCESS | 1665 | Values: 1692.5 1699.9 1775.5 2119.4 2145.9 7048.0 8501.5 9359.9 9514.8 9554.9 9194.6 9210.8 9267.7 9270.2 9279.6 2250.6 2606.0 2616.5 2632.9 2634.2 2584.3 2639.1 2651.7 2651.8 2654.3 2600.7 2605.6 2645.6 2661.6 2661.6 2202.3 2636.6 2644.7 2647.9 2655.7 2614.7 2617.4 2647.8 2658.2 2666.3 9397.5 9432.6 9440.1 9477.2 9624.8 5841.5 5952.8 6007.9 6035.5 6070.6 3178.7 3235.0 3711.8 3822.9 3879.4 1075.8 1101.8 1106.8 1119.4 1124.9 12531.9 12681.0 12738.6 12739.9 12852.0 5148.7 5205.5 5210.9 5331.3 5340.8 9529.2 10969.2 10980.9 10998.2 11096.6 5743.8 5760.4 5923.0 5936.8 6034.9 4776.0 5142.6 5283.4 5336.9 5337.3 4220.7 4253.3 4267.0 4272.5 4325.4 1400.1 1416.6 1416.6 1419.3 1421.6 1406.3 1415.7 1435.8 1458.6 1489.8 8544.9 8598.7 8884.2 8902.9 8906.3 534.8 546.5 547.9 549.8 550.6 6301.4 6332.4 6407.0 6487.2 6521.4 11396.6 11809.0 11915.3 11918.0 11949.5 11264.0 11361.4 11735.1 11793.5 11814.5 8985.5 9005.5 9023.5 9115.5 9126.7 8409.9 8461.5 8706.6 8758.8 8799.7 10096.9 10164.5 10167.7 10262.5 10331.9 10318.7 10483.7 10636.3 10747.3 10775.8 7226.6 7641.3 7812.9 7965.5 8062.0 8621.2 8661.8 8666.6 8694.5 8854.8 7548.2 7783.1 7798.6 7869.8 7909.6 7615.0 7618.1 7678.5 7773.0 7776.6 8192.0 8254.5 8258.6 8260.7 8274.5 6328.4 7291.3 7416.1 7438.8 7469.3 7534.5 7537.7 7606.0 7629.2 7660.2 12:56:16 INFO - PROCESS | 1665 | 12:56:16 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:5945.04 Median:6778.09 stddev:1909.58 (28.2%) stddev-sans-first:1867.37 12:56:16 INFO - PROCESS | 1665 | Values: 302.3 335.2 344.6 348.8 349.2 6776.4 6779.7 6814.5 6826.2 6877.8 6776.5 6801.8 6826.1 6835.4 6839.4 4814.0 4925.6 5034.3 5045.1 5098.0 4970.5 5001.6 5019.2 5034.9 5054.7 4954.7 4959.9 4969.4 4983.1 4992.8 4953.8 4963.9 4992.8 5024.4 5037.8 4341.8 4356.9 4358.9 4373.1 4375.4 6165.1 6526.6 6578.5 6593.9 6604.1 4785.5 5808.5 5830.0 5906.2 5913.4 7297.1 7311.2 7312.4 7313.0 7326.7 4725.6 4735.8 4737.0 4748.1 4749.8 7419.6 7650.6 7693.3 7732.0 7732.9 4643.5 4695.1 4785.7 4811.5 4852.1 4915.7 4918.4 4932.9 4933.0 4936.8 4799.3 5874.9 5885.6 5901.2 5912.6 7328.3 7328.3 7350.0 7369.3 7372.5 1657.7 1679.6 1704.5 1706.7 1720.4 890.8 1067.3 1087.4 1088.4 1090.2 5566.9 5613.4 5995.0 6573.8 6936.0 6582.6 7119.6 7607.5 7631.4 7640.9 6030.5 6402.0 6902.7 6917.4 6928.1 3908.5 3989.3 4040.3 4047.5 4058.3 7923.5 7969.2 8001.5 8053.7 8054.9 7842.6 7849.9 7865.4 7867.9 7869.3 7950.4 7953.0 7961.9 7991.2 8009.8 7309.8 7586.5 7608.4 7610.2 7664.0 6872.5 7383.6 7450.3 7451.8 7496.9 6433.9 7946.7 7948.6 7950.3 7953.8 4839.5 4840.7 4854.2 4855.3 4858.2 7267.6 7535.2 7536.8 7553.7 7560.5 7256.3 7294.2 7298.8 7322.8 7357.8 6324.6 6898.0 7275.5 7299.9 7302.5 6954.8 7124.1 7150.8 7252.1 7319.7 7266.6 7270.3 7311.6 7315.3 7348.0 5770.8 7002.7 7143.2 7150.6 7164.7 12:56:16 INFO - PROCESS | 1665 | 12:56:16 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:18933.43 Median:4010.47 stddev:27081.82 (675.3%) stddev-sans-first:27123.16 12:56:16 INFO - PROCESS | 1665 | Values: 692.5 707.3 781.9 809.4 820.2 15691.0 15935.9 15967.2 16003.7 16069.1 13293.2 13323.9 13325.4 13338.0 13351.9 797.2 982.1 982.9 991.7 1025.1 998.3 1003.8 1014.6 1016.8 1017.2 1049.1 1050.0 1050.3 1051.7 1053.2 1019.8 1029.1 1035.5 1043.9 1044.0 771.5 783.5 783.9 785.3 790.7 11983.8 14496.5 14556.2 14681.4 14684.9 13458.6 13523.0 13533.7 13569.4 13669.8 10394.1 10420.8 10501.2 10540.5 10773.5 3616.4 3619.4 3652.9 3667.2 3892.0 82833.6 82979.0 83122.0 83198.2 83453.0 9766.5 9850.2 9862.2 10022.3 10059.7 23154.1 23818.3 24009.6 24012.8 24045.3 6518.4 7618.7 7620.2 7747.7 7777.9 4108.0 4151.0 4166.4 4179.1 4196.0 3682.7 3695.1 3734.4 3735.6 3765.0 654.8 671.8 673.5 673.9 675.8 577.9 588.4 593.4 606.1 616.1 6927.1 6949.9 7334.8 8524.0 8530.2 596.7 596.7 608.9 617.9 628.5 3940.6 3968.0 4052.9 4056.2 4117.0 96336.0 97976.5 100372.7 100634.0 100768.5 86953.6 87445.6 87676.6 87804.1 87818.0 56387.0 74158.6 74568.6 74629.0 75204.0 7641.5 7892.9 7956.3 8169.6 8515.5 47688.0 49283.5 50083.0 50458.5 50884.5 64033.7 66663.7 67652.7 68145.6 68615.0 10214.3 10429.0 10452.8 10722.5 10852.7 11890.5 12021.3 12176.4 12374.1 12791.2 11470.4 11480.8 11534.3 11795.8 11918.2 11208.3 11363.2 11420.7 11562.1 12266.8 11169.4 11288.4 11350.8 11614.8 11934.5 7662.7 8579.6 9719.5 10105.7 10119.2 9796.5 9932.9 9951.5 10060.8 10187.3 12:56:16 INFO - PROCESS | 1665 | -------- Summary: end -------- 12:56:16 INFO - PROCESS | 1665 | 12:56:17 INFO - TEST-INFO | 1665: exit 0 12:56:17 INFO - TEST-OK | dromaeo_css | took 1109124ms 12:56:17 INFO - TEST-START | kraken 12:56:17 INFO - operating with platform_type : mac_ 12:56:17 INFO - Initialising browser for kraken test... 12:56:17 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmpTDKb7L/profile http://localhost:49269/getInfo.html) 12:56:19 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 12:56:19 INFO - PROCESS | 1676 | colorDepth:24 12:56:19 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 12:56:19 INFO - PROCESS | 1676 | __metrics 12:56:19 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 12:56:20 INFO - TEST-INFO | 1676: exit 0 12:56:20 INFO - Browser initialized. 12:56:20 INFO - Running cycle 1/1 for kraken test... 12:56:20 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmpTDKb7L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:56:31 INFO - PROCESS | 1680 | RSS: Main: 167882752 12:56:31 INFO - PROCESS | 1680 | 12:56:34 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 12:56:35 INFO - PROCESS | 1680 | RSS: Main: 179707904 12:56:35 INFO - PROCESS | 1680 | 12:56:37 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 12:56:38 INFO - PROCESS | 1680 | RSS: Main: 189108224 12:56:38 INFO - PROCESS | 1680 | 12:56:41 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 12:56:42 INFO - PROCESS | 1680 | RSS: Main: 192098304 12:56:42 INFO - PROCESS | 1680 | 12:56:44 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 12:56:44 INFO - PROCESS | 1680 | RSS: Main: 193572864 12:56:44 INFO - PROCESS | 1680 | 12:56:46 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:56:47 INFO - PROCESS | 1680 | RSS: Main: 193863680 12:56:47 INFO - PROCESS | 1680 | 12:56:50 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 12:56:50 INFO - PROCESS | 1680 | RSS: Main: 194674688 12:56:50 INFO - PROCESS | 1680 | 12:56:53 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 12:56:54 INFO - PROCESS | 1680 | RSS: Main: 194674688 12:56:54 INFO - PROCESS | 1680 | 12:56:57 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 12:56:57 INFO - PROCESS | 1680 | RSS: Main: 194965504 12:56:57 INFO - PROCESS | 1680 | 12:56:59 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:56:59 INFO - PROCESS | 1680 | RSS: Main: 194187264 12:56:59 INFO - PROCESS | 1680 | 12:57:01 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:57:02 INFO - PROCESS | 1680 | RSS: Main: 194240512 12:57:02 INFO - PROCESS | 1680 | 12:57:04 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:57:04 INFO - PROCESS | 1680 | RSS: Main: 194179072 12:57:04 INFO - PROCESS | 1680 | 12:57:07 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:57:08 INFO - PROCESS | 1680 | RSS: Main: 194248704 12:57:08 INFO - PROCESS | 1680 | 12:57:10 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:57:11 INFO - PROCESS | 1680 | RSS: Main: 194314240 12:57:11 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 12:57:13 INFO - PROCESS | 1680 | RSS: Main: 196079616 12:57:13 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | __start_tp_report 12:57:13 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 12:57:13 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 12:57:13 INFO - PROCESS | 1680 | |i|pagename|runs| 12:57:13 INFO - PROCESS | 1680 | |0;ai-astar;113;107;114;116;113;132;115;114;112;114 12:57:13 INFO - PROCESS | 1680 | |1;audio-beat-detection;154;134;152;155;152;169;129;159;143;148 12:57:13 INFO - PROCESS | 1680 | |2;audio-dft;192;218;190;195;193;237;193;190;209;247 12:57:13 INFO - PROCESS | 1680 | |3;audio-fft;73;68;72;116;72;74;56;60;128;56 12:57:13 INFO - PROCESS | 1680 | |4;audio-oscillator;86;84;120;78;81;80;117;78;78;118 12:57:13 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;134;89;135;130;87;104;119;85;93;86 12:57:13 INFO - PROCESS | 1680 | |6;imaging-darkroom;95;95;95;94;95;95;94;94;95;93 12:57:13 INFO - PROCESS | 1680 | |7;imaging-desaturate;92;94;92;90;92;92;92;92;91;95 12:57:13 INFO - PROCESS | 1680 | |8;json-parse-financial;56;58;59;61;81;94;89;101;45;42 12:57:13 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;65;64;68;64;78;66;67;65;66;67 12:57:13 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;84;81;83;72;90;106;81;83;86;86 12:57:13 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;116;142;135;125;124;136;135;129;126;129 12:57:13 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;136;132;135;133;136;149;180;176;166;132 12:57:13 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;67;68;65;63;67;92;99;100;94;93 12:57:13 INFO - PROCESS | 1680 | __end_tp_report 12:57:13 INFO - PROCESS | 1680 | __start_cc_report 12:57:13 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,892 12:57:13 INFO - PROCESS | 1680 | __end_cc_report 12:57:13 INFO - PROCESS | 1680 | __startTimestamp1462478233341__endTimestamp 12:57:13 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | ------- Summary: start ------- 12:57:13 INFO - PROCESS | 1680 | Number of tests: 14 12:57:13 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:115.00 Median:114.00 stddev:6.45 (5.7%) stddev-sans-first:6.80 12:57:13 INFO - PROCESS | 1680 | Values: 113.0 107.0 114.0 116.0 113.0 132.0 115.0 114.0 112.0 114.0 12:57:13 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:153.00 stddev:11.73 (7.7%) stddev-sans-first:12.33 12:57:13 INFO - PROCESS | 1680 | Values: 154.0 134.0 152.0 155.0 152.0 169.0 129.0 159.0 143.0 148.0 12:57:13 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:206.40 Median:202.00 stddev:20.98 (10.4%) stddev-sans-first:21.59 12:57:13 INFO - PROCESS | 1680 | Values: 192.0 218.0 190.0 195.0 193.0 237.0 193.0 190.0 209.0 247.0 12:57:13 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:77.50 Median:70.00 stddev:24.60 (35.1%) stddev-sans-first:26.04 12:57:13 INFO - PROCESS | 1680 | Values: 73.0 68.0 72.0 116.0 72.0 74.0 56.0 60.0 128.0 56.0 12:57:13 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:79.00 stddev:18.37 (23.3%) stddev-sans-first:19.36 12:57:13 INFO - PROCESS | 1680 | Values: 86.0 84.0 120.0 78.0 81.0 80.0 117.0 78.0 78.0 118.0 12:57:13 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:106.20 Median:85.50 stddev:21.17 (24.8%) stddev-sans-first:19.92 12:57:13 INFO - PROCESS | 1680 | Values: 134.0 89.0 135.0 130.0 87.0 104.0 119.0 85.0 93.0 86.0 12:57:13 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:95.00 stddev:0.71 (0.7%) stddev-sans-first:0.73 12:57:13 INFO - PROCESS | 1680 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 93.0 12:57:13 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:92.20 Median:92.00 stddev:1.40 (1.5%) stddev-sans-first:1.48 12:57:13 INFO - PROCESS | 1680 | Values: 92.0 94.0 92.0 90.0 92.0 92.0 92.0 92.0 91.0 95.0 12:57:13 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:68.60 Median:60.00 stddev:20.95 (34.9%) stddev-sans-first:21.72 12:57:13 INFO - PROCESS | 1680 | Values: 56.0 58.0 59.0 61.0 81.0 94.0 89.0 101.0 45.0 42.0 12:57:13 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:66.50 stddev:4.08 (6.1%) stddev-sans-first:4.27 12:57:13 INFO - PROCESS | 1680 | Values: 65.0 64.0 68.0 64.0 78.0 66.0 67.0 65.0 66.0 67.0 12:57:13 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:83.50 stddev:8.68 (10.4%) stddev-sans-first:9.19 12:57:13 INFO - PROCESS | 1680 | Values: 84.0 81.0 83.0 72.0 90.0 106.0 81.0 83.0 86.0 86.0 12:57:13 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:132.00 stddev:7.48 (5.7%) stddev-sans-first:6.08 12:57:13 INFO - PROCESS | 1680 | Values: 116.0 142.0 135.0 125.0 124.0 136.0 135.0 129.0 126.0 129.0 12:57:13 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:142.50 stddev:19.22 (13.5%) stddev-sans-first:19.93 12:57:13 INFO - PROCESS | 1680 | Values: 136.0 132.0 135.0 133.0 136.0 149.0 180.0 176.0 166.0 132.0 12:57:13 INFO - PROCESS | 1680 | 12:57:13 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.80 Median:80.00 stddev:15.85 (19.8%) stddev-sans-first:16.00 12:57:13 INFO - PROCESS | 1680 | Values: 67.0 68.0 65.0 63.0 67.0 92.0 99.0 100.0 94.0 93.0 12:57:13 INFO - PROCESS | 1680 | -------- Summary: end -------- 12:57:13 INFO - PROCESS | 1680 | 12:57:14 INFO - TEST-INFO | 1680: exit 0 12:57:14 INFO - TEST-OK | kraken | took 56993ms 12:57:14 INFO - SUITE-END | took 1166s 12:57:14 INFO - Completed test suite (00:19:26) 12:57:14 INFO - javascript benchmark 12:57:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3652.525171727675, 3707.6848467880227, 3714.238581090875, 3766.07731105879, 3775.339315619766, 4820.734859582731, 5958.4041595840445, 5982.910256346147, 5996.370381109986, 6053.788117415891, 5977.40225977402, 5986.132010858434, 6010.06843939189, 6021.819345419644, 6036.034234522477, 5308.840734777963, 5361.865953351178, 5407.567394608422, 5423.240746295522, 5521.558275337963, 5306.416294207634, 5405.351357837065, 5432.076546987002, 5442.455754424565, 5450.0, 5359.062164121283, 5417.918731219035, 5467.890642187154, 5494.120940649497, 5514.531264842473, 5359.062164121283, 5440.564754819605, 5471.917921231165, 5475.534579560742, 5478.808241711521, 5306.920396194021, 5350.30446042016, 5410.5401040911565, 5430.864228394283, 5470.194835704208, 5055.494450554952, 5721.742521586539, 5805.071188609802, 5960.165576819249, 6026.96986515069, 6256.15541901842, 6305.653189074599, 6309.337519560426, 6313.494920406357, 6325.746970121189, 6370.0763389308295, 6377.07532407803, 6382.968085159591, 6389.744410223586, 6455.354464553554, 5163.948360516422, 5970.791022314242, 6080.452759251689, 6108.358622344679, 6130.141780150782, 6455.386738259858, 6482.092507049017, 6499.415052645285, 6523.902141467882, 6539.803805885831, 6217.253929528486, 6300.59046161998, 6313.43179113882, 6313.810585682437, 6337.841553961188, 5777.855553611109, 6063.090536419484, 6267.0, 6316.715747791361, 6353.714082866282, 6270.529710271748, 6280.403361680633, 6292.4966002719675, 6325.462335701425, 6337.7781777637565, 6055.636661800306, 6223.222097237845, 6231.719572619243, 6260.749570017239, 6293.937060629335, 4989.176785830297, 5079.644424890296, 5086.92369614456, 5090.440051594395, 5092.770825312869, 4516.6160876325885, 4537.75042372666, 4546.227141385973, 4558.088382323548, 4564.520725323793, 5820.970895145497, 5957.374475680078, 6046.183765191643, 6166.136740856284, 6193.876122477525, 6315.652639104894, 6322.146510221153, 6325.05124231369, 6330.873382532323, 6362.9045564316575, 5974.581779275409, 6031.909521357183, 6039.54703397247, 6040.637561746309, 6044.818655440344, 5506.64206826555, 5507.03626865297, 5552.333719953551, 5562.916556251659, 5568.749406276727, 6531.575447595891, 6629.7679581214425, 6633.535652504278, 6639.0, 6642.501812364092, 6355.809325720235, 6358.427741503102, 6428.678566071584, 6437.291897891322, 6575.4410875076155, 6385.553011289165, 6498.350164983463, 6570.507211959027, 6575.112359831553, 6604.801855944329, 6277.435030847246, 6322.0516922462, 6335.271443784024, 6344.333844946399, 6357.586756860789, 6352.809415717536, 6376.776812811529, 6385.0, 6387.968060159669, 6402.1357116790505, 6182.721777519932, 6202.81391558254, 6277.246730392382, 6281.654509002049, 6282.717277722605, 5621.409751975983, 6248.352621135129, 6257.56197066201, 6282.403171698681, 6291.0, 5910.438508341701, 6208.906866396917, 6250.843728906813, 6251.4061164189325, 6273.905891411724, 6199.5660303780105, 6213.65824879636, 6245.750169993331, 6270.184875966095, 6285.49716022708, 6204.317525072148, 6246.718897649525, 6253.906191407042, 6255.46828519581, 6280.434760871543], "unit": "score", "name": "dojo.html", "value": 5880.354401850847}, {"lowerIsBetter": false, "replicates": [498.3571193160823, 529.9692098867699, 586.8679547101902, 678.5013015433657, 680.7855525509464, 32290.99999999997, 38960.831175064755, 39563.40654890175, 39630.801845990805, 39740.205195896066, 38123.0, 40383.39424908629, 40770.59229407705, 40885.79557102218, 40997.0, 9624.903750962505, 9826.852597211047, 9827.115559599635, 9838.016198380175, 9876.259280553952, 9646.662366817163, 9773.0, 9843.803123937518, 9952.104310612043, 9993.0, 9805.31362804604, 9910.256730745223, 9912.107910288072, 9965.651202207924, 10065.245106616996, 9864.0, 9946.055124763136, 9954.651587194487, 9966.9501652492, 9978.151857092156, 9787.559559819825, 9918.702438926844, 9934.0, 9940.552675129637, 9992.400455972665, 39790.40314395286, 39939.80030099831, 39959.80020099881, 40020.59979400227, 40231.0, 3364.7812892161933, 3397.6602339765827, 3547.255076433952, 3567.30437564675, 3658.70730341572, 28554.428911421863, 29300.41399172026, 29538.85230573855, 29539.40921181586, 29648.555271670943, 2843.6587609486787, 2848.9715102848913, 2853.7574306184, 2861.756750676195, 3024.803387779787, 513984.0, 529817.0, 532812.0, 536732.0, 537587.0, 48068.03863922702, 48251.552453426455, 57677.42322576804, 67831.32168678349, 69111.0, 46336.0, 46541.767291164004, 46578.767106164254, 46609.30086048712, 46661.533384665716, 17241.310347585957, 17423.39018134359, 17450.47648570545, 17525.7371139433, 17548.38580649671, 13593.796093058612, 13802.585922422344, 13831.930840345734, 13895.166290022631, 13910.652233694238, 14852.70294594102, 15238.847611523965, 15303.693926121416, 15306.851986101086, 15462.536123916301, 5330.147176451826, 5469.835904922858, 6625.536212465177, 6665.066890635315, 6673.499487538454, 987.2644879564771, 1046.670298855858, 1071.8392241163888, 1126.7802778458286, 1133.960311389114, 25192.37019074538, 30352.54471182934, 30535.54196687007, 31053.534196987064, 31304.373912522078, 1100.8844071372391, 1121.8036843552345, 1189.5658084799159, 1226.4174517104304, 1278.6276592576394, 15532.844671553366, 15686.215689215494, 15706.97904636195, 15999.600009999844, 16115.355385784438, 568111.0, 568887.0, 571784.0, 572377.0, 574898.0, 49916.25125623118, 61642.69178654078, 62177.68911155415, 62399.0, 63135.6843215781, 1533.5782659768654, 1534.6777176792775, 1564.7496400575853, 1566.3029951671397, 1568.192380923825, 25915.740842592088, 29008.984685535906, 30520.847395762878, 30775.692243078178, 31140.0, 41929.58070419379, 51805.0, 51849.22226166686, 52314.47685523248, 52451.0, 525998.0, 538216.0, 538986.0, 541140.0, 541549.0, 34508.65491345055, 35420.291594168484, 35516.11209719778, 35637.0, 35698.82150589334, 42391.94020149521, 45102.54897450984, 47099.0, 48678.0, 48762.0, 39112.0, 39298.6070139295, 39457.536327477144, 39670.0, 39974.60025399825, 37323.62676373201, 38308.80845595754, 38565.0, 38769.224615508094, 39069.02327441837, 35300.64699353076, 38292.61707382891, 38990.4151437723, 39006.4149037759, 39618.0, 25072.49855002926, 31857.362852743277, 31993.0, 32038.19904502406, 32079.198020049684, 20884.164633414493, 21022.47443813917, 25070.74929250684, 25123.49753004893, 25276.368090797878], "unit": "score", "name": "ext.html", "value": 19896.271025968792}, {"lowerIsBetter": false, "replicates": [368.2892018404479, 381.2527446205437, 388.6599225677532, 389.3206354910681, 393.3863173449421, 19499.70750438743, 20752.96235188242, 21302.786972130274, 21657.133714651434, 21725.45686357842, 12370.690732731686, 12762.808557871616, 20921.163153473844, 21194.25820096297, 21247.57504849902, 5336.38631557371, 5478.808241711541, 5523.171524271352, 5534.086875665531, 5538.0, 4174.8121334539865, 5906.704664766766, 5934.762609495637, 6022.397760223965, 6174.259088909337, 5967.0, 5998.25021872266, 6102.206713127287, 6118.8470288242925, 6120.938790612104, 6522.543421960465, 6548.836279093013, 6559.147310849583, 6574.243961944389, 6589.406953374171, 5305.832716802297, 5464.7814087436855, 5654.660720356792, 5733.426657334275, 5789.0, 10306.845397319046, 13130.737385252241, 14192.006559540836, 14446.277686115653, 14576.708465830625, 1695.4066076873119, 2210.668399740036, 2302.9751760466597, 2507.7993760499116, 2577.832440891355, 7962.203779622049, 10136.442495662735, 10143.847842282372, 10389.37663740178, 10433.16534677224, 1523.8552337527917, 1760.0407777761152, 1777.5733823882304, 1829.5517598188396, 1832.5143836883237, 102748.0, 106652.0, 107566.0, 107841.0, 110321.34517982157, 12058.939705301418, 12072.094592905392, 12136.817947730791, 12185.207961482476, 12208.572699955459, 14769.63075923089, 14788.260586970608, 14813.555593332218, 14824.258787060604, 14829.258537073103, 9060.456372617664, 9194.862077068849, 9224.953875230582, 9273.072692730808, 9348.252139828934, 7603.353714934293, 7683.231676832272, 7940.007499062617, 9180.311476639145, 9359.0, 4671.95328046722, 4677.017826256456, 4693.48371679115, 4721.197396442613, 4757.119932812371, 1457.9284226093812, 1801.5856353038612, 1990.6217818614416, 1995.092233033966, 1999.4901300168365, 915.4644532948166, 981.3572110267786, 984.5717113055844, 1031.118393773328, 1037.444966942682, 19561.1197496113, 20361.0, 20438.0, 20557.48606284825, 20657.483562911046, 1002.9799404012025, 1029.480112543176, 1037.061459379263, 1039.6257347354947, 1052.5105825791045, 11350.508116405796, 11357.488912998935, 11393.601223957121, 11423.914728100817, 11457.59898403552, 688223.0, 691056.0, 694413.0, 698875.0, 705607.0, 88766.11233887708, 110369.0, 117461.0, 118734.40632796781, 126238.0, 1035.5857656937135, 1051.5057922776282, 1054.878688950765, 1062.808694435009, 1122.3041714137287, 18392.448226553224, 18644.0, 18891.866488010764, 18976.335828245945, 19211.90394048021, 50426.49573504218, 52651.47348526466, 53303.0, 54010.0, 55113.0, 61675.691621541606, 67496.0, 67728.0, 67836.321636783, 68128.0, 8157.469764465291, 8163.591820409075, 8246.752597422086, 8326.167383261625, 8353.099205536833, 9529.99935006842, 12728.490860365482, 12971.740565188833, 13966.511172108927, 13973.580792576238, 11761.529538818351, 11918.22531535482, 12011.819822702491, 12133.514659413524, 12228.32744199042, 5361.35663720356, 8647.221750042527, 11646.080665147441, 11780.469878855643, 11784.882151178379, 5972.761089556369, 7761.4178936578855, 11592.88407115918, 12009.39953002329, 12033.939830300793, 8348.415610907421, 8536.103709110454, 8582.570871456526, 8648.56757162152, 8817.426867253607, 9325.487098209393, 12108.818367724314, 12123.090768192244, 12254.38728063611, 12276.81584776247], "unit": "score", "name": "jquery.html", "value": 9391.198702401047}, {"lowerIsBetter": false, "replicates": [1692.509172340021, 1699.8810083294168, 1775.5206094354526, 2119.3747844385894, 2145.8927053647312, 7047.964760176204, 8501.489910605353, 9359.906400935988, 9514.762130946721, 9554.856677149839, 9194.632214711404, 9210.769730756734, 9267.72196834096, 9270.165685088341, 9279.628814847398, 2250.639897616382, 2606.0, 2616.5290247755397, 2632.921012369632, 2634.1570697376847, 2584.2764026072728, 2639.0631325879326, 2651.7215692352315, 2651.7745991590737, 2654.32314759736, 2600.7269236730153, 2605.596132599441, 2645.563482025473, 2661.5874539446418, 2661.640678508396, 2202.3282898715966, 2636.617690434886, 2644.656194694687, 2647.8676066196804, 2655.721149279317, 2614.738526147389, 2617.41108250644, 2647.761701446879, 2658.2158263312367, 2666.2934322404576, 9397.530123493798, 9432.622695092188, 9440.055994400505, 9477.241820654332, 9624.807503849954, 5841.532677385799, 5952.821415357546, 6007.879842403127, 6035.456808887177, 6070.6324533432, 3178.666240044785, 3234.951475727866, 3711.758735682172, 3822.866199682998, 3879.35990561557, 1075.7740874416381, 1101.7576133250673, 1106.756513567014, 1119.44027986007, 1124.886362501126, 12531.874681253163, 12681.0, 12738.554150604778, 12739.87260127396, 12852.0, 5148.661348049534, 5205.47945205484, 5210.869728256824, 5331.333583302087, 5340.786368545215, 9529.237660987104, 10969.23215374916, 10980.890191098146, 10998.230123891251, 11096.61161859331, 5743.827685169452, 5760.36635970043, 5923.022701254245, 5936.762529498858, 6034.939650603438, 4776.0, 5142.588592912558, 5283.365996080418, 5336.893262134813, 5337.279467271868, 4220.662347012231, 4253.340732186516, 4266.957330426656, 4272.508661503967, 4325.437693099877, 1400.1319182107159, 1416.6387571169491, 1416.6458385403648, 1419.2832619527073, 1421.644588852787, 1406.3249640172774, 1415.709779495201, 1435.8133442652388, 1458.6207586027708, 1489.7541905585674, 8544.914550854537, 8598.699045533502, 8884.200421962054, 8902.86645700315, 8906.332025098014, 534.8047962493662, 546.5217934307481, 547.8712502561895, 549.7855836223875, 550.6338285040404, 6301.4328710416285, 6332.430081292614, 6407.0, 6487.156669632917, 6521.380468855451, 11396.601118960796, 11809.0, 11915.344656043828, 11918.0, 11949.522019119138, 11263.986241238164, 11361.37512436824, 11735.119866010084, 11793.469293881795, 11814.527418903319, 8985.505797181218, 9005.459672419676, 9023.503707296031, 9115.498647574315, 9126.726198214064, 8409.873851892104, 8461.450005749606, 8706.564671766513, 8758.781030474289, 8799.736007919773, 10096.899031009596, 10164.491775411348, 10167.7458063549, 10262.486875656337, 10331.896681033093, 10318.742031448974, 10483.68548943533, 10636.255462117577, 10747.301425407324, 10775.838362424727, 7226.602536860523, 7641.312281894434, 7812.92187078122, 7965.4822436541435, 8061.9596902017465, 8621.224089831945, 8661.783455413413, 8666.610002549774, 8694.521801300989, 8854.822903542023, 7548.1697013329585, 7783.143854176149, 7798.610069496389, 7869.803254918673, 7909.564973926259, 7614.961925190339, 7618.123915749759, 7678.5392876427595, 7772.961135194288, 7776.572288524186, 8192.0, 8254.504729716236, 8258.587070646323, 8260.710875119343, 8274.503529788231, 6328.367163283819, 7291.30732580404, 7416.147143078615, 7438.814029649302, 7469.290417410337, 7534.510256833289, 7537.660805263886, 7606.0, 7629.2370762923265, 7660.195679453577], "unit": "score", "name": "mootools.html", "value": 5174.426306899196}, {"lowerIsBetter": false, "replicates": [302.2805722380734, 335.20221871944784, 344.63985135533363, 348.75412833952066, 349.1620111731844, 6776.42400395967, 6779.72881084756, 6814.4548436125115, 6826.249112597617, 6877.793666190009, 6776.457883369331, 6801.829954251146, 6826.112605361309, 6835.418989385908, 6839.384455399026, 4813.951860481386, 4925.581325587312, 5034.320366750497, 5045.091883460976, 5097.974510127444, 4970.453250142481, 5001.649884508086, 5019.171836646949, 5034.874128146807, 5054.747262636872, 4954.653174277802, 4959.900801983958, 4969.353983982077, 4983.078130545842, 4992.800287988494, 4953.777080031407, 4963.900721985576, 4992.750362481861, 5024.43753685623, 5037.798488060474, 4341.848035318781, 4356.89107772305, 4358.912821743579, 4373.147236288925, 4375.409319741826, 6165.075238714184, 6526.608403495758, 6578.5395022347975, 6593.9120045192485, 6604.075429439882, 4785.521447855222, 5808.535317174616, 5830.0, 5906.173135760997, 5913.408659134096, 7297.087864016998, 7311.1592166900955, 7312.37844783194, 7312.96343518279, 7326.706931722725, 4725.5510726480925, 4735.763211839394, 4737.0, 4748.050389922029, 4749.762511874393, 7419.591922444263, 7650.579218143, 7693.346065584432, 7731.961340193319, 7732.884006739903, 4643.535646435329, 4695.131400690883, 4785.736784476887, 4811.4707382187935, 4852.102361063144, 4915.65590408668, 4918.409790825124, 4932.926006109911, 4933.0, 4936.777844996984, 4799.3041009053495, 5874.882502349929, 5885.6468611882565, 5901.203337549462, 5912.615679980873, 7328.267173282736, 7328.303811137934, 7350.044494215717, 7369.336759691653, 7372.520786148991, 1657.693326734558, 1679.638877641313, 1704.5397742609425, 1706.6671998960085, 1720.3892618120387, 890.7684002159356, 1067.295584913953, 1087.3910610058392, 1088.357868857378, 1090.231386872253, 5566.916496252559, 5613.438656134354, 5994.970025149846, 6573.769918052941, 6936.028955946172, 6582.605043697297, 7119.64726701925, 7607.505512141693, 7631.3894888408795, 7640.885386719204, 6030.48740857032, 6402.03969404593, 6902.654867256718, 6917.446604271646, 6928.064711264015, 3908.4528166056775, 3989.3018721723583, 4040.252553277653, 4047.473828402348, 4058.3100872851687, 7923.48497347682, 7969.163237860057, 8001.47990380635, 8053.677852885936, 8054.919450805417, 7842.5686587237105, 7849.882251766228, 7865.370770338359, 7867.921320786719, 7869.331106855867, 7950.363970882316, 7953.0, 7961.880571791427, 7991.160928102466, 8009.8398032040195, 7309.780706578811, 7586.506877052974, 7608.391328693802, 7610.1628820828555, 7664.0, 6872.522407682372, 7383.630818459163, 7450.254974502724, 7451.813704657427, 7496.863393932703, 6433.935660643521, 7946.721864734938, 7948.562829044226, 7950.324222440926, 7953.801154971172, 4839.516048395132, 4840.7337596432535, 4854.2233242681, 4855.34452848875, 4858.174110401311, 7267.600281984542, 7535.171131175676, 7536.8492630148185, 7553.697852086075, 7560.546367217985, 7256.346928776436, 7294.197638259893, 7298.817529561591, 7322.816929576803, 7357.77926662201, 6324.572799040782, 6897.965510172417, 7275.471396372649, 7299.927000729925, 7302.488825782144, 6954.826129346807, 7124.073870396815, 7150.821229469305, 7252.129744430702, 7319.74380896666, 7266.636668166676, 7270.272972702687, 7311.634418279171, 7315.341619254293, 7348.044754182136, 5770.798022069207, 7002.719891204499, 7143.2499587544635, 7150.64246787669, 7164.749233776793], "unit": "score", "name": "prototype.html", "value": 5302.483892223891}, {"lowerIsBetter": false, "replicates": [692.4806395203598, 707.2573797512614, 781.9022622172229, 809.3565615335807, 820.1962077164379, 15691.0, 15935.920320398382, 15967.201639918016, 16003.679926401479, 16069.116198609072, 13293.202407855535, 13323.933380333085, 13325.400356983935, 13338.0, 13351.866481335184, 797.214743477674, 982.0915653020962, 982.9410235385864, 991.7024892532247, 1025.0620682075892, 998.2812375089924, 1003.7992401519689, 1014.614446510325, 1016.8169729448696, 1017.231989847664, 1049.108257980718, 1050.0077426831647, 1050.2595670052594, 1051.7002654243543, 1053.2258789789498, 1019.7654539455966, 1029.0738335498036, 1035.502958579882, 1043.906048455635, 1043.979120417595, 771.5255118102383, 783.5337973905517, 783.8628240057967, 785.2696991797626, 790.7034861926777, 11983.760324793542, 14496.492622758153, 14556.199409032499, 14681.412743490248, 14684.853151468455, 13458.596242112751, 13523.0, 13533.729325413437, 13569.389377478037, 13669.794953075712, 10394.064534191883, 10420.79158416835, 10501.21240906935, 10540.472976351151, 10773.515191816387, 3616.4032934565766, 3619.438986957026, 3652.9086772830624, 3667.21154951684, 3891.9610803891883, 82833.58583207105, 82978.9999999994, 83122.0, 83198.16801831964, 83453.0, 9766.46284454362, 9850.21198304134, 9862.211023118134, 10022.298439109192, 10059.69820905374, 23154.073837046668, 23818.285451436484, 24009.639855402183, 24012.759872401402, 24045.27864164078, 6518.413342799171, 7618.69525218985, 7620.161782203953, 7747.690092396241, 7777.883331749915, 4107.979460102681, 4151.0, 4166.375043743463, 4179.059711564934, 4196.0, 3682.705383569308, 3695.131644063643, 3734.3838266685693, 3735.6451137141926, 3765.021094515446, 654.7937399719074, 671.8219671786981, 673.461231015186, 673.8847207870981, 675.8377989282537, 577.9017567013618, 588.4115884115885, 593.4273426143792, 606.1150719948924, 616.0881894795638, 6927.134341862649, 6949.861002779916, 7334.816629584303, 8523.95738021306, 8530.232279094911, 596.6897213448982, 596.6956852005509, 608.8812681527148, 617.8949578571653, 628.5066223015003, 3940.645341919241, 3968.0, 4052.9392059119136, 4056.1684854604737, 4116.9794151029055, 96336.0, 97976.51011744895, 100372.71301098114, 100634.0, 100768.49615751875, 86953.56523217344, 87445.56277218701, 87676.5616171915, 87804.1219587796, 87818.0, 56387.0, 74158.62920685361, 74568.62715686495, 74629.0, 75204.0, 7641.503302285334, 7892.881606776018, 7956.283934445696, 8169.591520424074, 8515.48907065578, 47688.0, 49283.52149435523, 50083.0, 50458.49541504685, 50884.49115508798, 64033.679831600544, 66663.66668166628, 67652.661736691, 68145.63708725898, 68615.0, 10214.32602929925, 10429.0, 10452.843207352047, 10722.463876805972, 10852.728681783019, 11890.464929078385, 12021.278723276631, 12176.391180440765, 12374.071944604011, 12791.232526048467, 11470.39729618554, 11480.82778758336, 11534.307941523535, 11795.823062653895, 11918.165728398928, 11208.327500350006, 11363.204575679623, 11420.71448213768, 11562.132840036862, 12266.75466490683, 11169.38568378747, 11288.435578220891, 11350.829737553779, 11614.825777613174, 11934.462949167135, 7662.73180438682, 8579.613917373608, 9719.514024298898, 10105.747356316151, 10119.241056920613, 9796.476080617294, 9932.900670993487, 9951.502424878583, 10060.84908726355, 10187.28688991793], "unit": "score", "name": "yui.html", "value": 7129.423251740739}], "name": "dromaeo_css", "value": 7739.638846006561}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 114.0, 116.0, 113.0, 132.0, 115.0, 114.0, 112.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.0}, {"lowerIsBetter": true, "replicates": [154.0, 134.0, 152.0, 155.0, 152.0, 169.0, 129.0, 159.0, 143.0, 148.0], "unit": "score", "name": "audio-beat-detection", "value": 149.5}, {"lowerIsBetter": true, "replicates": [192.0, 218.0, 190.0, 195.0, 193.0, 237.0, 193.0, 190.0, 209.0, 247.0], "unit": "score", "name": "audio-dft", "value": 206.4}, {"lowerIsBetter": true, "replicates": [73.0, 68.0, 72.0, 116.0, 72.0, 74.0, 56.0, 60.0, 128.0, 56.0], "unit": "score", "name": "audio-fft", "value": 77.5}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 120.0, 78.0, 81.0, 80.0, 117.0, 78.0, 78.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 92.0}, {"lowerIsBetter": true, "replicates": [134.0, 89.0, 135.0, 130.0, 87.0, 104.0, 119.0, 85.0, 93.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 106.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 94.5}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 92.0, 90.0, 92.0, 92.0, 92.0, 92.0, 91.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 92.2}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 59.0, 61.0, 81.0, 94.0, 89.0, 101.0, 45.0, 42.0], "unit": "score", "name": "json-parse-financial", "value": 68.6}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 68.0, 64.0, 78.0, 66.0, 67.0, 65.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [84.0, 81.0, 83.0, 72.0, 90.0, 106.0, 81.0, 83.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [116.0, 142.0, 135.0, 125.0, 124.0, 136.0, 135.0, 129.0, 126.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.7}, {"lowerIsBetter": true, "replicates": [136.0, 132.0, 135.0, 133.0, 136.0, 149.0, 180.0, 176.0, 166.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 65.0, 63.0, 67.0, 92.0, 99.0, 100.0, 94.0, 93.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 80.8}], "name": "kraken", "value": 1512.1000000000001}]} 12:57:14 INFO - Return code: 0 12:57:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:57:14 ERROR - # TBPL SUCCESS # 12:57:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:57:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:57:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:57:14 INFO - 2016-05-05 12:57:14.620 screenresolution[1685:10302] starting screenresolution argv=screenresolution get 12:57:14 INFO - 2016-05-05 12:57:14.623 screenresolution[1685:10302] Display 0: 1600x1200x32@60 12:57:14 INFO - 2016-05-05 12:57:14.629 screenresolution[1686:10305] starting screenresolution argv=screenresolution list 12:57:14 INFO - Available Modes on Display 0 12:57:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:57:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:57:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:57:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:57:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:57:14 INFO - Intel Iris: 12:57:14 INFO - Chipset Model: Intel Iris 12:57:14 INFO - Type: GPU 12:57:14 INFO - Bus: Built-In 12:57:14 INFO - VRAM (Dynamic, Max): 1536 MB 12:57:14 INFO - Vendor: Intel (0x8086) 12:57:14 INFO - Device ID: 0x0a2e 12:57:14 INFO - Revision ID: 0x0009 12:57:14 INFO - Displays: 12:57:14 INFO - Display: 12:57:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:57:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:57:14 INFO - Display Serial Number: 1600x1200 60 12:57:14 INFO - Main Display: Yes 12:57:14 INFO - Mirror: Off 12:57:14 INFO - Online: Yes 12:57:14 INFO - Rotation: Supported 12:57:14 INFO - Return code: 0 12:57:14 INFO - Running post-action listener: _resource_record_post_action 12:57:14 INFO - Running post-run listener: _resource_record_post_run 12:57:15 INFO - Total resource usage - Wall time: 1190s; CPU: 53.0%; Read bytes: 37701120; Write bytes: 508888064; Read time: 396; Write time: 1530 12:57:15 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 200729088; Write bytes: 197248512; Read time: 18074; Write time: 371 12:57:15 INFO - run-tests - Wall time: 1169s; CPU: 53.0%; Read bytes: 35886592; Write bytes: 300846592; Read time: 376; Write time: 1126 12:57:15 INFO - Running post-run listener: _upload_blobber_files 12:57:15 INFO - Blob upload gear active. 12:57:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:57:15 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 12:57:15 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'] 12:57:15 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 12:57:16 INFO - (blobuploader) - INFO - Open directory for files ... 12:57:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:57:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:57:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:57:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:57:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:57:17 INFO - (blobuploader) - INFO - Done attempting. 12:57:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:57:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:57:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:57:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:57:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:57:18 INFO - (blobuploader) - INFO - Done attempting. 12:57:18 INFO - (blobuploader) - INFO - Iteration through files over. 12:57:18 INFO - Return code: 0 12:57:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:57:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:57:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/957ec55ee762f8753fea2cb8b30714716ca1ac1e2e5a9e3fbd4b6df55836c5e257d0b1ce6e7da242279b8016dc8dfa604ca99df0f3a0f5f9ba89c87b6da584bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95bc67c9431e58994d3e21af2f1f1145a51829a9d82d30245d5c9e63ef16381fe634b1cc701af698a746a255e7ed86e75e80fffd51aa5fefb2a75c948eeb0474"} 12:57:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:57:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:57:18 INFO - Contents: 12:57:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/957ec55ee762f8753fea2cb8b30714716ca1ac1e2e5a9e3fbd4b6df55836c5e257d0b1ce6e7da242279b8016dc8dfa604ca99df0f3a0f5f9ba89c87b6da584bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95bc67c9431e58994d3e21af2f1f1145a51829a9d82d30245d5c9e63ef16381fe634b1cc701af698a746a255e7ed86e75e80fffd51aa5fefb2a75c948eeb0474"} 12:57:18 INFO - Running post-run listener: copy_logs_to_upload_dir 12:57:18 INFO - Copying logs to upload dir... 12:57:18 INFO - mkdir: /builds/slave/test/build/upload/logs 12:57:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.177811 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-05 12:57:18.694480) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 12:57:18.699763) ========= 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.9VedmZxqqL/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.yJLzkfCmdM/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/957ec55ee762f8753fea2cb8b30714716ca1ac1e2e5a9e3fbd4b6df55836c5e257d0b1ce6e7da242279b8016dc8dfa604ca99df0f3a0f5f9ba89c87b6da584bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95bc67c9431e58994d3e21af2f1f1145a51829a9d82d30245d5c9e63ef16381fe634b1cc701af698a746a255e7ed86e75e80fffd51aa5fefb2a75c948eeb0474"} build_url:https://queue.taskcluster.net/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010893 build_url: 'https://queue.taskcluster.net/v1/task/QFaV3R2mR96t5-p32XWuLw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/957ec55ee762f8753fea2cb8b30714716ca1ac1e2e5a9e3fbd4b6df55836c5e257d0b1ce6e7da242279b8016dc8dfa604ca99df0f3a0f5f9ba89c87b6da584bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95bc67c9431e58994d3e21af2f1f1145a51829a9d82d30245d5c9e63ef16381fe634b1cc701af698a746a255e7ed86e75e80fffd51aa5fefb2a75c948eeb0474"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 12:57:18.727048) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 12:57:18.727508) ========= 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.9VedmZxqqL/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.yJLzkfCmdM/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.004973 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 12:57:18.776068) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 12:57:18.776433) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 12:57:18.776799) ========= ========= Total master_lag: 0.24 =========