builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0112 starttime: 1461968123.9 results: success (0) buildid: 20160429140138 builduid: 705aab55b64d4756b715c6983158d0fe revision: 362b8365615be2a57cc3ba93fe33ea3412d61192 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 15:15:23.897290) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 15:15:23.897748) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 15:15:23.898024) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 15:15:23.917747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 15:15:23.918119) ========= 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.23L7rR9Zxk/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.Wg0zTY4dNW/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-04-29 15:15:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2016-04-29 15:15:24 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178674 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 15:15:24.114875) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 15:15:24.115248) ========= 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.23L7rR9Zxk/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.Wg0zTY4dNW/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.027049 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 15:15:24.164040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 15:15:24.164474) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 362b8365615be2a57cc3ba93fe33ea3412d61192 --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 362b8365615be2a57cc3ba93fe33ea3412d61192 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.23L7rR9Zxk/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.Wg0zTY4dNW/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-04-29 15:15:24,227 truncating revision to first 12 chars 2016-04-29 15:15:24,227 Setting DEBUG logging. 2016-04-29 15:15:24,227 attempt 1/10 2016-04-29 15:15:24,227 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/362b8365615b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 15:15:25,275 unpacking tar archive at: mozilla-beta-362b8365615b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.297872 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 15:15:25.479169) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 15:15:25.479532) ========= script_repo_revision: 362b8365615be2a57cc3ba93fe33ea3412d61192 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 15:15:25.479967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 15:15:25.480251) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 15:15:25.494072) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-04-29 15:15:25.494464) ========= /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.23L7rR9Zxk/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.Wg0zTY4dNW/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 15:15:25 INFO - MultiFileLogger online at 20160429 15:15:25 in /builds/slave/test 15:15:25 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 15:15:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:15:25 INFO - {'append_to_log': False, 15:15:25 INFO - 'base_work_dir': '/builds/slave/test', 15:15:25 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:15:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:15:25 INFO - 'branch': 'Mozilla-Beta', 15:15:25 INFO - 'buildbot_json_path': 'buildprops.json', 15:15:25 INFO - 'config_files': ('talos/mac_config.py',), 15:15:25 INFO - 'default_actions': ('clobber', 15:15:25 INFO - 'read-buildbot-config', 15:15:25 INFO - 'download-and-extract', 15:15:25 INFO - 'populate-webroot', 15:15:25 INFO - 'create-virtualenv', 15:15:25 INFO - 'install', 15:15:25 INFO - 'run-tests'), 15:15:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:15:25 INFO - 'download_minidump_stackwalk': True, 15:15:25 INFO - 'download_symbols': 'ondemand', 15:15:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:15:25 INFO - 'tooltool.py': '/tools/tooltool.py', 15:15:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:15:25 INFO - '/tools/misc-python/virtualenv.py')}, 15:15:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:15:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:15:25 INFO - 'installer_path': 'installer.exe', 15:15:25 INFO - 'log_level': 'info', 15:15:25 INFO - 'log_name': 'talos', 15:15:25 INFO - 'log_to_console': True, 15:15:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:15:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:15:25 INFO - 'opt_config_files': (), 15:15:25 INFO - 'pip_index': False, 15:15:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:15:25 INFO - 'cmd': ('bash', 15:15:25 INFO - '-c', 15:15:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:15:25 INFO - 'enabled': True, 15:15:25 INFO - 'halt_on_failure': False, 15:15:25 INFO - 'name': 'check_screen_resolution'},), 15:15:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:15:25 INFO - 'cmd': ('bash', 15:15:25 INFO - '-c', 15:15:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:15:25 INFO - 'enabled': True, 15:15:25 INFO - 'halt_on_failure': False, 15:15:25 INFO - 'name': 'check_screen_resolution'},), 15:15:25 INFO - 'run_cmd_checks_enabled': True, 15:15:25 INFO - 'sps_profile': False, 15:15:25 INFO - 'sps_profile_interval': 0, 15:15:25 INFO - 'suite': 'dromaeojs-e10s', 15:15:25 INFO - 'system_bits': '32', 15:15:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:15:25 INFO - 'title': 't-yosemite-r7-0112', 15:15:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:15:25 INFO - 'use_talos_json': True, 15:15:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:15:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:15:25 INFO - 'work_dir': 'build'} 15:15:25 INFO - ##### 15:15:25 INFO - ##### Running clobber step. 15:15:25 INFO - ##### 15:15:25 INFO - Running pre-action listener: _resource_record_pre_action 15:15:25 INFO - Running main action method: clobber 15:15:25 INFO - rmtree: /builds/slave/test/build 15:15:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:15:27 INFO - Running post-action listener: _resource_record_post_action 15:15:27 INFO - ##### 15:15:27 INFO - ##### Running read-buildbot-config step. 15:15:27 INFO - ##### 15:15:27 INFO - Running pre-action listener: _resource_record_pre_action 15:15:27 INFO - Running main action method: read_buildbot_config 15:15:27 INFO - Using buildbot properties: 15:15:27 INFO - { 15:15:27 INFO - "project": "", 15:15:27 INFO - "product": "firefox", 15:15:27 INFO - "script_repo_revision": "production", 15:15:27 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 15:15:27 INFO - "repository": "", 15:15:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 15:15:27 INFO - "buildid": "20160429140138", 15:15:27 INFO - "pgo_build": "False", 15:15:27 INFO - "basedir": "/builds/slave/test", 15:15:27 INFO - "buildnumber": 66, 15:15:27 INFO - "slavename": "t-yosemite-r7-0112", 15:15:27 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 15:15:27 INFO - "platform": "yosemite_r7", 15:15:27 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:15:27 INFO - "branch": "mozilla-beta", 15:15:27 INFO - "repo_path": "releases/mozilla-beta", 15:15:27 INFO - "revision": "362b8365615be2a57cc3ba93fe33ea3412d61192", 15:15:27 INFO - "stage_platform": "macosx64", 15:15:27 INFO - "builduid": "705aab55b64d4756b715c6983158d0fe", 15:15:27 INFO - "slavebuilddir": "test" 15:15:27 INFO - } 15:15:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 15:15:27 INFO - Running post-action listener: _resource_record_post_action 15:15:27 INFO - ##### 15:15:27 INFO - ##### Running download-and-extract step. 15:15:27 INFO - ##### 15:15:27 INFO - Running pre-action listener: _resource_record_pre_action 15:15:27 INFO - Running main action method: download_and_extract 15:15:27 INFO - mkdir: /builds/slave/test/build/tests 15:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:27 INFO - https://queue.taskcluster.net/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:15:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 15:15:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 15:15:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/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 15:15:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/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 15:15:28 INFO - Downloaded 1241 bytes. 15:15:28 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 15:15:28 INFO - Using the following test package requirements: 15:15:28 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 15:15:28 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 15:15:28 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 15:15:28 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 15:15:28 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 15:15:28 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:15:28 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 15:15:28 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 15:15:28 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 15:15:28 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 15:15:28 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 15:15:28 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 15:15:28 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 15:15:28 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 15:15:28 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 15:15:28 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 15:15:28 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 15:15:28 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 15:15:28 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 15:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:28 INFO - https://queue.taskcluster.net/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:15:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 15:15:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 15:15:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/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 15:15:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/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 15:15:31 INFO - Downloaded 17745612 bytes. 15:15:31 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'] 15:15:31 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 15:15:34 INFO - Return code: 0 15:15:34 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 15:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:34 INFO - https://queue.taskcluster.net/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:15:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 15:15:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 15:15:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/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 15:15:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/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 15:15:35 INFO - Downloaded 17745612 bytes. 15:15:35 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'] 15:15:35 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 15:15:39 INFO - Return code: 0 15:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:39 INFO - https://queue.taskcluster.net/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:15:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 15:15:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 15:15:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/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 15:15:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/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 15:15:45 INFO - Downloaded 10845194 bytes. 15:15: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'] 15:15: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 15:15:45 INFO - Return code: 0 15:15: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')]} 15:15:45 INFO - https://queue.taskcluster.net/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 15:15:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 15:15:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 15:15:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 15:15:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXCiSXcnRki_somanj2WKA/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 15:15:50 INFO - Downloaded 88279395 bytes. 15:15:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 15:15:50 INFO - mkdir: /builds/slave/test/properties 15:15:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:15:50 INFO - Writing to file /builds/slave/test/properties/build_url 15:15:50 INFO - Contents: 15:15:50 INFO - build_url:https://queue.taskcluster.net/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 15:15:53 INFO - Running post-action listener: _resource_record_post_action 15:15:53 INFO - Running post-action listener: set_extra_try_arguments 15:15:53 INFO - ##### 15:15:53 INFO - ##### Running populate-webroot step. 15:15:53 INFO - ##### 15:15:53 INFO - Running pre-action listener: _resource_record_pre_action 15:15:53 INFO - Running main action method: populate_webroot 15:15:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:15:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:15:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:15:53 INFO - '--tppagecycles', 15:15:53 INFO - '7'], 15:15:53 INFO - 'tests': ['tsvgm']}}, 15:15:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:15:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:15:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:15:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:15:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:15:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:15:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:15:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:53 INFO - 'talos_options': ['--e10s'], 15:15:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:15:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:53 INFO - 'tests': ['damp', 'tps']}, 15:15:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:53 INFO - 'talos_options': ['--e10s'], 15:15:53 INFO - 'tests': ['damp', 'tps']}, 15:15:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:15:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:15:53 INFO - 'other': {'tests': ['a11yr', 15:15:53 INFO - 'ts_paint', 15:15:53 INFO - 'tpaint', 15:15:53 INFO - 'sessionrestore', 15:15:53 INFO - 'sessionrestore_no_auto_restore', 15:15:53 INFO - 'tabpaint']}, 15:15:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:15:53 INFO - 'tests': ['a11yr', 15:15:53 INFO - 'ts_paint', 15:15:53 INFO - 'tpaint', 15:15:53 INFO - 'sessionrestore', 15:15:53 INFO - 'sessionrestore_no_auto_restore', 15:15:53 INFO - 'tabpaint']}, 15:15:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:15:53 INFO - 'tests': ['a11yr', 15:15:53 INFO - 'ts_paint', 15:15:53 INFO - 'tpaint', 15:15:53 INFO - 'sessionrestore', 15:15:53 INFO - 'sessionrestore_no_auto_restore', 15:15:53 INFO - 'tabpaint']}, 15:15:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:15:53 INFO - 'tests': ['a11yr', 15:15:53 INFO - 'ts_paint', 15:15:53 INFO - 'tpaint', 15:15:53 INFO - 'sessionrestore', 15:15:53 INFO - 'sessionrestore_no_auto_restore', 15:15:53 INFO - 'tabpaint']}, 15:15:53 INFO - 'other_l64': {'tests': ['a11yr', 15:15:53 INFO - 'ts_paint', 15:15:53 INFO - 'tpaint', 15:15:53 INFO - 'sessionrestore', 15:15:53 INFO - 'sessionrestore_no_auto_restore', 15:15:53 INFO - 'tabpaint']}, 15:15:53 INFO - 'other_nol64': {'tests': ['a11yr', 15:15:53 INFO - 'ts_paint', 15:15:53 INFO - 'tpaint', 15:15:53 INFO - 'sessionrestore', 15:15:53 INFO - 'sessionrestore_no_auto_restore', 15:15:53 INFO - 'tabpaint']}, 15:15:53 INFO - 'svgr': {'tests': ['tsvgx', 15:15:53 INFO - 'tsvgr_opacity', 15:15:53 INFO - 'tart', 15:15:53 INFO - 'tscrollx', 15:15:53 INFO - 'cart']}, 15:15:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:15:53 INFO - 'tests': ['tsvgx', 15:15:53 INFO - 'tsvgr_opacity', 15:15:53 INFO - 'tart', 15:15:53 INFO - 'tscrollx', 15:15:53 INFO - 'cart']}, 15:15:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:53 INFO - 'tests': ['tp5o']}, 15:15:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:53 INFO - 'talos_options': ['--e10s'], 15:15:53 INFO - 'tests': ['tp5o']}, 15:15:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:53 INFO - 'talos_options': ['--xperf_path', 15:15:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:15:53 INFO - 'tests': ['tp5n']}, 15:15:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:53 INFO - 'talos_options': ['--e10s', 15:15:53 INFO - '--xperf_path', 15:15:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:15:53 INFO - 'tests': ['tp5n']}}, 15:15:53 INFO - 'talos.zip': {'path': '', 15:15:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:15:53 INFO - Running post-action listener: _resource_record_post_action 15:15:53 INFO - ##### 15:15:53 INFO - ##### Running create-virtualenv step. 15:15:53 INFO - ##### 15:15:53 INFO - Running pre-action listener: _resource_record_pre_action 15:15:53 INFO - Running main action method: create_virtualenv 15:15:53 INFO - Creating virtualenv /builds/slave/test/build/venv 15:15:53 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 15:15:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:15:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:15:53 INFO - Using real prefix '/tools/python27' 15:15:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:15:54 INFO - Installing distribute.............................................................................................................................................................................................done. 15:15:57 INFO - Installing pip.................done. 15:15:57 INFO - Return code: 0 15:15:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:57 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 0x10b5b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd06347e7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458d30>, '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 0x10b2bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b44fb20>, '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.23L7rR9Zxk/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.Wg0zTY4dNW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 15:15:57 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 15:15:57 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 15:15:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.23L7rR9Zxk/Render', 15:15:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:57 INFO - 'HOME': '/Users/cltbld', 15:15:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:57 INFO - 'LOGNAME': 'cltbld', 15:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:57 INFO - 'MOZ_NO_REMOTE': '1', 15:15:57 INFO - 'NO_EM_RESTART': '1', 15:15:57 INFO - 'PAGER': '/bin/cat', 15:15:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:57 INFO - 'PWD': '/builds/slave/test', 15:15:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:57 INFO - 'SHELL': '/bin/bash', 15:15:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wg0zTY4dNW/Listeners', 15:15:57 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 15:15:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:57 INFO - 'USER': 'cltbld', 15:15:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:57 INFO - 'XPC_FLAGS': '0x0', 15:15:57 INFO - 'XPC_SERVICE_NAME': '0', 15:15:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:57 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 15:15:57 INFO - Cleaning up... 15:15:57 INFO - Return code: 0 15:15:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:57 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 0x10b5b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd06347e7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458d30>, '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 0x10b2bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b44fb20>, '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.23L7rR9Zxk/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.Wg0zTY4dNW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 15:15:57 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 15:15:57 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 15:15:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.23L7rR9Zxk/Render', 15:15:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:57 INFO - 'HOME': '/Users/cltbld', 15:15:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:57 INFO - 'LOGNAME': 'cltbld', 15:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:57 INFO - 'MOZ_NO_REMOTE': '1', 15:15:57 INFO - 'NO_EM_RESTART': '1', 15:15:57 INFO - 'PAGER': '/bin/cat', 15:15:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:57 INFO - 'PWD': '/builds/slave/test', 15:15:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:57 INFO - 'SHELL': '/bin/bash', 15:15:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wg0zTY4dNW/Listeners', 15:15:57 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 15:15:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:57 INFO - 'USER': 'cltbld', 15:15:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:57 INFO - 'XPC_FLAGS': '0x0', 15:15:57 INFO - 'XPC_SERVICE_NAME': '0', 15:15:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:57 INFO - Downloading/unpacking psutil>=0.7.1 15:15:57 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 15:15:57 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 15:15:57 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 15:15:57 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 15:15:57 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 15:15:57 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 15:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:16:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:00 INFO - Installing collected packages: psutil 15:16:00 INFO - Running setup.py install for psutil 15:16:00 INFO - building 'psutil._psutil_osx' extension 15:16:00 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 15:16:00 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 15:16:00 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 15:16:01 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 15:16:01 INFO - building 'psutil._psutil_posix' extension 15:16:01 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 15:16:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:16:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:16:01 INFO - ^ 15:16:01 INFO - 1 warning generated. 15:16:01 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 15:16:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:01 INFO - Successfully installed psutil 15:16:01 INFO - Cleaning up... 15:16:01 INFO - Return code: 0 15:16:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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')]} 15:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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', '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 0x10b5b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd06347e7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458d30>, '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 0x10b2bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b44fb20>, '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.23L7rR9Zxk/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.Wg0zTY4dNW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 15:16: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:16: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 mozsystemmonitor==0.0.0 15:16:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.23L7rR9Zxk/Render', 15:16:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:01 INFO - 'HOME': '/Users/cltbld', 15:16:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:01 INFO - 'LOGNAME': 'cltbld', 15:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:01 INFO - 'MOZ_NO_REMOTE': '1', 15:16:01 INFO - 'NO_EM_RESTART': '1', 15:16:01 INFO - 'PAGER': '/bin/cat', 15:16:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:01 INFO - 'PWD': '/builds/slave/test', 15:16:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:01 INFO - 'SHELL': '/bin/bash', 15:16:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wg0zTY4dNW/Listeners', 15:16:01 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 15:16:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:01 INFO - 'USER': 'cltbld', 15:16:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:01 INFO - 'XPC_FLAGS': '0x0', 15:16:01 INFO - 'XPC_SERVICE_NAME': '0', 15:16:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:16:04 INFO - Installing collected packages: mozsystemmonitor 15:16:04 INFO - Running setup.py install for mozsystemmonitor 15:16:04 INFO - Successfully installed mozsystemmonitor 15:16:04 INFO - Cleaning up... 15:16:04 INFO - Return code: 0 15:16:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b5b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd06347e7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458d30>, '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 0x10b2bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b44fb20>, '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.23L7rR9Zxk/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.Wg0zTY4dNW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 15:16:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:16:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.23L7rR9Zxk/Render', 15:16:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:04 INFO - 'HOME': '/Users/cltbld', 15:16:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:04 INFO - 'LOGNAME': 'cltbld', 15:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:04 INFO - 'MOZ_NO_REMOTE': '1', 15:16:04 INFO - 'NO_EM_RESTART': '1', 15:16:04 INFO - 'PAGER': '/bin/cat', 15:16:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:04 INFO - 'PWD': '/builds/slave/test', 15:16:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:04 INFO - 'SHELL': '/bin/bash', 15:16:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wg0zTY4dNW/Listeners', 15:16:04 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 15:16:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:04 INFO - 'USER': 'cltbld', 15:16:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:04 INFO - 'XPC_FLAGS': '0x0', 15:16:04 INFO - 'XPC_SERVICE_NAME': '0', 15:16:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:04 INFO - Downloading/unpacking blobuploader==1.2.4 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:07 INFO - Downloading blobuploader-1.2.4.tar.gz 15:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:16:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:16:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:08 INFO - Downloading docopt-0.6.1.tar.gz 15:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:16:08 INFO - Installing collected packages: blobuploader, requests, docopt 15:16:08 INFO - Running setup.py install for blobuploader 15:16:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:16:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:16:08 INFO - Running setup.py install for requests 15:16:09 INFO - Running setup.py install for docopt 15:16:09 INFO - Successfully installed blobuploader requests docopt 15:16:09 INFO - Cleaning up... 15:16:09 INFO - Return code: 0 15:16:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:09 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')]} 15:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:09 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')]} 15:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:09 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 0x10b5b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd06347e7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458d30>, '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 0x10b2bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b44fb20>, '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.23L7rR9Zxk/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.Wg0zTY4dNW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 15:16:09 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 15:16:09 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 15:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.23L7rR9Zxk/Render', 15:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:09 INFO - 'HOME': '/Users/cltbld', 15:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:09 INFO - 'LOGNAME': 'cltbld', 15:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:09 INFO - 'MOZ_NO_REMOTE': '1', 15:16:09 INFO - 'NO_EM_RESTART': '1', 15:16:09 INFO - 'PAGER': '/bin/cat', 15:16:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:09 INFO - 'PWD': '/builds/slave/test', 15:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:09 INFO - 'SHELL': '/bin/bash', 15:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wg0zTY4dNW/Listeners', 15:16:09 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 15:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:09 INFO - 'USER': 'cltbld', 15:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:09 INFO - 'XPC_FLAGS': '0x0', 15:16:09 INFO - 'XPC_SERVICE_NAME': '0', 15:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:09 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-jPhAyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:09 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-gnWdtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:09 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-r81Xwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:09 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Zr707f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:09 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-hkuJZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-IE3kCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-uLqHr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-VsHzCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Nn_Lev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-9XImJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-D5Mzz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-vjYTra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-0o7WyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-0UtOgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-EhOjsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:11 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-tLqDUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:11 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-tiuAap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:16:11 INFO - Running setup.py install for manifestparser 15:16:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:16:11 INFO - Running setup.py install for mozcrash 15:16:11 INFO - Running setup.py install for mozdebug 15:16:11 INFO - Running setup.py install for mozdevice 15:16:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:16:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:16:11 INFO - Running setup.py install for mozfile 15:16:12 INFO - Running setup.py install for mozhttpd 15:16:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:16:12 INFO - Running setup.py install for mozinfo 15:16:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:16:12 INFO - Running setup.py install for mozInstall 15:16:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:16:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:16:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:16:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:16:12 INFO - Running setup.py install for mozleak 15:16:12 INFO - Running setup.py install for mozlog 15:16:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:16:12 INFO - Running setup.py install for moznetwork 15:16:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:16:12 INFO - Running setup.py install for mozprocess 15:16:13 INFO - Running setup.py install for mozprofile 15:16:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:16:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:16:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:16:13 INFO - Running setup.py install for mozrunner 15:16:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:16:13 INFO - Running setup.py install for mozscreenshot 15:16:13 INFO - Running setup.py install for moztest 15:16:13 INFO - Running setup.py install for mozversion 15:16:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:16:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:16:13 INFO - Cleaning up... 15:16:13 INFO - Return code: 0 15:16:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:13 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 0x10b5b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd06347e7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458d30>, '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 0x10b2bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b44fb20>, '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.23L7rR9Zxk/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.Wg0zTY4dNW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 15:16:13 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 15:16:13 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 15:16:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.23L7rR9Zxk/Render', 15:16:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:13 INFO - 'HOME': '/Users/cltbld', 15:16:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:13 INFO - 'LOGNAME': 'cltbld', 15:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:13 INFO - 'MOZ_NO_REMOTE': '1', 15:16:13 INFO - 'NO_EM_RESTART': '1', 15:16:13 INFO - 'PAGER': '/bin/cat', 15:16:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:13 INFO - 'PWD': '/builds/slave/test', 15:16:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:13 INFO - 'SHELL': '/bin/bash', 15:16:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wg0zTY4dNW/Listeners', 15:16:13 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 15:16:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:13 INFO - 'USER': 'cltbld', 15:16:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:13 INFO - 'XPC_FLAGS': '0x0', 15:16:13 INFO - 'XPC_SERVICE_NAME': '0', 15:16:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:14 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-5QzA9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:14 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)) 15:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:14 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-HMUi9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:14 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)) 15:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:14 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-3I16AZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:14 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)) 15:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:14 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-_68Au4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:14 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)) 15:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:14 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-3C40wW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:14 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)) 15:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:14 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-EtroMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:14 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)) 15:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:14 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-J7u1cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:14 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)) 15:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:14 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-SL6cMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:14 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)) 15:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:14 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-qWZnGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:15 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)) 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-bIMJg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:15 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)) 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-hab7IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:15 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)) 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-v4HMy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:15 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)) 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-dLzIhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:15 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)) 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-sOoRX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:15 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)) 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-w8bkri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:15 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)) 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-KAeWFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:15 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)) 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-0VbwoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:15 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)) 15:16:15 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)) 15:16:15 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)) 15:16:15 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)) 15:16:15 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)) 15:16:15 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)) 15:16:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:16:15 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 15:16:15 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 15:16:15 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 15:16:15 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 15:16:15 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 15:16:15 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 15:16:18 INFO - Downloading blessings-1.6.tar.gz 15:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:16:18 INFO - Installing collected packages: blessings 15:16:18 INFO - Running setup.py install for blessings 15:16:18 INFO - Successfully installed blessings 15:16:18 INFO - Cleaning up... 15:16:18 INFO - Return code: 0 15:16:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:16:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:19 INFO - Reading from file tmpfile_stdout 15:16:19 INFO - Current package versions: 15:16:19 INFO - blessings == 1.6 15:16:19 INFO - blobuploader == 1.2.4 15:16:19 INFO - docopt == 0.6.1 15:16:19 INFO - manifestparser == 1.1 15:16:19 INFO - mozInstall == 1.12 15:16:19 INFO - mozcrash == 0.17 15:16:19 INFO - mozdebug == 0.1 15:16:19 INFO - mozdevice == 0.48 15:16:19 INFO - mozfile == 1.2 15:16:19 INFO - mozhttpd == 0.7 15:16:19 INFO - mozinfo == 0.9 15:16:19 INFO - mozleak == 0.1 15:16:19 INFO - mozlog == 3.1 15:16:19 INFO - moznetwork == 0.27 15:16:19 INFO - mozprocess == 0.22 15:16:19 INFO - mozprofile == 0.28 15:16:19 INFO - mozrunner == 6.11 15:16:19 INFO - mozscreenshot == 0.1 15:16:19 INFO - mozsystemmonitor == 0.0 15:16:19 INFO - moztest == 0.7 15:16:19 INFO - mozversion == 1.4 15:16:19 INFO - psutil == 3.1.1 15:16:19 INFO - requests == 1.2.3 15:16:19 INFO - wsgiref == 0.1.2 15:16:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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')]} 15:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:19 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 0x10b5b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd06347e7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458d30>, '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 0x10b2bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b44fb20>, '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.23L7rR9Zxk/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.Wg0zTY4dNW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 15:16:19 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 15:16:19 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 15:16:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.23L7rR9Zxk/Render', 15:16:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:19 INFO - 'HOME': '/Users/cltbld', 15:16:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:19 INFO - 'LOGNAME': 'cltbld', 15:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:19 INFO - 'MOZ_NO_REMOTE': '1', 15:16:19 INFO - 'NO_EM_RESTART': '1', 15:16:19 INFO - 'PAGER': '/bin/cat', 15:16:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:19 INFO - 'PWD': '/builds/slave/test', 15:16:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:19 INFO - 'SHELL': '/bin/bash', 15:16:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wg0zTY4dNW/Listeners', 15:16:19 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 15:16:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:19 INFO - 'USER': 'cltbld', 15:16:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:19 INFO - 'XPC_FLAGS': '0x0', 15:16:19 INFO - 'XPC_SERVICE_NAME': '0', 15:16:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:19 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)) 15:16:19 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)) 15:16:19 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)) 15:16:19 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)) 15:16:19 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)) 15:16:19 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)) 15:16:19 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)) 15:16:19 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)) 15:16:19 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)) 15:16:19 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)) 15:16:19 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)) 15:16:19 INFO - Cleaning up... 15:16:19 INFO - Return code: 0 15:16:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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')]} 15:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b5b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd06347e7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458d30>, '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 0x10b2bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b44fb20>, '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.23L7rR9Zxk/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.Wg0zTY4dNW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 15:16: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', 'jsonschema'] in /builds/slave/test/build 15:16: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 jsonschema 15:16:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.23L7rR9Zxk/Render', 15:16:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:19 INFO - 'HOME': '/Users/cltbld', 15:16:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:19 INFO - 'LOGNAME': 'cltbld', 15:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:19 INFO - 'MOZ_NO_REMOTE': '1', 15:16:19 INFO - 'NO_EM_RESTART': '1', 15:16:19 INFO - 'PAGER': '/bin/cat', 15:16:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:19 INFO - 'PWD': '/builds/slave/test', 15:16:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:19 INFO - 'SHELL': '/bin/bash', 15:16:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wg0zTY4dNW/Listeners', 15:16:19 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 15:16:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:19 INFO - 'USER': 'cltbld', 15:16:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:19 INFO - 'XPC_FLAGS': '0x0', 15:16:19 INFO - 'XPC_SERVICE_NAME': '0', 15:16:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:19 INFO - Downloading/unpacking jsonschema 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:16:21 INFO - Downloading/unpacking functools32 (from jsonschema) 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:22 INFO - Downloading functools32-3.2.3-2.tar.gz 15:16:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:16:22 INFO - warning: no files found matching '*.txt' 15:16:22 INFO - no previously-included directories found matching 'build' 15:16:22 INFO - no previously-included directories found matching 'dist' 15:16:22 INFO - no previously-included directories found matching '.git*' 15:16:22 INFO - Installing collected packages: jsonschema, functools32 15:16:22 INFO - Running setup.py install for functools32 15:16:22 INFO - warning: no files found matching '*.txt' 15:16:22 INFO - no previously-included directories found matching 'build' 15:16:22 INFO - no previously-included directories found matching 'dist' 15:16:22 INFO - no previously-included directories found matching '.git*' 15:16:22 INFO - Successfully installed jsonschema functools32 15:16:22 INFO - Cleaning up... 15:16:22 INFO - Return code: 0 15:16:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:23 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 0x10b5b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd06347e7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458d30>, '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 0x10b2bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b44fb20>, '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.23L7rR9Zxk/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.Wg0zTY4dNW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 15:16:23 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 15:16:23 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 15:16:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.23L7rR9Zxk/Render', 15:16:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:23 INFO - 'HOME': '/Users/cltbld', 15:16:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:23 INFO - 'LOGNAME': 'cltbld', 15:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:23 INFO - 'MOZ_NO_REMOTE': '1', 15:16:23 INFO - 'NO_EM_RESTART': '1', 15:16:23 INFO - 'PAGER': '/bin/cat', 15:16:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:23 INFO - 'PWD': '/builds/slave/test', 15:16:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:23 INFO - 'SHELL': '/bin/bash', 15:16:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wg0zTY4dNW/Listeners', 15:16:23 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 15:16:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:23 INFO - 'USER': 'cltbld', 15:16:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:23 INFO - 'XPC_FLAGS': '0x0', 15:16:23 INFO - 'XPC_SERVICE_NAME': '0', 15:16:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:23 INFO - Downloading/unpacking flake8 15:16:23 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 15:16:23 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 15:16:23 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 15:16:23 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 15:16:23 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 15:16:23 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 15:16:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:16:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:16:26 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 15:16:26 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 15:16:26 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 15:16:26 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 15:16:26 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 15:16:26 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 15:16:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:16:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:16:26 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 15:16:26 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 15:16:26 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 15:16:26 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 15:16:26 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 15:16:26 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 15:16:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:16:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:16:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:16:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:16:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:16:27 INFO - no previously-included directories found matching 'docs/_build' 15:16:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:16:27 INFO - Running setup.py install for pep8 15:16:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:16:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:16:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:16:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:16:27 INFO - no previously-included directories found matching 'docs/_build' 15:16:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:16:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:16:27 INFO - Cleaning up... 15:16:27 INFO - Return code: 0 15:16:27 INFO - Running post-action listener: _resource_record_post_action 15:16:27 INFO - Running post-action listener: _start_resource_monitoring 15:16:28 INFO - Starting resource monitoring. 15:16:28 INFO - ##### 15:16:28 INFO - ##### Running install step. 15:16:28 INFO - ##### 15:16:28 INFO - Running pre-action listener: _resource_record_pre_action 15:16:28 INFO - Running main action method: install 15:16:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:28 INFO - Reading from file tmpfile_stdout 15:16:28 INFO - Detecting whether we're running mozinstall >=1.0... 15:16:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:16:28 INFO - Reading from file tmpfile_stdout 15:16:28 INFO - Output received: 15:16:28 INFO - Usage: mozinstall [options] installer 15:16:28 INFO - Options: 15:16:28 INFO - -h, --help show this help message and exit 15:16:28 INFO - -d DEST, --destination=DEST 15:16:28 INFO - Directory to install application into. [default: 15:16:28 INFO - "/builds/slave/test"] 15:16:28 INFO - --app=APP Application being installed. [default: firefox] 15:16:28 INFO - mkdir: /builds/slave/test/build/application 15:16:28 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'] 15:16:28 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 15:16:50 INFO - Reading from file tmpfile_stdout 15:16:50 INFO - Output received: 15:16:50 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:16:50 INFO - Running post-action listener: _resource_record_post_action 15:16:50 INFO - ##### 15:16:50 INFO - ##### Running run-tests step. 15:16:50 INFO - ##### 15:16:50 INFO - Running pre-action listener: _resource_record_pre_action 15:16:50 INFO - Running main action method: run_tests 15:16:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:16:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:16:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:16:50 INFO - 2016-04-29 15:16:50.572 screenresolution[1638:7477] starting screenresolution argv=screenresolution get 15:16:50 INFO - 2016-04-29 15:16:50.575 screenresolution[1638:7477] Display 0: 1600x1200x32@60 15:16:50 INFO - 2016-04-29 15:16:50.581 screenresolution[1639:7479] starting screenresolution argv=screenresolution list 15:16:50 INFO - Available Modes on Display 0 15:16:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:16:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:16:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:16:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:16:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:16:50 INFO - Intel Iris: 15:16:50 INFO - Chipset Model: Intel Iris 15:16:50 INFO - Type: GPU 15:16:50 INFO - Bus: Built-In 15:16:50 INFO - VRAM (Dynamic, Max): 1536 MB 15:16:50 INFO - Vendor: Intel (0x8086) 15:16:50 INFO - Device ID: 0x0a2e 15:16:50 INFO - Revision ID: 0x0009 15:16:50 INFO - Displays: 15:16:50 INFO - Display: 15:16:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:16:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:16:50 INFO - Display Serial Number: 1600x1200 60 15:16:50 INFO - Main Display: Yes 15:16:50 INFO - Mirror: Off 15:16:50 INFO - Online: Yes 15:16:50 INFO - Rotation: Supported 15:16:50 INFO - Return code: 0 15:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:16:50 INFO - Python 2.7.3 15:16:50 INFO - Return code: 0 15:16:50 INFO - grabbing minidump binary from tooltool 15:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:50 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 0x10b458d30>, '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 0x10b2bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b44fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:16:50 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 15:16:50 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 15:16:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:16:50 INFO - Return code: 0 15:16:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:16:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:16:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:16:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:16:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:16:52 INFO - Return code: 0 15:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 15:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0112 --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 15:16:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.23L7rR9Zxk/Render', 15:16:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:52 INFO - 'HOME': '/Users/cltbld', 15:16:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:52 INFO - 'LOGNAME': 'cltbld', 15:16:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:16:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:52 INFO - 'MOZ_NO_REMOTE': '1', 15:16:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:16:52 INFO - 'NO_EM_RESTART': '1', 15:16:52 INFO - 'PAGER': '/bin/cat', 15:16:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:52 INFO - 'PWD': '/builds/slave/test', 15:16:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:16:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:52 INFO - 'SHELL': '/bin/bash', 15:16:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wg0zTY4dNW/Listeners', 15:16:52 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 15:16:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:52 INFO - 'USER': 'cltbld', 15:16:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:52 INFO - 'XPC_FLAGS': '0x0', 15:16:52 INFO - 'XPC_SERVICE_NAME': '0', 15:16:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 15:16:52 INFO - mozversion application_buildid: 20160429140138 15:16:52 INFO - mozversion application_changeset: 362b8365615be2a57cc3ba93fe33ea3412d61192 15:16:52 INFO - mozversion application_display_name: Firefox 15:16:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:16:52 INFO - mozversion application_name: Firefox 15:16:52 INFO - mozversion application_remotingname: firefox 15:16:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:16:52 INFO - mozversion application_vendor: Mozilla 15:16:52 INFO - mozversion application_version: 47.0 15:16:52 INFO - mozversion platform_buildid: 20160429140138 15:16:52 INFO - mozversion platform_changeset: 362b8365615be2a57cc3ba93fe33ea3412d61192 15:16:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:16:52 INFO - mozversion platform_version: 47.0 15:16:52 INFO - using testdate: 1461968212 15:16:52 INFO - actual date: 1461968212 15:16:52 INFO - starting webserver on 'localhost:49278' 15:16:52 INFO - SUITE-START | Running 2 tests 15:16:52 INFO - TEST-START | dromaeo_css 15:16:52 INFO - operating with platform_type : mac_ 15:16:52 INFO - Initialising browser for dromaeo_css test... 15:16:52 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmp5UvmKt/profile http://localhost:49278/getInfo.html) 15:16:54 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 15:16:54 INFO - PROCESS | 1657 | colorDepth:24 15:16:54 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 15:16:54 INFO - PROCESS | 1657 | __metrics 15:16:55 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:16:55 INFO - TEST-INFO | 1657: exit 0 15:16:55 INFO - Browser initialized. 15:16:55 INFO - Running cycle 1/1 for dromaeo_css test... 15:16:55 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmp5UvmKt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:17:07 INFO - PROCESS | 1661 | RSS: Main: 168103936 15:17:07 INFO - PROCESS | 1661 | 15:17:57 INFO - PROCESS | 1661 | 1461968277065 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] 15:20:07 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 15:20:08 INFO - PROCESS | 1661 | RSS: Main: 181501952 15:20:08 INFO - PROCESS | 1661 | 15:23:10 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 15:23:11 INFO - PROCESS | 1661 | RSS: Main: 191778816 15:23:11 INFO - PROCESS | 1661 | 15:26:12 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 15:26:13 INFO - PROCESS | 1661 | RSS: Main: 193241088 15:26:13 INFO - PROCESS | 1661 | 15:29:14 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 15:29:15 INFO - PROCESS | 1661 | RSS: Main: 196812800 15:29:15 INFO - PROCESS | 1661 | 15:32:18 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 15:32:18 INFO - PROCESS | 1661 | RSS: Main: 196026368 15:32:18 INFO - PROCESS | 1661 | 15:35:20 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 15:35:20 INFO - PROCESS | 1661 | RSS: Main: 201437184 15:35:20 INFO - PROCESS | 1661 | 15:35:20 INFO - PROCESS | 1661 | __start_tp_report 15:35:20 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 15:35:20 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 15:35:20 INFO - PROCESS | 1661 | |i|pagename|runs| 15:35:21 INFO - PROCESS | 1661 | |0;dojo.html;3643.0710168906926;3643.3077715234103;3678.8160591970395;3711.6288371162877;3713.647203515665;5990.700464976756;6007.48936340411;6044.788432404866;6050.515958723303;6069.059295809146;5930;5970.552208584352;6036.456718895299;6047.818565443033;6059.939400605993;5345.385280692712;5391.919121213165;5441.564674826004;5472.835814925558;5526.530244929186;4433;5336.8132115375965;5442.510174084332;5490.450954904518;5491.368492623359;5383.730813459331;5402.270693456372;5409.540189083933;5436.945630543683;5448.128299472085;5412.404635490093;5457.808976685797;5467.6719396835915;5496.367917689457;5540.63985840921;4361.803718832628;4547.454305483363;4776.590905682832;5198.662086964335;5357.544608708265;4996.7501624918605;5026;5288.497592728685;5777.364489906149;6016.909746353808;6220.47125994291;6243.2508099027955;6270.937290627081;6275.529335299825;6290.811275661737;6364.968175159141;6417.197850268716;6421.51838612106;6435;6445.258795238561;6029.8191054268445;6070.939290607126;6096.298925623521;6130.948521380002;6163.19878415803;6501.2198536175965;6518.087467754518;6524.412802847766;6529.804105876831;6547.116139321226;6201.782937597162;6236.18929539157;6248.343923888017;6251.28110267316;6254.186955695731;6264.9373506265265;6367.872642547123;6451.935480645134;6466.094746735461;6483.384078512534;5707.258056452718;5821.27234095738;6192.752289908443;6254.906176407358;6258.499320054385;6208;6213.502919766408;6269.905951410732;6295.213098362705;6296.937030629635;4935.21036634144;5051.87370315745;5054.848354549369;5056.469070747518;5092.159793634083;3883.3980732986433;4471.575200355961;4492.842750503717;4535.274356103007;4554.772261386917;6022.337542870281;6096.512279017668;6105.755769769159;6120.632762034292;6136.539759518054;6239.438450539473;6342.112104305401;6345.460635845912;6373.235211774617;6402.295747467775;6131.478824299985;6143.078538219303;6153.446189842935;6178.258608966953;6191.473724733358;4638.443386793607;5475.534579560782;5574.888502229933;5578.832635020955;5599.412061733541;6443.613383197023;6495.935040649533;6525.804225873231;6526.216853977458;6561.507886908596;6398.104265402941;6406.13517175194;6408.263049749338;6432.3567643237175;6446.806595802133;6156;6468.611883287018;6512.902306465501;6524.9673751630935;6535.346465353617;6315.810525684236;6327.778527751507;6331.113644089739;6346.397092276226;6348.206474190726;6229.750809967732;6367.395097465734;6368;6373.5857169283845;6374.776882809079;6056.788012419544;6190.783322583688;6211.409916057967;6260.186175797117;6291.811245662638;5908.645481271137;6178.5366097543765;6204.069389591597;6246.281677606951;6264.812055638338;5743.167240750151;5912.881742365043;6103.42017508336;6135.294441139326;6140.662263575547;6170.074488826712;6186.133941248138;6231.376862313732;6259.749610015549;6267.529935254783;5148;5970.701464926823;6232.065190221503;6251.78118765841;6280.780172693934 15:35:21 INFO - PROCESS | 1661 | |1;ext.html;465.039693033885;583.4777873802947;626.639682182745;680.2687111355293;691.0463560286805;33390.66609333906;34172.48741268883;38316.658916937915;39533.20933581327;39807.60192398079;40812;40916.79541602295;41374.75875723726;41759.79120104403;41878;9655.710328690133;9696.12734853863;9784.755381115458;9822.803543929118;9825.150706295202;9826.16477599405;9978.401295922231;9998.900010999869;10000.999900010014;10003;9949.452780097092;9953.701388958343;10003.749906252366;10015.89984100157;10038.297319187659;9852.655157069505;9874.60501579936;9926.25553083518;10015.298929074968;10036.899631003706;9862.161716254128;9912.752181195456;10007.399556026661;10039.698809035668;10066.748331291703;34372;40465.59534404677;40596.79701601473;40829.795851020855;40949.59050409488;3199.1362332170183;3355.7147642450423;3383.2556837495713;3441.896743097711;3559.946600800964;27941.580876286873;28007.29981750452;28582.571261431094;29020.41959160805;29332.70667293321;2608.0480624572083;2760.254731222559;2835.702251263608;2849.216465472012;2924.8683809228637;340528.2973585141;340887;342646;342998;343535;47844;48277.75861120742;48462.27306590404;71557.28442715506;72560.63719681473;47002.76498617485;48071.278930816065;48140;48157;48355;17686;17694.734578981326;17892.46322610324;17913.462596122135;17926.103694815207;14231.78652320216;14300.856991429953;14362.640933976525;14368.568942931728;14468.421263149567;12591.748165036648;15691.450799221973;15725.921370393075;15777.447789327318;15894.887357885069;6645.102911106938;6777.085093512412;6778.627175505395;6798.898016529756;6808.3659921618455;981.8281800684852;1004.9899501005043;1029.5933106422922;1034.4827586206898;1110.2949626986922;22604.660930086062;30362;30501.542476862865;30946.845265773976;31329;1142.3716955674347;1148.9482973266222;1170.145793570698;1171.4494187731752;1222.3155033181447;13190.73618527624;15592.92203538975;16060.518184454486;16104.19479026044;16167.757483637755;540662;1033380;1039675;1059984;1063602;53403.19895201575;66245.66877165584;67036.6648166756;67191.66404167948;67443;1480.9337277160428;1545.51316335354;1576.5428025872368;1579.1946107485035;1581.043468701419;24458;32331.19172020718;32904.012879612696;32905.50641740328;33371.83314083414;55433.44566554283;56112.719436402556;56130.719346403006;56132;56200;497358;502921;505363;505766;505981;34519.13702157365;35219.647803521635;36196;36245;36301.63698363088;47126.82182945454;47258.29112563246;47379;47909.802254943905;48977;38389.80805095957;38773.22453550857;38936;39186.412203817534;39394.803025984686;38474.807625961694;38637;39227.607723922396;39246.4113038299;39569.406458902566;37609.623903761705;38050.8097459522;38509.4223586652;38732.61267387403;38890.02774930649;34297.65702342945;34634.82682586571;34831.82584087063;35079.82460087683;35084.473732893515;26458.470830583665;26541.33646658849;26662;26884;26951.46097078008 15:35:21 INFO - PROCESS | 1661 | |2;jquery.html;371.10008230042143;377.53374582390745;381.10250360401255;381.42404968497567;383.0958936908893;17919;18049.187786549603;20128.798712012875;20575.971201439945;22117.447063823412;12491.937540312309;15860.127692976881;21360.57278854422;21887.890560547174;21914.561708765854;5471.097268950628;5731;5731.885362292752;5751.964646363653;5763;4244.384564238184;5907.527397808187;6008.48927841134;6150.2927163376335;6163.1063495793305;6115.266168059839;6124.96937515314;6139.447449729523;6141.539384546155;6164;6674.899876501856;6761.830954226184;6762.053312536249;6823.351781580766;6826.795196144124;5522.723863806834;5829.47534721877;5886.558508111866;6000.249968753906;6028.638281703112;13894.930525347309;14155.716885662228;14198.290085495684;14215;24188.758112418825;2271.4775601611555;2273.6475846243693;2323.7211534615953;2349.7415284318713;2355.7173139223232;8474;10076.193904487624;10307.072363487247;11686.649400517997;15161.24193790317;1439.2587817274111;1685.6628674265196;1852.5090850924516;1855.6381505606412;1859.6466671332403;89351.55324223338;89542;90901;120617;123198.9999999991;11331.206815522999;11588.76822463546;11685.941570292094;11870.643880683594;11980.76038479243;14470.421183152766;14584.48954286616;14673.266336683124;14791.70416591662;14862.851371486364;8905.643774249087;8906.421082629608;9029.954850225708;9054.502002389932;9070.455772653662;9403.294752893424;9529.618815247451;9610.855837162448;9622.182114520345;9729.854052189223;4601.976990115028;4645;4646.907061858811;4668.299755036772;4703.3885594872445;1850.2783914273443;1938.3990962801295;1987.145527423193;2014.4560968538706;2033.4306394209646;875.8379699755566;970.6020531582018;977.9657711980046;986.921046316293;1129.88701129888;19842;20128.19487220524;20199.798002020085;20547;20555.38333849987;969.3941286695815;997.6857289953641;1017.2878984710584;1017.7353887989176;1038.382162613244;11131.276467029616;11149.72125696864;11313.604023859125;11333.979941805112;11381.658550243506;677774;687298;692970;698496;705214;125910;127650;131442;133090.00364994534;135325.32337338448;1046.1892033673964;1049.9422531760674;1068.2522234435926;1068.8770791358938;1072.0298130192189;18368.632627347644;18598.16308266104;18686.81313186905;18736.437906862815;19006.809931900505;51933;54753;55113;58391;58682.53293667692;75671.62164189144;76811.46377072316;78831.4233715334;79918.60040699992;83111.58444207741;9600.66397676078;12167.026637869127;12299.385030748248;12352.938235308766;12459.750804983669;12030.458629361874;14093.647658808612;14195.503157389441;14247.002709810215;14373;5569.136783798518;6470.9676451619325;11924.73430048288;12015.219010764273;12157.1489995703;11900;11941.522339106687;12024.699382515508;12060.457279422622;12313.50745970187;11775.52897884075;12162.452689629165;12206.084543659439;12278.938605306916;12305.323207223331;12073.335966521925;12093.455794489093;12218.144729868824;12299.569515066929;12304;12191.573294934635;12200.710788577466;12214.328211948428;12316.692082698004;12357.505699771908 15:35:21 INFO - PROCESS | 1661 | |3;mootools.html;1590.3479573374916;1663.742119971404;2004.3285499357714;2082.9166833326667;2093.947651308717;8269.586520673958;8813.427127236726;8936.955315223422;9138.862917056249;9140.223081038112;8897.021327653969;8960.193582577567;9007.459552426859;9012.324075694332;9039.00570937198;2145.5387091775265;2541.4027703489755;2544.6437498750142;2584.883680234394;2585.5475291823855;2526.090607381341;2596.208156512263;2599.2462185966046;2637.2483842105003;2647.9602805957925;2571.4342844574257;2578.6776652918384;2585.3536615846037;2602.4925139597785;2609.765121139097;2577.252596746932;2594;2597.0261152067974;2607.9869600652064;2613.0331777242445;2598.246508512529;2618.56793629051;2627.5270451318756;2636.2091372588147;2640.115561286971;9066;9113.270938324918;9121;9131.726048218565;9180.219681327095;5637.267155269829;5689.573282003867;5692.459216374479;5701.2018317435595;5786.739596718157;3642.25333806569;3722.7207959403154;3724.888253352404;3776.093737503007;3790.7156963227594;1041.141058626636;1062.33073163907;1070.6829704742083;1071.539238127605;1104.4256986367125;11841.171118021655;11885;12052.698682532919;12157;12241.20432171906;4995.450500444948;5039.672421292605;5142.9742851286255;5158.071547121479;5161.458046905096;10385.740356491147;10402.375857448576;10539.683809485728;10572.735681608021;10597.4701264938;4959.553640172402;5720.599558030898;5723.427657234327;5804.216430781875;5805.187273781674;4613.930791038137;4999.675021123688;5095.643304968617;5122.385313762373;5260.736963151904;3285.4743241081314;3982.3230050891416;4042.6765858731233;4045.2516284486874;4060.553339132693;1163.9359835208975;1375.5048182654236;1376.6420730609914;1378.1730961423066;1379.489588852111;1375.8005089262;1404.676924307415;1406.3249640172774;1417.3126033873564;1418.269591160553;7942.682292708342;8081.0706768721175;8117.350611951148;8171.182881711781;8302.8339433211;538.7440965541336;543.4456854008968;1297.5588299978053;1369.397465115346;1377.1324065838658;6463.127477790438;6483.124778154889;6518.804435866931;6544.214694236722;6576.1122248496795;10518.579256829642;10686.305390149615;10793.730156746144;10827.83758243627;11004.614838480775;10652.414117223627;10728.89271107279;10735.83896241557;10742.892571074346;10815.621453249256;8383.538905360141;8385.538795366192;8412.411131220755;8522.147785221428;8539.573021348908;8262.628181731956;8313.625886834985;8373.581320933807;8412.369072319478;8461.365397595328;9394.81210375775;9686.225101991682;9798.216142708423;9829.213662907094;9941.552630131517;9584.808303833745;9794.510274486389;9805.656802011896;9990.450525221182;10014.248931330034;6947.965260173667;7224.422046236394;7402.148752893486;7560.432967527568;7699.422543309386;8241.175882411711;8373.66505339804;8386.874196887173;8422.368322375969;8425.157484251771;7320.304571065741;7399.408047356091;7524.360429363565;7618.8095297618;7671.424643151674;7382.335589796944;7402.33378995893;7437.0331856858265;7461.925380746123;7506.061742282215;7469.663865126191;7868.622990976671;7882.5270483771155;7889.447738658238;7930.643121059682;5924.940750592611;6123.8162855114415;7067.434605231466;7141.321574450419;7194.96402518005;6597.241317248578;7304.452166087458;7371.705131794883;7379.557226566209;7426.220246874001 15:35:21 INFO - PROCESS | 1661 | |4;prototype.html;334.8041395783467;337.4651177883055;341.47072038340565;342.4845607360923;343.7164339419978;6906.689198986045;6940.861182776348;6950.8262293442685;6990.580565166094;7008.36924676779;5548.750306236219;6928.61892595907;6942.791716248508;6947.478939079564;6984.546004509703;4910.75446227689;4972.502749725035;5076.213186956009;5091.338126043609;5151.45909679483;4538.7503687297185;4968.87577810554;5045.84862454127;5067.214581739836;5132.846014619548;4087.202995415895;4631.471614367268;4746.5490778376;5068.518490743373;5081.949180508184;4579.656525760548;4633.930491042637;5088.058709138802;5100.795968161269;5125;4381.145676593065;4386.6929314947965;4392.9896123891685;4417.271150260203;4419;6327.3988971047675;6621.867562648768;6633.6683165842;6650.301718319555;6683.2648408675;5130.9230361544605;5543.614096475881;5948.762049518057;5954.672493012882;5983.982722937111;7356.411487081021;7371.336579707799;7376.225496322862;7378.667959941816;7399.408047356199;4781.426228852525;4786.569208771228;4788.904221915543;4791.832285869978;4808.326834243208;7007.159140903124;7347.33873951347;7709.498882572615;7729.884051739228;7810.531368117931;4625.468071171791;4708.505606911225;4766.952330476651;4778.904421911542;4784.952150478521;4876.756162191876;4898.583620392235;4933.383327084114;4959.380077490314;4972.7513624318635;5954.136650185786;5962.731677074542;5964.7315870785915;5970.492508136857;5988.6706231157705;7390.408767298603;7402;7404.925950740424;7405.222451642608;7412.555246685216;1643.1127191316555;1693.678201141779;1722.1475369692082;1722.2077844191563;1724.04315604838;1063.2663462211049;1084.788466249074;1085.1481586954203;1091.3724608350071;1092.6995076354067;6781.321867813278;6792.728290868409;6845.110135682329;6889.866080351849;6957.860842783116;7623.275788800055;7630.580318082448;7631;7635.503692259986;7661.46369754123;5622.971885140548;5663.490285874209;6887.242403335629;6953.061336719579;6987.567548652514;3756.1173124315765;4022.35642297231;4047.8785636430953;4052.5744796796503;4061.6547593454297;7685.846283074307;7701.730439434593;7851.842963140705;7922.445428820042;7998.080220774686;7970.561619110888;7994.840748091494;8000.119986801447;8002.839943201104;8014;7916.485428447132;7938.364930805522;7942.3646108311195;7958.6418611162635;7980.162082981204;7415.480916335805;7692.846143076995;7705.42209334291;7763;7789.104253010976;6145.569810113428;6769.458443324424;7556.811079723051;7587.596294685501;7622.504537205064;7914.920850791418;7948.085970113511;7955.960220198862;7978.401619878417;8004.679812807422;3851.306764782366;4820.204666230033;4871.3423687803115;4878.414590249193;4924.310596516419;7361.374283185989;7696.692132314644;7709.036370453693;7711.38308935295;7742.187070357531;7398.852022959618;7422.851542969002;7437.293457121565;7447.329740323397;7457.552546847207;6322.272938612118;7404.370628496423;7442.441816863865;7445.143808462096;7453.627318634155;6995.370416662525;7225.747098851515;7248.710051597877;7255.165655949633;7276.126864776261;7378.852422951403;7400.148982866824;7406.333429991327;7420.109586849612;7442.181360050282;7276.490645654965;7278.308560686726;7308.123025237006;7313.549960763204;7317.451191160791 15:35:21 INFO - PROCESS | 1661 | |5;yui.html;696;711.3349018667546;720.9387202087822;765.4947734495234;793.984120317594;15263.618409539768;15265.694686106272;15283.770743438858;15503.922480387582;15522.068675879442;13799;14078.296085195725;14134.293285335743;14158.29208539574;14172.929135354309;972.8248915195262;979.500454768068;1007.0483393193435;1008.8486726990974;1009.3338396658207;982.1995074014656;992.533509250651;1005.8290090684601;1006.783541538569;1010.7574182196294;900.7658008917696;1032.406366339354;1060.1677683018831;1060.4803646213338;1065.2436769893386;1014.8274793285159;1046.0951277145252;1052.9157667386592;1053.394298278493;1060.0724366179593;760.2549501488572;778.2723153851167;789.5973053742575;790.7864876483375;792.9246721561442;15622.609434764108;15667.2949717263;15676.843231567766;16030.679386412206;16114.838851611452;12742.61772146837;12861.614151575468;12925.741485170243;12998;13187.736245275137;10359.637412690596;10441.373517588969;10655.786884262348;10735.302205356627;10767.461626918623;3514.859405623772;3562.8040457774814;3592.281543691246;3594.11944073701;3665.6700896919406;89656.99999999935;90377.09622903753;90963;91205.54397228037;92089.53955230248;9486.667966621135;9600.519974001412;9653.90346096544;9687.2734544908;9983.900160998297;21206.93965301729;21897.890510547346;21977.560448790933;22102.784346860757;22104.557908842056;7834.334081603128;7909.209079092045;7950.3242224410415;7967.3626109911065;8035.196480352035;4147.854825081107;4193.266178418765;4355.2813785725;4424.358468022118;4476.060027394218;3661.2494438640015;3690.797006164633;3693.353663108945;3705.444183372516;3708.35103856824;606.6178307666142;671.4158681946737;672.7006482115412;676.5061505101205;676.7597502886503;581.1791192061858;621.8476473264079;637.4167636612448;645.0807599171162;646.5355968730828;8594.87107693385;8638.74083777475;8687.305015598737;8785.428947118417;8844.955775221211;621.7916997805695;622.7820262907946;626.1890851347425;643.0964494884695;650.6421468192475;3988.0428697112484;4037.8788636340955;4040.878773636796;4054.3310353791294;4087.182563487255;73126;91219.54390228007;91334.54332728294;94802.52598736962;96230;82135;82451;82690;84259;84783;69469;69774.3022569778;70425.81470414731;70569.64715176493;71934;6371.139896113966;6980.546264492792;7160.391366733886;7936.682532698858;8322.50064996102;34149.14627134242;44527;50584.747076264386;51365.7431712839;51793;64738;68990;70101.64949175222;70794;71590;10379.584816607252;11118;11213.775724485628;11388.772224555629;11795;12027;12169.81745273804;12227.205231659913;12596.496140154291;12655.303958282382;12173.87826121763;12240;12310.569130080405;12311.876881231432;12326.75346493083;12023.939880300542;12089.879101209228;12110.843998443635;12259.32573708419;12423.503059877503;11742.91036018712;11876.940615296868;11915.285082895054;12014.579489717818;12101.394930253276;9416.10546998034;9774.706758797247;9799.265055120752;9905.356151850106;9927.851082233918;9957.651482198089;9961.203103751537;9968.700938971842;9972.950135249277;10115.494225288854 15:35:21 INFO - PROCESS | 1661 | __end_tp_report 15:35:21 INFO - PROCESS | 1661 | __start_cc_report 15:35:21 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,344 15:35:21 INFO - PROCESS | 1661 | __end_cc_report 15:35:21 INFO - PROCESS | 1661 | __startTimestamp1461969320995__endTimestamp 15:35:21 INFO - PROCESS | 1661 | 15:35:21 INFO - PROCESS | 1661 | ------- Summary: start ------- 15:35:21 INFO - PROCESS | 1661 | Number of tests: 6 15:35:21 INFO - PROCESS | 1661 | 15:35:21 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5873.12 Median:6153.45 stddev:674.41 (11.0%) stddev-sans-first:653.39 15:35:21 INFO - PROCESS | 1661 | Values: 3643.1 3643.3 3678.8 3711.6 3713.6 5990.7 6007.5 6044.8 6050.5 6069.1 5930.0 5970.6 6036.5 6047.8 6059.9 5345.4 5391.9 5441.6 5472.8 5526.5 4433.0 5336.8 5442.5 5490.5 5491.4 5383.7 5402.3 5409.5 5436.9 5448.1 5412.4 5457.8 5467.7 5496.4 5540.6 4361.8 4547.5 4776.6 5198.7 5357.5 4996.8 5026.0 5288.5 5777.4 6016.9 6220.5 6243.3 6270.9 6275.5 6290.8 6365.0 6417.2 6421.5 6435.0 6445.3 6029.8 6070.9 6096.3 6130.9 6163.2 6501.2 6518.1 6524.4 6529.8 6547.1 6201.8 6236.2 6248.3 6251.3 6254.2 6264.9 6367.9 6451.9 6466.1 6483.4 5707.3 5821.3 6192.8 6254.9 6258.5 6208.0 6213.5 6269.9 6295.2 6296.9 4935.2 5051.9 5054.8 5056.5 5092.2 3883.4 4471.6 4492.8 4535.3 4554.8 6022.3 6096.5 6105.8 6120.6 6136.5 6239.4 6342.1 6345.5 6373.2 6402.3 6131.5 6143.1 6153.4 6178.3 6191.5 4638.4 5475.5 5574.9 5578.8 5599.4 6443.6 6495.9 6525.8 6526.2 6561.5 6398.1 6406.1 6408.3 6432.4 6446.8 6156.0 6468.6 6512.9 6525.0 6535.3 6315.8 6327.8 6331.1 6346.4 6348.2 6229.8 6367.4 6368.0 6373.6 6374.8 6056.8 6190.8 6211.4 6260.2 6291.8 5908.6 6178.5 6204.1 6246.3 6264.8 5743.2 5912.9 6103.4 6135.3 6140.7 6170.1 6186.1 6231.4 6259.7 6267.5 5148.0 5970.7 6232.1 6251.8 6280.8 15:35:21 INFO - PROCESS | 1661 | 15:35:21 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:72685.26 Median:35152.06 stddev:179342.60 (510.2%) stddev-sans-first:179763.73 15:35:21 INFO - PROCESS | 1661 | Values: 465.0 583.5 626.6 680.3 691.0 33390.7 34172.5 38316.7 39533.2 39807.6 40812.0 40916.8 41374.8 41759.8 41878.0 9655.7 9696.1 9784.8 9822.8 9825.2 9826.2 9978.4 9998.9 10001.0 10003.0 9949.5 9953.7 10003.7 10015.9 10038.3 9852.7 9874.6 9926.3 10015.3 10036.9 9862.2 9912.8 10007.4 10039.7 10066.7 34372.0 40465.6 40596.8 40829.8 40949.6 3199.1 3355.7 3383.3 3441.9 3559.9 27941.6 28007.3 28582.6 29020.4 29332.7 2608.0 2760.3 2835.7 2849.2 2924.9 340528.3 340887.0 342646.0 342998.0 343535.0 47844.0 48277.8 48462.3 71557.3 72560.6 47002.8 48071.3 48140.0 48157.0 48355.0 17686.0 17694.7 17892.5 17913.5 17926.1 14231.8 14300.9 14362.6 14368.6 14468.4 12591.7 15691.5 15725.9 15777.4 15894.9 6645.1 6777.1 6778.6 6798.9 6808.4 981.8 1005.0 1029.6 1034.5 1110.3 22604.7 30362.0 30501.5 30946.8 31329.0 1142.4 1148.9 1170.1 1171.4 1222.3 13190.7 15592.9 16060.5 16104.2 16167.8 540662.0 1033380.0 1039675.0 1059984.0 1063602.0 53403.2 66245.7 67036.7 67191.7 67443.0 1480.9 1545.5 1576.5 1579.2 1581.0 24458.0 32331.2 32904.0 32905.5 33371.8 55433.4 56112.7 56130.7 56132.0 56200.0 497358.0 502921.0 505363.0 505766.0 505981.0 34519.1 35219.6 36196.0 36245.0 36301.6 47126.8 47258.3 47379.0 47909.8 48977.0 38389.8 38773.2 38936.0 39186.4 39394.8 38474.8 38637.0 39227.6 39246.4 39569.4 37609.6 38050.8 38509.4 38732.6 38890.0 34297.7 34634.8 34831.8 35079.8 35084.5 26458.5 26541.3 26662.0 26884.0 26951.5 15:35:21 INFO - PROCESS | 1661 | 15:35:21 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:37482.22 Median:11071.63 stddev:114568.82 (1034.8%) stddev-sans-first:114856.32 15:35:21 INFO - PROCESS | 1661 | Values: 371.1 377.5 381.1 381.4 383.1 17919.0 18049.2 20128.8 20576.0 22117.4 12491.9 15860.1 21360.6 21887.9 21914.6 5471.1 5731.0 5731.9 5752.0 5763.0 4244.4 5907.5 6008.5 6150.3 6163.1 6115.3 6125.0 6139.4 6141.5 6164.0 6674.9 6761.8 6762.1 6823.4 6826.8 5522.7 5829.5 5886.6 6000.2 6028.6 13894.9 14155.7 14198.3 14215.0 24188.8 2271.5 2273.6 2323.7 2349.7 2355.7 8474.0 10076.2 10307.1 11686.6 15161.2 1439.3 1685.7 1852.5 1855.6 1859.6 89351.6 89542.0 90901.0 120617.0 123199.0 11331.2 11588.8 11685.9 11870.6 11980.8 14470.4 14584.5 14673.3 14791.7 14862.9 8905.6 8906.4 9030.0 9054.5 9070.5 9403.3 9529.6 9610.9 9622.2 9729.9 4602.0 4645.0 4646.9 4668.3 4703.4 1850.3 1938.4 1987.1 2014.5 2033.4 875.8 970.6 978.0 986.9 1129.9 19842.0 20128.2 20199.8 20547.0 20555.4 969.4 997.7 1017.3 1017.7 1038.4 11131.3 11149.7 11313.6 11334.0 11381.7 677774.0 687298.0 692970.0 698496.0 705214.0 125910.0 127650.0 131442.0 133090.0 135325.3 1046.2 1049.9 1068.3 1068.9 1072.0 18368.6 18598.2 18686.8 18736.4 19006.8 51933.0 54753.0 55113.0 58391.0 58682.5 75671.6 76811.5 78831.4 79918.6 83111.6 9600.7 12167.0 12299.4 12352.9 12459.8 12030.5 14093.6 14195.5 14247.0 14373.0 5569.1 6471.0 11924.7 12015.2 12157.1 11900.0 11941.5 12024.7 12060.5 12313.5 11775.5 12162.5 12206.1 12278.9 12305.3 12073.3 12093.5 12218.1 12299.6 12304.0 12191.6 12200.7 12214.3 12316.7 12357.5 15:35:21 INFO - PROCESS | 1661 | 15:35:21 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:6196.41 Median:541.09 stddev:3213.14 (593.8%) stddev-sans-first:3203.50 15:35:21 INFO - PROCESS | 1661 | Values: 1590.3 1663.7 2004.3 2082.9 2093.9 8269.6 8813.4 8937.0 9138.9 9140.2 8897.0 8960.2 9007.5 9012.3 9039.0 2145.5 2541.4 2544.6 2584.9 2585.5 2526.1 2596.2 2599.2 2637.2 2648.0 2571.4 2578.7 2585.4 2602.5 2609.8 2577.3 2594.0 2597.0 2608.0 2613.0 2598.2 2618.6 2627.5 2636.2 2640.1 9066.0 9113.3 9121.0 9131.7 9180.2 5637.3 5689.6 5692.5 5701.2 5786.7 3642.3 3722.7 3724.9 3776.1 3790.7 1041.1 1062.3 1070.7 1071.5 1104.4 11841.2 11885.0 12052.7 12157.0 12241.2 4995.5 5039.7 5143.0 5158.1 5161.5 10385.7 10402.4 10539.7 10572.7 10597.5 4959.6 5720.6 5723.4 5804.2 5805.2 4613.9 4999.7 5095.6 5122.4 5260.7 3285.5 3982.3 4042.7 4045.3 4060.6 1163.9 1375.5 1376.6 1378.2 1379.5 1375.8 1404.7 1406.3 1417.3 1418.3 7942.7 8081.1 8117.4 8171.2 8302.8 538.7 543.4 1297.6 1369.4 1377.1 6463.1 6483.1 6518.8 6544.2 6576.1 10518.6 10686.3 10793.7 10827.8 11004.6 10652.4 10728.9 10735.8 10742.9 10815.6 8383.5 8385.5 8412.4 8522.1 8539.6 8262.6 8313.6 8373.6 8412.4 8461.4 9394.8 9686.2 9798.2 9829.2 9941.6 9584.8 9794.5 9805.7 9990.5 10014.2 6948.0 7224.4 7402.1 7560.4 7699.4 8241.2 8373.7 8386.9 8422.4 8425.2 7320.3 7399.4 7524.4 7618.8 7671.4 7382.3 7402.3 7437.0 7461.9 7506.1 7469.7 7868.6 7882.5 7889.4 7930.6 5924.9 6123.8 7067.4 7141.3 7195.0 6597.2 7304.5 7371.7 7379.6 7426.2 15:35:21 INFO - PROCESS | 1661 | 15:35:21 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:6002.91 Median:6898.28 stddev:1949.73 (28.3%) stddev-sans-first:1908.22 15:35:21 INFO - PROCESS | 1661 | Values: 334.8 337.5 341.5 342.5 343.7 6906.7 6940.9 6950.8 6990.6 7008.4 5548.8 6928.6 6942.8 6947.5 6984.5 4910.8 4972.5 5076.2 5091.3 5151.5 4538.8 4968.9 5045.8 5067.2 5132.8 4087.2 4631.5 4746.5 5068.5 5081.9 4579.7 4633.9 5088.1 5100.8 5125.0 4381.1 4386.7 4393.0 4417.3 4419.0 6327.4 6621.9 6633.7 6650.3 6683.3 5130.9 5543.6 5948.8 5954.7 5984.0 7356.4 7371.3 7376.2 7378.7 7399.4 4781.4 4786.6 4788.9 4791.8 4808.3 7007.2 7347.3 7709.5 7729.9 7810.5 4625.5 4708.5 4767.0 4778.9 4785.0 4876.8 4898.6 4933.4 4959.4 4972.8 5954.1 5962.7 5964.7 5970.5 5988.7 7390.4 7402.0 7404.9 7405.2 7412.6 1643.1 1693.7 1722.1 1722.2 1724.0 1063.3 1084.8 1085.1 1091.4 1092.7 6781.3 6792.7 6845.1 6889.9 6957.9 7623.3 7630.6 7631.0 7635.5 7661.5 5623.0 5663.5 6887.2 6953.1 6987.6 3756.1 4022.4 4047.9 4052.6 4061.7 7685.8 7701.7 7851.8 7922.4 7998.1 7970.6 7994.8 8000.1 8002.8 8014.0 7916.5 7938.4 7942.4 7958.6 7980.2 7415.5 7692.8 7705.4 7763.0 7789.1 6145.6 6769.5 7556.8 7587.6 7622.5 7914.9 7948.1 7956.0 7978.4 8004.7 3851.3 4820.2 4871.3 4878.4 4924.3 7361.4 7696.7 7709.0 7711.4 7742.2 7398.9 7422.9 7437.3 7447.3 7457.6 6322.3 7404.4 7442.4 7445.1 7453.6 6995.4 7225.7 7248.7 7255.2 7276.1 7378.9 7400.1 7406.3 7420.1 7442.2 7276.5 7278.3 7308.1 7313.5 7317.5 15:35:21 INFO - PROCESS | 1661 | 15:35:21 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:18799.04 Median:24475.68 stddev:26530.41 (108.4%) stddev-sans-first:26570.02 15:35:21 INFO - PROCESS | 1661 | Values: 696.0 711.3 720.9 765.5 794.0 15263.6 15265.7 15283.8 15503.9 15522.1 13799.0 14078.3 14134.3 14158.3 14172.9 972.8 979.5 1007.0 1008.8 1009.3 982.2 992.5 1005.8 1006.8 1010.8 900.8 1032.4 1060.2 1060.5 1065.2 1014.8 1046.1 1052.9 1053.4 1060.1 760.3 778.3 789.6 790.8 792.9 15622.6 15667.3 15676.8 16030.7 16114.8 12742.6 12861.6 12925.7 12998.0 13187.7 10359.6 10441.4 10655.8 10735.3 10767.5 3514.9 3562.8 3592.3 3594.1 3665.7 89657.0 90377.1 90963.0 91205.5 92089.5 9486.7 9600.5 9653.9 9687.3 9983.9 21206.9 21897.9 21977.6 22102.8 22104.6 7834.3 7909.2 7950.3 7967.4 8035.2 4147.9 4193.3 4355.3 4424.4 4476.1 3661.2 3690.8 3693.4 3705.4 3708.4 606.6 671.4 672.7 676.5 676.8 581.2 621.8 637.4 645.1 646.5 8594.9 8638.7 8687.3 8785.4 8845.0 621.8 622.8 626.2 643.1 650.6 3988.0 4037.9 4040.9 4054.3 4087.2 73126.0 91219.5 91334.5 94802.5 96230.0 82135.0 82451.0 82690.0 84259.0 84783.0 69469.0 69774.3 70425.8 70569.6 71934.0 6371.1 6980.5 7160.4 7936.7 8322.5 34149.1 44527.0 50584.7 51365.7 51793.0 64738.0 68990.0 70101.6 70794.0 71590.0 10379.6 11118.0 11213.8 11388.8 11795.0 12027.0 12169.8 12227.2 12596.5 12655.3 12173.9 12240.0 12310.6 12311.9 12326.8 12023.9 12089.9 12110.8 12259.3 12423.5 11742.9 11876.9 11915.3 12014.6 12101.4 9416.1 9774.7 9799.3 9905.4 9927.9 9957.7 9961.2 9968.7 9973.0 10115.5 15:35:21 INFO - PROCESS | 1661 | -------- Summary: end -------- 15:35:21 INFO - PROCESS | 1661 | 15:35:21 INFO - TEST-INFO | 1661: exit 0 15:35:21 INFO - TEST-OK | dromaeo_css | took 1109123ms 15:35:21 INFO - TEST-START | kraken 15:35:21 INFO - operating with platform_type : mac_ 15:35:21 INFO - Initialising browser for kraken test... 15:35:21 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpdSLkcb/profile http://localhost:49278/getInfo.html) 15:35:23 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 15:35:23 INFO - PROCESS | 1674 | colorDepth:24 15:35:23 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 15:35:23 INFO - PROCESS | 1674 | __metrics 15:35:24 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:35:24 INFO - TEST-INFO | 1674: exit 0 15:35:24 INFO - Browser initialized. 15:35:24 INFO - Running cycle 1/1 for kraken test... 15:35:24 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpdSLkcb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:35:36 INFO - PROCESS | 1678 | RSS: Main: 168108032 15:35:36 INFO - PROCESS | 1678 | 15:35:39 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 15:35:39 INFO - PROCESS | 1678 | RSS: Main: 180318208 15:35:39 INFO - PROCESS | 1678 | 15:35:42 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 15:35:42 INFO - PROCESS | 1678 | RSS: Main: 189304832 15:35:42 INFO - PROCESS | 1678 | 15:35:46 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 15:35:46 INFO - PROCESS | 1678 | RSS: Main: 192425984 15:35:46 INFO - PROCESS | 1678 | 15:35:48 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 15:35:49 INFO - PROCESS | 1678 | RSS: Main: 192737280 15:35:49 INFO - PROCESS | 1678 | 15:35:51 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:35:51 INFO - PROCESS | 1678 | RSS: Main: 194273280 15:35:51 INFO - PROCESS | 1678 | 15:35:54 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 15:35:55 INFO - PROCESS | 1678 | RSS: Main: 195375104 15:35:55 INFO - PROCESS | 1678 | 15:35:58 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 15:35:58 INFO - PROCESS | 1678 | RSS: Main: 194801664 15:35:58 INFO - PROCESS | 1678 | 15:36:01 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 15:36:02 INFO - PROCESS | 1678 | RSS: Main: 195198976 15:36:02 INFO - PROCESS | 1678 | 15:36:03 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:36:04 INFO - PROCESS | 1678 | RSS: Main: 194535424 15:36:04 INFO - PROCESS | 1678 | 15:36:06 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:36:06 INFO - PROCESS | 1678 | RSS: Main: 194899968 15:36:06 INFO - PROCESS | 1678 | 15:36:08 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:36:09 INFO - PROCESS | 1678 | RSS: Main: 195088384 15:36:09 INFO - PROCESS | 1678 | 15:36:12 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:36:12 INFO - PROCESS | 1678 | RSS: Main: 195203072 15:36:12 INFO - PROCESS | 1678 | 15:36:15 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:36:15 INFO - PROCESS | 1678 | RSS: Main: 195260416 15:36:15 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 15:36:17 INFO - PROCESS | 1678 | RSS: Main: 196288512 15:36:17 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | __start_tp_report 15:36:17 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 15:36:17 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 15:36:17 INFO - PROCESS | 1678 | |i|pagename|runs| 15:36:17 INFO - PROCESS | 1678 | |0;ai-astar;115;111;115;118;116;127;118;96;169;168 15:36:17 INFO - PROCESS | 1678 | |1;audio-beat-detection;149;117;152;150;145;169;141;122;187;120 15:36:17 INFO - PROCESS | 1678 | |2;audio-dft;195;192;197;203;193;192;193;191;201;195 15:36:17 INFO - PROCESS | 1678 | |3;audio-fft;65;76;71;108;59;64;82;88;157;56 15:36:17 INFO - PROCESS | 1678 | |4;audio-oscillator;87;79;122;78;82;79;119;78;80;118 15:36:17 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;89;86;88;86;104;114;90;90;88;85 15:36:17 INFO - PROCESS | 1678 | |6;imaging-darkroom;114;150;94;95;94;93;94;94;95;93 15:36:17 INFO - PROCESS | 1678 | |7;imaging-desaturate;138;145;93;115;123;90;93;92;92;91 15:36:17 INFO - PROCESS | 1678 | |8;json-parse-financial;55;58;59;59;60;57;60;66;56;52 15:36:17 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;63;64;68;65;76;74;68;64;62;86 15:36:17 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;83;83;82;85;80;83;103;111;110;116 15:36:17 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;124;141;140;127;131;135;132;136;137;124 15:36:17 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;134;136;157;177;174;124;134;172;171;173 15:36:17 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;66;67;67;66;67;66;74;62;84;88 15:36:17 INFO - PROCESS | 1678 | __end_tp_report 15:36:17 INFO - PROCESS | 1678 | __start_cc_report 15:36:17 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,902 15:36:17 INFO - PROCESS | 1678 | __end_cc_report 15:36:17 INFO - PROCESS | 1678 | __startTimestamp1461969377917__endTimestamp 15:36:17 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | ------- Summary: start ------- 15:36:17 INFO - PROCESS | 1678 | Number of tests: 14 15:36:17 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:125.30 Median:122.50 stddev:24.05 (19.6%) stddev-sans-first:25.21 15:36:17 INFO - PROCESS | 1678 | Values: 115.0 111.0 115.0 118.0 116.0 127.0 118.0 96.0 169.0 168.0 15:36:17 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:149.50 stddev:22.07 (14.8%) stddev-sans-first:23.37 15:36:17 INFO - PROCESS | 1678 | Values: 149.0 117.0 152.0 150.0 145.0 169.0 141.0 122.0 187.0 120.0 15:36:17 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:195.20 Median:195.00 stddev:4.02 (2.1%) stddev-sans-first:4.27 15:36:17 INFO - PROCESS | 1678 | Values: 195.0 192.0 197.0 203.0 193.0 192.0 193.0 191.0 201.0 195.0 15:36:17 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:82.60 Median:68.00 stddev:30.38 (44.7%) stddev-sans-first:31.55 15:36:17 INFO - PROCESS | 1678 | Values: 65.0 76.0 71.0 108.0 59.0 64.0 82.0 88.0 157.0 56.0 15:36:17 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:79.00 stddev:19.16 (24.3%) stddev-sans-first:20.23 15:36:17 INFO - PROCESS | 1678 | Values: 87.0 79.0 122.0 78.0 82.0 79.0 119.0 78.0 80.0 118.0 15:36:17 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:92.00 Median:88.00 stddev:9.42 (10.7%) stddev-sans-first:9.92 15:36:17 INFO - PROCESS | 1678 | Values: 89.0 86.0 88.0 86.0 104.0 114.0 90.0 90.0 88.0 85.0 15:36:17 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:101.60 Median:94.00 stddev:18.14 (19.3%) stddev-sans-first:18.68 15:36:17 INFO - PROCESS | 1678 | Values: 114.0 150.0 94.0 95.0 94.0 93.0 94.0 94.0 95.0 93.0 15:36:17 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:107.20 Median:91.50 stddev:21.37 (23.4%) stddev-sans-first:19.55 15:36:17 INFO - PROCESS | 1678 | Values: 138.0 145.0 93.0 115.0 123.0 90.0 93.0 92.0 92.0 91.0 15:36:17 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:59.00 stddev:3.71 (6.3%) stddev-sans-first:3.75 15:36:17 INFO - PROCESS | 1678 | Values: 55.0 58.0 59.0 59.0 60.0 57.0 60.0 66.0 56.0 52.0 15:36:17 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:68.00 stddev:7.57 (11.1%) stddev-sans-first:7.71 15:36:17 INFO - PROCESS | 1678 | Values: 63.0 64.0 68.0 65.0 76.0 74.0 68.0 64.0 62.0 86.0 15:36:17 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:93.60 Median:82.50 stddev:14.50 (17.6%) stddev-sans-first:14.86 15:36:17 INFO - PROCESS | 1678 | Values: 83.0 83.0 82.0 85.0 80.0 83.0 103.0 111.0 110.0 116.0 15:36:17 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:135.50 stddev:6.18 (4.6%) stddev-sans-first:5.70 15:36:17 INFO - PROCESS | 1678 | Values: 124.0 141.0 140.0 127.0 131.0 135.0 132.0 136.0 137.0 124.0 15:36:17 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:171.50 stddev:20.87 (12.2%) stddev-sans-first:20.68 15:36:17 INFO - PROCESS | 1678 | Values: 134.0 136.0 157.0 177.0 174.0 124.0 134.0 172.0 171.0 173.0 15:36:17 INFO - PROCESS | 1678 | 15:36:17 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:67.00 stddev:8.63 (12.9%) stddev-sans-first:8.98 15:36:17 INFO - PROCESS | 1678 | Values: 66.0 67.0 67.0 66.0 67.0 66.0 74.0 62.0 84.0 88.0 15:36:17 INFO - PROCESS | 1678 | -------- Summary: end -------- 15:36:17 INFO - PROCESS | 1678 | 15:36:18 INFO - TEST-INFO | 1678: exit 0 15:36:18 INFO - TEST-OK | kraken | took 57224ms 15:36:18 INFO - SUITE-END | took 1166s 15:36:19 INFO - Completed test suite (00:19:26) 15:36:19 INFO - javascript benchmark 15:36:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3643.0710168906926, 3643.3077715234103, 3678.8160591970395, 3711.6288371162877, 3713.647203515665, 5990.700464976756, 6007.48936340411, 6044.788432404866, 6050.515958723303, 6069.059295809146, 5930.0, 5970.552208584352, 6036.456718895299, 6047.818565443033, 6059.939400605993, 5345.385280692712, 5391.919121213165, 5441.564674826004, 5472.835814925558, 5526.530244929186, 4433.0, 5336.8132115375965, 5442.510174084332, 5490.450954904518, 5491.368492623359, 5383.730813459331, 5402.270693456372, 5409.540189083933, 5436.945630543683, 5448.128299472085, 5412.404635490093, 5457.808976685797, 5467.6719396835915, 5496.367917689457, 5540.63985840921, 4361.803718832628, 4547.454305483363, 4776.590905682832, 5198.662086964335, 5357.544608708265, 4996.7501624918605, 5026.0, 5288.497592728685, 5777.364489906149, 6016.909746353808, 6220.47125994291, 6243.2508099027955, 6270.937290627081, 6275.529335299825, 6290.811275661737, 6364.968175159141, 6417.197850268716, 6421.51838612106, 6435.0, 6445.258795238561, 6029.8191054268445, 6070.939290607126, 6096.298925623521, 6130.948521380002, 6163.19878415803, 6501.2198536175965, 6518.087467754518, 6524.412802847766, 6529.804105876831, 6547.116139321226, 6201.782937597162, 6236.18929539157, 6248.343923888017, 6251.28110267316, 6254.186955695731, 6264.9373506265265, 6367.872642547123, 6451.935480645134, 6466.094746735461, 6483.384078512534, 5707.258056452718, 5821.27234095738, 6192.752289908443, 6254.906176407358, 6258.499320054385, 6208.0, 6213.502919766408, 6269.905951410732, 6295.213098362705, 6296.937030629635, 4935.21036634144, 5051.87370315745, 5054.848354549369, 5056.469070747518, 5092.159793634083, 3883.3980732986433, 4471.575200355961, 4492.842750503717, 4535.274356103007, 4554.772261386917, 6022.337542870281, 6096.512279017668, 6105.755769769159, 6120.632762034292, 6136.539759518054, 6239.438450539473, 6342.112104305401, 6345.460635845912, 6373.235211774617, 6402.295747467775, 6131.478824299985, 6143.078538219303, 6153.446189842935, 6178.258608966953, 6191.473724733358, 4638.443386793607, 5475.534579560782, 5574.888502229933, 5578.832635020955, 5599.412061733541, 6443.613383197023, 6495.935040649533, 6525.804225873231, 6526.216853977458, 6561.507886908596, 6398.104265402941, 6406.13517175194, 6408.263049749338, 6432.3567643237175, 6446.806595802133, 6156.0, 6468.611883287018, 6512.902306465501, 6524.9673751630935, 6535.346465353617, 6315.810525684236, 6327.778527751507, 6331.113644089739, 6346.397092276226, 6348.206474190726, 6229.750809967732, 6367.395097465734, 6368.0, 6373.5857169283845, 6374.776882809079, 6056.788012419544, 6190.783322583688, 6211.409916057967, 6260.186175797117, 6291.811245662638, 5908.645481271137, 6178.5366097543765, 6204.069389591597, 6246.281677606951, 6264.812055638338, 5743.167240750151, 5912.881742365043, 6103.42017508336, 6135.294441139326, 6140.662263575547, 6170.074488826712, 6186.133941248138, 6231.376862313732, 6259.749610015549, 6267.529935254783, 5148.0, 5970.701464926823, 6232.065190221503, 6251.78118765841, 6280.780172693934], "unit": "score", "name": "dojo.html", "value": 5831.611361466479}, {"lowerIsBetter": false, "replicates": [465.039693033885, 583.4777873802947, 626.639682182745, 680.2687111355293, 691.0463560286805, 33390.66609333906, 34172.48741268883, 38316.658916937915, 39533.20933581327, 39807.60192398079, 40812.0, 40916.79541602295, 41374.75875723726, 41759.79120104403, 41878.0, 9655.710328690133, 9696.12734853863, 9784.755381115458, 9822.803543929118, 9825.150706295202, 9826.16477599405, 9978.401295922231, 9998.900010999869, 10000.999900010014, 10003.0, 9949.452780097092, 9953.701388958343, 10003.749906252366, 10015.89984100157, 10038.297319187659, 9852.655157069505, 9874.60501579936, 9926.25553083518, 10015.298929074968, 10036.899631003706, 9862.161716254128, 9912.752181195456, 10007.399556026661, 10039.698809035668, 10066.748331291703, 34372.0, 40465.59534404677, 40596.79701601473, 40829.795851020855, 40949.59050409488, 3199.1362332170183, 3355.7147642450423, 3383.2556837495713, 3441.896743097711, 3559.946600800964, 27941.580876286873, 28007.29981750452, 28582.571261431094, 29020.41959160805, 29332.70667293321, 2608.0480624572083, 2760.254731222559, 2835.702251263608, 2849.216465472012, 2924.8683809228637, 340528.2973585141, 340887.0, 342646.0, 342998.0, 343535.0, 47844.0, 48277.75861120742, 48462.27306590404, 71557.28442715506, 72560.63719681473, 47002.76498617485, 48071.278930816065, 48140.0, 48157.0, 48355.0, 17686.0, 17694.734578981326, 17892.46322610324, 17913.462596122135, 17926.103694815207, 14231.78652320216, 14300.856991429953, 14362.640933976525, 14368.568942931728, 14468.421263149567, 12591.748165036648, 15691.450799221973, 15725.921370393075, 15777.447789327318, 15894.887357885069, 6645.102911106938, 6777.085093512412, 6778.627175505395, 6798.898016529756, 6808.3659921618455, 981.8281800684852, 1004.9899501005043, 1029.5933106422922, 1034.4827586206898, 1110.2949626986922, 22604.660930086062, 30362.0, 30501.542476862865, 30946.845265773976, 31329.0, 1142.3716955674347, 1148.9482973266222, 1170.145793570698, 1171.4494187731752, 1222.3155033181447, 13190.73618527624, 15592.92203538975, 16060.518184454486, 16104.19479026044, 16167.757483637755, 540662.0, 1033380.0, 1039675.0, 1059984.0, 1063602.0, 53403.19895201575, 66245.66877165584, 67036.6648166756, 67191.66404167948, 67443.0, 1480.9337277160428, 1545.51316335354, 1576.5428025872368, 1579.1946107485035, 1581.043468701419, 24458.0, 32331.19172020718, 32904.012879612696, 32905.50641740328, 33371.83314083414, 55433.44566554283, 56112.719436402556, 56130.719346403006, 56132.0, 56200.0, 497358.0, 502921.0, 505363.0, 505766.0, 505981.0, 34519.13702157365, 35219.647803521635, 36196.0, 36245.0, 36301.63698363088, 47126.82182945454, 47258.29112563246, 47379.0, 47909.802254943905, 48977.0, 38389.80805095957, 38773.22453550857, 38936.0, 39186.412203817534, 39394.803025984686, 38474.807625961694, 38637.0, 39227.607723922396, 39246.4113038299, 39569.406458902566, 37609.623903761705, 38050.8097459522, 38509.4223586652, 38732.61267387403, 38890.02774930649, 34297.65702342945, 34634.82682586571, 34831.82584087063, 35079.82460087683, 35084.473732893515, 26458.470830583665, 26541.33646658849, 26662.0, 26884.0, 26951.46097078008], "unit": "score", "name": "ext.html", "value": 20207.16210615148}, {"lowerIsBetter": false, "replicates": [371.10008230042143, 377.53374582390745, 381.10250360401255, 381.42404968497567, 383.0958936908893, 17919.0, 18049.187786549603, 20128.798712012875, 20575.971201439945, 22117.447063823412, 12491.937540312309, 15860.127692976881, 21360.57278854422, 21887.890560547174, 21914.561708765854, 5471.097268950628, 5731.0, 5731.885362292752, 5751.964646363653, 5763.0, 4244.384564238184, 5907.527397808187, 6008.48927841134, 6150.2927163376335, 6163.1063495793305, 6115.266168059839, 6124.96937515314, 6139.447449729523, 6141.539384546155, 6164.0, 6674.899876501856, 6761.830954226184, 6762.053312536249, 6823.351781580766, 6826.795196144124, 5522.723863806834, 5829.47534721877, 5886.558508111866, 6000.249968753906, 6028.638281703112, 13894.930525347309, 14155.716885662228, 14198.290085495684, 14215.0, 24188.758112418825, 2271.4775601611555, 2273.6475846243693, 2323.7211534615953, 2349.7415284318713, 2355.7173139223232, 8474.0, 10076.193904487624, 10307.072363487247, 11686.649400517997, 15161.24193790317, 1439.2587817274111, 1685.6628674265196, 1852.5090850924516, 1855.6381505606412, 1859.6466671332403, 89351.55324223338, 89542.0, 90901.0, 120617.0, 123198.9999999991, 11331.206815522999, 11588.76822463546, 11685.941570292094, 11870.643880683594, 11980.76038479243, 14470.421183152766, 14584.48954286616, 14673.266336683124, 14791.70416591662, 14862.851371486364, 8905.643774249087, 8906.421082629608, 9029.954850225708, 9054.502002389932, 9070.455772653662, 9403.294752893424, 9529.618815247451, 9610.855837162448, 9622.182114520345, 9729.854052189223, 4601.976990115028, 4645.0, 4646.907061858811, 4668.299755036772, 4703.3885594872445, 1850.2783914273443, 1938.3990962801295, 1987.145527423193, 2014.4560968538706, 2033.4306394209646, 875.8379699755566, 970.6020531582018, 977.9657711980046, 986.921046316293, 1129.88701129888, 19842.0, 20128.19487220524, 20199.798002020085, 20547.0, 20555.38333849987, 969.3941286695815, 997.6857289953641, 1017.2878984710584, 1017.7353887989176, 1038.382162613244, 11131.276467029616, 11149.72125696864, 11313.604023859125, 11333.979941805112, 11381.658550243506, 677774.0, 687298.0, 692970.0, 698496.0, 705214.0, 125910.0, 127650.0, 131442.0, 133090.00364994534, 135325.32337338448, 1046.1892033673964, 1049.9422531760674, 1068.2522234435926, 1068.8770791358938, 1072.0298130192189, 18368.632627347644, 18598.16308266104, 18686.81313186905, 18736.437906862815, 19006.809931900505, 51933.0, 54753.0, 55113.0, 58391.0, 58682.53293667692, 75671.62164189144, 76811.46377072316, 78831.4233715334, 79918.60040699992, 83111.58444207741, 9600.66397676078, 12167.026637869127, 12299.385030748248, 12352.938235308766, 12459.750804983669, 12030.458629361874, 14093.647658808612, 14195.503157389441, 14247.002709810215, 14373.0, 5569.136783798518, 6470.9676451619325, 11924.73430048288, 12015.219010764273, 12157.1489995703, 11900.0, 11941.522339106687, 12024.699382515508, 12060.457279422622, 12313.50745970187, 11775.52897884075, 12162.452689629165, 12206.084543659439, 12278.938605306916, 12305.323207223331, 12073.335966521925, 12093.455794489093, 12218.144729868824, 12299.569515066929, 12304.0, 12191.573294934635, 12200.710788577466, 12214.328211948428, 12316.692082698004, 12357.505699771908], "unit": "score", "name": "jquery.html", "value": 9894.67180858384}, {"lowerIsBetter": false, "replicates": [1590.3479573374916, 1663.742119971404, 2004.3285499357714, 2082.9166833326667, 2093.947651308717, 8269.586520673958, 8813.427127236726, 8936.955315223422, 9138.862917056249, 9140.223081038112, 8897.021327653969, 8960.193582577567, 9007.459552426859, 9012.324075694332, 9039.00570937198, 2145.5387091775265, 2541.4027703489755, 2544.6437498750142, 2584.883680234394, 2585.5475291823855, 2526.090607381341, 2596.208156512263, 2599.2462185966046, 2637.2483842105003, 2647.9602805957925, 2571.4342844574257, 2578.6776652918384, 2585.3536615846037, 2602.4925139597785, 2609.765121139097, 2577.252596746932, 2594.0, 2597.0261152067974, 2607.9869600652064, 2613.0331777242445, 2598.246508512529, 2618.56793629051, 2627.5270451318756, 2636.2091372588147, 2640.115561286971, 9066.0, 9113.270938324918, 9121.0, 9131.726048218565, 9180.219681327095, 5637.267155269829, 5689.573282003867, 5692.459216374479, 5701.2018317435595, 5786.739596718157, 3642.25333806569, 3722.7207959403154, 3724.888253352404, 3776.093737503007, 3790.7156963227594, 1041.141058626636, 1062.33073163907, 1070.6829704742083, 1071.539238127605, 1104.4256986367125, 11841.171118021655, 11885.0, 12052.698682532919, 12157.0, 12241.20432171906, 4995.450500444948, 5039.672421292605, 5142.9742851286255, 5158.071547121479, 5161.458046905096, 10385.740356491147, 10402.375857448576, 10539.683809485728, 10572.735681608021, 10597.4701264938, 4959.553640172402, 5720.599558030898, 5723.427657234327, 5804.216430781875, 5805.187273781674, 4613.930791038137, 4999.675021123688, 5095.643304968617, 5122.385313762373, 5260.736963151904, 3285.4743241081314, 3982.3230050891416, 4042.6765858731233, 4045.2516284486874, 4060.553339132693, 1163.9359835208975, 1375.5048182654236, 1376.6420730609914, 1378.1730961423066, 1379.489588852111, 1375.8005089262, 1404.676924307415, 1406.3249640172774, 1417.3126033873564, 1418.269591160553, 7942.682292708342, 8081.0706768721175, 8117.350611951148, 8171.182881711781, 8302.8339433211, 538.7440965541336, 543.4456854008968, 1297.5588299978053, 1369.397465115346, 1377.1324065838658, 6463.127477790438, 6483.124778154889, 6518.804435866931, 6544.214694236722, 6576.1122248496795, 10518.579256829642, 10686.305390149615, 10793.730156746144, 10827.83758243627, 11004.614838480775, 10652.414117223627, 10728.89271107279, 10735.83896241557, 10742.892571074346, 10815.621453249256, 8383.538905360141, 8385.538795366192, 8412.411131220755, 8522.147785221428, 8539.573021348908, 8262.628181731956, 8313.625886834985, 8373.581320933807, 8412.369072319478, 8461.365397595328, 9394.81210375775, 9686.225101991682, 9798.216142708423, 9829.213662907094, 9941.552630131517, 9584.808303833745, 9794.510274486389, 9805.656802011896, 9990.450525221182, 10014.248931330034, 6947.965260173667, 7224.422046236394, 7402.148752893486, 7560.432967527568, 7699.422543309386, 8241.175882411711, 8373.66505339804, 8386.874196887173, 8422.368322375969, 8425.157484251771, 7320.304571065741, 7399.408047356091, 7524.360429363565, 7618.8095297618, 7671.424643151674, 7382.335589796944, 7402.33378995893, 7437.0331856858265, 7461.925380746123, 7506.061742282215, 7469.663865126191, 7868.622990976671, 7882.5270483771155, 7889.447738658238, 7930.643121059682, 5924.940750592611, 6123.8162855114415, 7067.434605231466, 7141.321574450419, 7194.96402518005, 6597.241317248578, 7304.452166087458, 7371.705131794883, 7379.557226566209, 7426.220246874001], "unit": "score", "name": "mootools.html", "value": 5080.536911474345}, {"lowerIsBetter": false, "replicates": [334.8041395783467, 337.4651177883055, 341.47072038340565, 342.4845607360923, 343.7164339419978, 6906.689198986045, 6940.861182776348, 6950.8262293442685, 6990.580565166094, 7008.36924676779, 5548.750306236219, 6928.61892595907, 6942.791716248508, 6947.478939079564, 6984.546004509703, 4910.75446227689, 4972.502749725035, 5076.213186956009, 5091.338126043609, 5151.45909679483, 4538.7503687297185, 4968.87577810554, 5045.84862454127, 5067.214581739836, 5132.846014619548, 4087.202995415895, 4631.471614367268, 4746.5490778376, 5068.518490743373, 5081.949180508184, 4579.656525760548, 4633.930491042637, 5088.058709138802, 5100.795968161269, 5125.0, 4381.145676593065, 4386.6929314947965, 4392.9896123891685, 4417.271150260203, 4419.0, 6327.3988971047675, 6621.867562648768, 6633.6683165842, 6650.301718319555, 6683.2648408675, 5130.9230361544605, 5543.614096475881, 5948.762049518057, 5954.672493012882, 5983.982722937111, 7356.411487081021, 7371.336579707799, 7376.225496322862, 7378.667959941816, 7399.408047356199, 4781.426228852525, 4786.569208771228, 4788.904221915543, 4791.832285869978, 4808.326834243208, 7007.159140903124, 7347.33873951347, 7709.498882572615, 7729.884051739228, 7810.531368117931, 4625.468071171791, 4708.505606911225, 4766.952330476651, 4778.904421911542, 4784.952150478521, 4876.756162191876, 4898.583620392235, 4933.383327084114, 4959.380077490314, 4972.7513624318635, 5954.136650185786, 5962.731677074542, 5964.7315870785915, 5970.492508136857, 5988.6706231157705, 7390.408767298603, 7402.0, 7404.925950740424, 7405.222451642608, 7412.555246685216, 1643.1127191316555, 1693.678201141779, 1722.1475369692082, 1722.2077844191563, 1724.04315604838, 1063.2663462211049, 1084.788466249074, 1085.1481586954203, 1091.3724608350071, 1092.6995076354067, 6781.321867813278, 6792.728290868409, 6845.110135682329, 6889.866080351849, 6957.860842783116, 7623.275788800055, 7630.580318082448, 7631.0, 7635.503692259986, 7661.46369754123, 5622.971885140548, 5663.490285874209, 6887.242403335629, 6953.061336719579, 6987.567548652514, 3756.1173124315765, 4022.35642297231, 4047.8785636430953, 4052.5744796796503, 4061.6547593454297, 7685.846283074307, 7701.730439434593, 7851.842963140705, 7922.445428820042, 7998.080220774686, 7970.561619110888, 7994.840748091494, 8000.119986801447, 8002.839943201104, 8014.0, 7916.485428447132, 7938.364930805522, 7942.3646108311195, 7958.6418611162635, 7980.162082981204, 7415.480916335805, 7692.846143076995, 7705.42209334291, 7763.0, 7789.104253010976, 6145.569810113428, 6769.458443324424, 7556.811079723051, 7587.596294685501, 7622.504537205064, 7914.920850791418, 7948.085970113511, 7955.960220198862, 7978.401619878417, 8004.679812807422, 3851.306764782366, 4820.204666230033, 4871.3423687803115, 4878.414590249193, 4924.310596516419, 7361.374283185989, 7696.692132314644, 7709.036370453693, 7711.38308935295, 7742.187070357531, 7398.852022959618, 7422.851542969002, 7437.293457121565, 7447.329740323397, 7457.552546847207, 6322.272938612118, 7404.370628496423, 7442.441816863865, 7445.143808462096, 7453.627318634155, 6995.370416662525, 7225.747098851515, 7248.710051597877, 7255.165655949633, 7276.126864776261, 7378.852422951403, 7400.148982866824, 7406.333429991327, 7420.109586849612, 7442.181360050282, 7276.490645654965, 7278.308560686726, 7308.123025237006, 7313.549960763204, 7317.451191160791], "unit": "score", "name": "prototype.html", "value": 5349.513109618614}, {"lowerIsBetter": false, "replicates": [696.0, 711.3349018667546, 720.9387202087822, 765.4947734495234, 793.984120317594, 15263.618409539768, 15265.694686106272, 15283.770743438858, 15503.922480387582, 15522.068675879442, 13799.0, 14078.296085195725, 14134.293285335743, 14158.29208539574, 14172.929135354309, 972.8248915195262, 979.500454768068, 1007.0483393193435, 1008.8486726990974, 1009.3338396658207, 982.1995074014656, 992.533509250651, 1005.8290090684601, 1006.783541538569, 1010.7574182196294, 900.7658008917696, 1032.406366339354, 1060.1677683018831, 1060.4803646213338, 1065.2436769893386, 1014.8274793285159, 1046.0951277145252, 1052.9157667386592, 1053.394298278493, 1060.0724366179593, 760.2549501488572, 778.2723153851167, 789.5973053742575, 790.7864876483375, 792.9246721561442, 15622.609434764108, 15667.2949717263, 15676.843231567766, 16030.679386412206, 16114.838851611452, 12742.61772146837, 12861.614151575468, 12925.741485170243, 12998.0, 13187.736245275137, 10359.637412690596, 10441.373517588969, 10655.786884262348, 10735.302205356627, 10767.461626918623, 3514.859405623772, 3562.8040457774814, 3592.281543691246, 3594.11944073701, 3665.6700896919406, 89656.99999999935, 90377.09622903753, 90963.0, 91205.54397228037, 92089.53955230248, 9486.667966621135, 9600.519974001412, 9653.90346096544, 9687.2734544908, 9983.900160998297, 21206.93965301729, 21897.890510547346, 21977.560448790933, 22102.784346860757, 22104.557908842056, 7834.334081603128, 7909.209079092045, 7950.3242224410415, 7967.3626109911065, 8035.196480352035, 4147.854825081107, 4193.266178418765, 4355.2813785725, 4424.358468022118, 4476.060027394218, 3661.2494438640015, 3690.797006164633, 3693.353663108945, 3705.444183372516, 3708.35103856824, 606.6178307666142, 671.4158681946737, 672.7006482115412, 676.5061505101205, 676.7597502886503, 581.1791192061858, 621.8476473264079, 637.4167636612448, 645.0807599171162, 646.5355968730828, 8594.87107693385, 8638.74083777475, 8687.305015598737, 8785.428947118417, 8844.955775221211, 621.7916997805695, 622.7820262907946, 626.1890851347425, 643.0964494884695, 650.6421468192475, 3988.0428697112484, 4037.8788636340955, 4040.878773636796, 4054.3310353791294, 4087.182563487255, 73126.0, 91219.54390228007, 91334.54332728294, 94802.52598736962, 96230.0, 82135.0, 82451.0, 82690.0, 84259.0, 84783.0, 69469.0, 69774.3022569778, 70425.81470414731, 70569.64715176493, 71934.0, 6371.139896113966, 6980.546264492792, 7160.391366733886, 7936.682532698858, 8322.50064996102, 34149.14627134242, 44527.0, 50584.747076264386, 51365.7431712839, 51793.0, 64738.0, 68990.0, 70101.64949175222, 70794.0, 71590.0, 10379.584816607252, 11118.0, 11213.775724485628, 11388.772224555629, 11795.0, 12027.0, 12169.81745273804, 12227.205231659913, 12596.496140154291, 12655.303958282382, 12173.87826121763, 12240.0, 12310.569130080405, 12311.876881231432, 12326.75346493083, 12023.939880300542, 12089.879101209228, 12110.843998443635, 12259.32573708419, 12423.503059877503, 11742.91036018712, 11876.940615296868, 11915.285082895054, 12014.579489717818, 12101.394930253276, 9416.10546998034, 9774.706758797247, 9799.265055120752, 9905.356151850106, 9927.851082233918, 9957.651482198089, 9961.203103751537, 9968.700938971842, 9972.950135249277, 10115.494225288854], "unit": "score", "name": "yui.html", "value": 7190.478538976433}], "name": "dromaeo_css", "value": 7815.409567111071}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 115.0, 118.0, 116.0, 127.0, 118.0, 96.0, 169.0, 168.0], "unit": "score", "name": "ai-astar", "value": 125.3}, {"lowerIsBetter": true, "replicates": [149.0, 117.0, 152.0, 150.0, 145.0, 169.0, 141.0, 122.0, 187.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [195.0, 192.0, 197.0, 203.0, 193.0, 192.0, 193.0, 191.0, 201.0, 195.0], "unit": "score", "name": "audio-dft", "value": 195.2}, {"lowerIsBetter": true, "replicates": [65.0, 76.0, 71.0, 108.0, 59.0, 64.0, 82.0, 88.0, 157.0, 56.0], "unit": "score", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [87.0, 79.0, 122.0, 78.0, 82.0, 79.0, 119.0, 78.0, 80.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 92.2}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 88.0, 86.0, 104.0, 114.0, 90.0, 90.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.0}, {"lowerIsBetter": true, "replicates": [114.0, 150.0, 94.0, 95.0, 94.0, 93.0, 94.0, 94.0, 95.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 101.6}, {"lowerIsBetter": true, "replicates": [138.0, 145.0, 93.0, 115.0, 123.0, 90.0, 93.0, 92.0, 92.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 107.2}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 59.0, 59.0, 60.0, 57.0, 60.0, 66.0, 56.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 68.0, 65.0, 76.0, 74.0, 68.0, 64.0, 62.0, 86.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 82.0, 85.0, 80.0, 83.0, 103.0, 111.0, 110.0, 116.0], "unit": "score", "name": "stanford-crypto-aes", "value": 93.6}, {"lowerIsBetter": true, "replicates": [124.0, 141.0, 140.0, 127.0, 131.0, 135.0, 132.0, 136.0, 137.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.7}, {"lowerIsBetter": true, "replicates": [134.0, 136.0, 157.0, 177.0, 174.0, 124.0, 134.0, 172.0, 171.0, 173.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 155.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 66.0, 67.0, 66.0, 74.0, 62.0, 84.0, 88.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1520.7}]} 15:36:19 INFO - Return code: 0 15:36:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:36:19 ERROR - # TBPL SUCCESS # 15:36:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:36:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:36:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:36:19 INFO - 2016-04-29 15:36:19.239 screenresolution[1683:10413] starting screenresolution argv=screenresolution get 15:36:19 INFO - 2016-04-29 15:36:19.242 screenresolution[1683:10413] Display 0: 1600x1200x32@60 15:36:19 INFO - 2016-04-29 15:36:19.248 screenresolution[1684:10416] starting screenresolution argv=screenresolution list 15:36:19 INFO - Available Modes on Display 0 15:36:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:36:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:36:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:36:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:36:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:36:19 INFO - Intel Iris: 15:36:19 INFO - Chipset Model: Intel Iris 15:36:19 INFO - Type: GPU 15:36:19 INFO - Bus: Built-In 15:36:19 INFO - VRAM (Dynamic, Max): 1536 MB 15:36:19 INFO - Vendor: Intel (0x8086) 15:36:19 INFO - Device ID: 0x0a2e 15:36:19 INFO - Revision ID: 0x0009 15:36:19 INFO - Displays: 15:36:19 INFO - Display: 15:36:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:36:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:36:19 INFO - Display Serial Number: 1600x1200 60 15:36:19 INFO - Main Display: Yes 15:36:19 INFO - Mirror: Off 15:36:19 INFO - Online: Yes 15:36:19 INFO - Rotation: Supported 15:36:19 INFO - Return code: 0 15:36:19 INFO - Running post-action listener: _resource_record_post_action 15:36:19 INFO - Running post-run listener: _resource_record_post_run 15:36:20 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 37893632; Write bytes: 512188928; Read time: 396; Write time: 1625 15:36:20 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 200659456; Write bytes: 198952960; Read time: 18092; Write time: 396 15:36:20 INFO - run-tests - Wall time: 1169s; CPU: 53.0%; Read bytes: 36079104; Write bytes: 302443008; Read time: 376; Write time: 1194 15:36:20 INFO - Running post-run listener: _upload_blobber_files 15:36:20 INFO - Blob upload gear active. 15:36:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:36:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:36:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:36:20 INFO - (blobuploader) - INFO - Open directory for files ... 15:36:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:36:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:36:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:22 INFO - (blobuploader) - INFO - Done attempting. 15:36:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:36:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:36:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:22 INFO - (blobuploader) - INFO - Done attempting. 15:36:22 INFO - (blobuploader) - INFO - Iteration through files over. 15:36:22 INFO - Return code: 0 15:36:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:36:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:36:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e80f778c2214d3c64d395f416f75c9e418f14784d514bc4fc43aa066666b8f85921dbf5be4b54a2828da8eee6983c33b00f54dc02d7f09464841098d5c4fed6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3eba547dc91b9c9b3fe05dbefe49adab67d46461c58dfa090a59b99f1d3487fe764710115145d325bc51705c63e098e097779c32567aadd6e5efd972f4b242d0"} 15:36:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:36:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:36:22 INFO - Contents: 15:36:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e80f778c2214d3c64d395f416f75c9e418f14784d514bc4fc43aa066666b8f85921dbf5be4b54a2828da8eee6983c33b00f54dc02d7f09464841098d5c4fed6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3eba547dc91b9c9b3fe05dbefe49adab67d46461c58dfa090a59b99f1d3487fe764710115145d325bc51705c63e098e097779c32567aadd6e5efd972f4b242d0"} 15:36:22 INFO - Running post-run listener: copy_logs_to_upload_dir 15:36:22 INFO - Copying logs to upload dir... 15:36:22 INFO - mkdir: /builds/slave/test/build/upload/logs 15:36:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.535961 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-04-29 15:36:23.072101) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 15:36:23.075670) ========= 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.23L7rR9Zxk/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.Wg0zTY4dNW/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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/4e80f778c2214d3c64d395f416f75c9e418f14784d514bc4fc43aa066666b8f85921dbf5be4b54a2828da8eee6983c33b00f54dc02d7f09464841098d5c4fed6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3eba547dc91b9c9b3fe05dbefe49adab67d46461c58dfa090a59b99f1d3487fe764710115145d325bc51705c63e098e097779c32567aadd6e5efd972f4b242d0"} build_url:https://queue.taskcluster.net/v1/task/eXCiSXcnRki_somanj2WKA/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010822 build_url: 'https://queue.taskcluster.net/v1/task/eXCiSXcnRki_somanj2WKA/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/4e80f778c2214d3c64d395f416f75c9e418f14784d514bc4fc43aa066666b8f85921dbf5be4b54a2828da8eee6983c33b00f54dc02d7f09464841098d5c4fed6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3eba547dc91b9c9b3fe05dbefe49adab67d46461c58dfa090a59b99f1d3487fe764710115145d325bc51705c63e098e097779c32567aadd6e5efd972f4b242d0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 15:36:23.104153) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 15:36:23.104516) ========= 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.23L7rR9Zxk/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.Wg0zTY4dNW/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.004988 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 15:36:23.154820) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 15:36:23.155248) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 15:36:23.155831) ========= ========= Total master_lag: 0.16 =========