builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0037 starttime: 1461776094.14 results: success (0) buildid: 20160427075503 builduid: a1f1896d7282419ab0e2294def8d59bc revision: e0cddb21b2849605a49f8ace1b786e0dd04ef4ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:54.146555) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:54.147072) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:54.147349) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:54.167699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:54.168070) ========= 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.rYGfPgRW5C/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.fIgcmYSVzz/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-27 09:54:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 236M=0s 2016-04-27 09:54:54 (236 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097314 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:54.292070) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:54.292338) ========= 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.rYGfPgRW5C/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.fIgcmYSVzz/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.026439 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:54.362421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 09:54:54.363300) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e0cddb21b2849605a49f8ace1b786e0dd04ef4ce --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 e0cddb21b2849605a49f8ace1b786e0dd04ef4ce --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rYGfPgRW5C/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.fIgcmYSVzz/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-27 09:54:54,435 truncating revision to first 12 chars 2016-04-27 09:54:54,435 Setting DEBUG logging. 2016-04-27 09:54:54,435 attempt 1/10 2016-04-27 09:54:54,435 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e0cddb21b284?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 09:54:55,398 unpacking tar archive at: mozilla-beta-e0cddb21b284/testing/mozharness/ program finished with exit code 0 elapsedTime=1.214313 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 09:54:55.596169) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:55.596464) ========= script_repo_revision: e0cddb21b2849605a49f8ace1b786e0dd04ef4ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:55.596847) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:55.597107) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:55.612777) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-27 09:54:55.613053) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rYGfPgRW5C/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.fIgcmYSVzz/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 09:54:55 INFO - MultiFileLogger online at 20160427 09:54:55 in /builds/slave/test 09:54:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:54:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:54:55 INFO - {'append_to_log': False, 09:54:55 INFO - 'base_work_dir': '/builds/slave/test', 09:54:55 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:54:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:54:55 INFO - 'branch': 'Mozilla-Beta', 09:54:55 INFO - 'buildbot_json_path': 'buildprops.json', 09:54:55 INFO - 'config_files': ('talos/mac_config.py',), 09:54:55 INFO - 'default_actions': ('clobber', 09:54:55 INFO - 'read-buildbot-config', 09:54:55 INFO - 'download-and-extract', 09:54:55 INFO - 'populate-webroot', 09:54:55 INFO - 'create-virtualenv', 09:54:55 INFO - 'install', 09:54:55 INFO - 'run-tests'), 09:54:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:54:55 INFO - 'download_minidump_stackwalk': True, 09:54:55 INFO - 'download_symbols': 'ondemand', 09:54:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:54:55 INFO - 'tooltool.py': '/tools/tooltool.py', 09:54:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:54:55 INFO - '/tools/misc-python/virtualenv.py')}, 09:54:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:54:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:54:55 INFO - 'installer_path': 'installer.exe', 09:54:55 INFO - 'log_level': 'info', 09:54:55 INFO - 'log_name': 'talos', 09:54:55 INFO - 'log_to_console': True, 09:54:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:54:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:54:55 INFO - 'opt_config_files': (), 09:54:55 INFO - 'pip_index': False, 09:54:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:54:55 INFO - 'cmd': ('bash', 09:54:55 INFO - '-c', 09:54:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:54:55 INFO - 'enabled': True, 09:54:55 INFO - 'halt_on_failure': False, 09:54:55 INFO - 'name': 'check_screen_resolution'},), 09:54:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:54:55 INFO - 'cmd': ('bash', 09:54:55 INFO - '-c', 09:54:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:54:55 INFO - 'enabled': True, 09:54:55 INFO - 'halt_on_failure': False, 09:54:55 INFO - 'name': 'check_screen_resolution'},), 09:54:55 INFO - 'run_cmd_checks_enabled': True, 09:54:55 INFO - 'sps_profile': False, 09:54:55 INFO - 'sps_profile_interval': 0, 09:54:55 INFO - 'suite': 'dromaeojs', 09:54:55 INFO - 'system_bits': '32', 09:54:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:54:55 INFO - 'title': 't-yosemite-r7-0037', 09:54:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:54:55 INFO - 'use_talos_json': True, 09:54:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:54:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:54:55 INFO - 'work_dir': 'build'} 09:54:55 INFO - ##### 09:54:55 INFO - ##### Running clobber step. 09:54:55 INFO - ##### 09:54:55 INFO - Running pre-action listener: _resource_record_pre_action 09:54:55 INFO - Running main action method: clobber 09:54:55 INFO - rmtree: /builds/slave/test/build 09:54:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:54:57 INFO - Running post-action listener: _resource_record_post_action 09:54:57 INFO - ##### 09:54:57 INFO - ##### Running read-buildbot-config step. 09:54:57 INFO - ##### 09:54:57 INFO - Running pre-action listener: _resource_record_pre_action 09:54:57 INFO - Running main action method: read_buildbot_config 09:54:57 INFO - Using buildbot properties: 09:54:57 INFO - { 09:54:57 INFO - "project": "", 09:54:57 INFO - "product": "firefox", 09:54:57 INFO - "script_repo_revision": "production", 09:54:57 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:54:57 INFO - "repository": "", 09:54:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:54:57 INFO - "buildid": "20160427075503", 09:54:57 INFO - "pgo_build": "False", 09:54:57 INFO - "basedir": "/builds/slave/test", 09:54:57 INFO - "buildnumber": 3, 09:54:57 INFO - "slavename": "t-yosemite-r7-0037", 09:54:57 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:54:57 INFO - "platform": "yosemite_r7", 09:54:57 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:54:57 INFO - "branch": "mozilla-beta", 09:54:57 INFO - "repo_path": "releases/mozilla-beta", 09:54:57 INFO - "revision": "e0cddb21b2849605a49f8ace1b786e0dd04ef4ce", 09:54:57 INFO - "stage_platform": "macosx64", 09:54:57 INFO - "builduid": "a1f1896d7282419ab0e2294def8d59bc", 09:54:57 INFO - "slavebuilddir": "test" 09:54:57 INFO - } 09:54:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 09:54:57 INFO - Running post-action listener: _resource_record_post_action 09:54:57 INFO - ##### 09:54:57 INFO - ##### Running download-and-extract step. 09:54:57 INFO - ##### 09:54:57 INFO - Running pre-action listener: _resource_record_pre_action 09:54:57 INFO - Running main action method: download_and_extract 09:54:57 INFO - mkdir: /builds/slave/test/build/tests 09:54: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')]} 09:54:57 INFO - https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:54:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 09:54:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 09:54:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/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 09:54:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/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 09:54:58 INFO - Downloaded 1241 bytes. 09:54:58 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 09:54:58 INFO - Using the following test package requirements: 09:54:58 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 09:54:58 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:54:58 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 09:54:58 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:54:58 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 09:54:58 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:54:58 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:54:58 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 09:54:58 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 09:54:58 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:54:58 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 09:54:58 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:54:58 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 09:54:58 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:54:58 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 09:54:58 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 09:54:58 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:54:58 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 09:54:58 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 09:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:58 INFO - https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:54:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 09:54:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 09:54:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/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 09:54:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/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 09:55:00 INFO - Downloaded 17745647 bytes. 09:55:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:55:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:55:03 INFO - Return code: 0 09:55:03 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:03 INFO - https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:55:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 09:55:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 09:55:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/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 09:55:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/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 09:55:07 INFO - Downloaded 17745647 bytes. 09:55:07 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'] 09:55:07 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 09:55:11 INFO - Return code: 0 09:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:11 INFO - https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:55:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 09:55:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 09:55:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/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 09:55:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/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 09:55:12 INFO - Downloaded 10845194 bytes. 09:55:12 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'] 09:55:12 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 09:55:12 INFO - Return code: 0 09:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:12 INFO - https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 09:55:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 09:55:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 09:55:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 09:55:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/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 09:55:16 INFO - Downloaded 88299148 bytes. 09:55:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 09:55:16 INFO - mkdir: /builds/slave/test/properties 09:55:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:55:16 INFO - Writing to file /builds/slave/test/properties/build_url 09:55:16 INFO - Contents: 09:55:16 INFO - build_url:https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 09:55:18 INFO - Running post-action listener: _resource_record_post_action 09:55:18 INFO - Running post-action listener: set_extra_try_arguments 09:55:18 INFO - ##### 09:55:18 INFO - ##### Running populate-webroot step. 09:55:18 INFO - ##### 09:55:18 INFO - Running pre-action listener: _resource_record_pre_action 09:55:18 INFO - Running main action method: populate_webroot 09:55:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:55:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:55:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:55:18 INFO - '--tppagecycles', 09:55:18 INFO - '7'], 09:55:18 INFO - 'tests': ['tsvgm']}}, 09:55:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:55:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:55:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:55:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:55:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:55:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:55:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:55:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:18 INFO - 'talos_options': ['--e10s'], 09:55:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:55:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:18 INFO - 'tests': ['damp', 'tps']}, 09:55:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:18 INFO - 'talos_options': ['--e10s'], 09:55:18 INFO - 'tests': ['damp', 'tps']}, 09:55:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:55:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:55:18 INFO - 'other': {'tests': ['a11yr', 09:55:18 INFO - 'ts_paint', 09:55:18 INFO - 'tpaint', 09:55:18 INFO - 'sessionrestore', 09:55:18 INFO - 'sessionrestore_no_auto_restore', 09:55:18 INFO - 'tabpaint']}, 09:55:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:55:18 INFO - 'tests': ['a11yr', 09:55:18 INFO - 'ts_paint', 09:55:18 INFO - 'tpaint', 09:55:18 INFO - 'sessionrestore', 09:55:18 INFO - 'sessionrestore_no_auto_restore', 09:55:18 INFO - 'tabpaint']}, 09:55:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:55:18 INFO - 'tests': ['a11yr', 09:55:18 INFO - 'ts_paint', 09:55:18 INFO - 'tpaint', 09:55:18 INFO - 'sessionrestore', 09:55:18 INFO - 'sessionrestore_no_auto_restore', 09:55:18 INFO - 'tabpaint']}, 09:55:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:55:18 INFO - 'tests': ['a11yr', 09:55:18 INFO - 'ts_paint', 09:55:18 INFO - 'tpaint', 09:55:18 INFO - 'sessionrestore', 09:55:18 INFO - 'sessionrestore_no_auto_restore', 09:55:18 INFO - 'tabpaint']}, 09:55:18 INFO - 'other_l64': {'tests': ['a11yr', 09:55:18 INFO - 'ts_paint', 09:55:18 INFO - 'tpaint', 09:55:18 INFO - 'sessionrestore', 09:55:18 INFO - 'sessionrestore_no_auto_restore', 09:55:18 INFO - 'tabpaint']}, 09:55:18 INFO - 'other_nol64': {'tests': ['a11yr', 09:55:18 INFO - 'ts_paint', 09:55:18 INFO - 'tpaint', 09:55:18 INFO - 'sessionrestore', 09:55:18 INFO - 'sessionrestore_no_auto_restore', 09:55:18 INFO - 'tabpaint']}, 09:55:18 INFO - 'svgr': {'tests': ['tsvgx', 09:55:18 INFO - 'tsvgr_opacity', 09:55:18 INFO - 'tart', 09:55:18 INFO - 'tscrollx', 09:55:18 INFO - 'cart']}, 09:55:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:55:18 INFO - 'tests': ['tsvgx', 09:55:18 INFO - 'tsvgr_opacity', 09:55:18 INFO - 'tart', 09:55:18 INFO - 'tscrollx', 09:55:18 INFO - 'cart']}, 09:55:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:18 INFO - 'tests': ['tp5o']}, 09:55:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:18 INFO - 'talos_options': ['--e10s'], 09:55:18 INFO - 'tests': ['tp5o']}, 09:55:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:18 INFO - 'talos_options': ['--xperf_path', 09:55:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:55:18 INFO - 'tests': ['tp5n']}, 09:55:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:18 INFO - 'talos_options': ['--e10s', 09:55:18 INFO - '--xperf_path', 09:55:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:55:18 INFO - 'tests': ['tp5n']}}, 09:55:18 INFO - 'talos.zip': {'path': '', 09:55:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:55:18 INFO - Running post-action listener: _resource_record_post_action 09:55:18 INFO - ##### 09:55:18 INFO - ##### Running create-virtualenv step. 09:55:18 INFO - ##### 09:55:18 INFO - Running pre-action listener: _resource_record_pre_action 09:55:18 INFO - Running main action method: create_virtualenv 09:55:18 INFO - Creating virtualenv /builds/slave/test/build/venv 09:55:18 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 09:55:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:55:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:55:18 INFO - Using real prefix '/tools/python27' 09:55:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:55:19 INFO - Installing distribute.............................................................................................................................................................................................done. 09:55:22 INFO - Installing pip.................done. 09:55:22 INFO - Return code: 0 09:55:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:55: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')]} 09:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55: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')]} 09:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:22 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 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa72146d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108234d30>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822bb20>, '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.rYGfPgRW5C/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.fIgcmYSVzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 09:55:22 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 09:55:22 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 09:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rYGfPgRW5C/Render', 09:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:22 INFO - 'HOME': '/Users/cltbld', 09:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:22 INFO - 'LOGNAME': 'cltbld', 09:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:22 INFO - 'MOZ_NO_REMOTE': '1', 09:55:22 INFO - 'NO_EM_RESTART': '1', 09:55:22 INFO - 'PAGER': '/bin/cat', 09:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:22 INFO - 'PWD': '/builds/slave/test', 09:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:22 INFO - 'SHELL': '/bin/bash', 09:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fIgcmYSVzz/Listeners', 09:55:22 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 09:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:22 INFO - 'USER': 'cltbld', 09:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:22 INFO - 'XPC_FLAGS': '0x0', 09:55:22 INFO - 'XPC_SERVICE_NAME': '0', 09:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:22 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 09:55:22 INFO - Cleaning up... 09:55:22 INFO - Return code: 0 09:55:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:55: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')]} 09:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55: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')]} 09:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:22 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 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa72146d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108234d30>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822bb20>, '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.rYGfPgRW5C/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.fIgcmYSVzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 09:55:22 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 09:55:22 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 09:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rYGfPgRW5C/Render', 09:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:22 INFO - 'HOME': '/Users/cltbld', 09:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:22 INFO - 'LOGNAME': 'cltbld', 09:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:22 INFO - 'MOZ_NO_REMOTE': '1', 09:55:22 INFO - 'NO_EM_RESTART': '1', 09:55:22 INFO - 'PAGER': '/bin/cat', 09:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:22 INFO - 'PWD': '/builds/slave/test', 09:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:22 INFO - 'SHELL': '/bin/bash', 09:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fIgcmYSVzz/Listeners', 09:55:22 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 09:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:22 INFO - 'USER': 'cltbld', 09:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:22 INFO - 'XPC_FLAGS': '0x0', 09:55:22 INFO - 'XPC_SERVICE_NAME': '0', 09:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:23 INFO - Downloading/unpacking psutil>=0.7.1 09:55: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 09:55: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 09:55: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 09:55: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 09:55: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 09:55: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 09:55:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:55:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:55:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:55:25 INFO - Installing collected packages: psutil 09:55:25 INFO - Running setup.py install for psutil 09:55:25 INFO - building 'psutil._psutil_osx' extension 09:55:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:55:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:55:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:55:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:55:26 INFO - building 'psutil._psutil_posix' extension 09:55:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:55:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:55:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:55:26 INFO - ^ 09:55:26 INFO - 1 warning generated. 09:55:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:55:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:55:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:55:26 INFO - Successfully installed psutil 09:55:26 INFO - Cleaning up... 09:55:26 INFO - Return code: 0 09:55:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa72146d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108234d30>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822bb20>, '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.rYGfPgRW5C/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.fIgcmYSVzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 09:55:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:55:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:55:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rYGfPgRW5C/Render', 09:55:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:26 INFO - 'HOME': '/Users/cltbld', 09:55:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:26 INFO - 'LOGNAME': 'cltbld', 09:55:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:26 INFO - 'MOZ_NO_REMOTE': '1', 09:55:26 INFO - 'NO_EM_RESTART': '1', 09:55:26 INFO - 'PAGER': '/bin/cat', 09:55:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:26 INFO - 'PWD': '/builds/slave/test', 09:55:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:26 INFO - 'SHELL': '/bin/bash', 09:55:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fIgcmYSVzz/Listeners', 09:55:26 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 09:55:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:26 INFO - 'USER': 'cltbld', 09:55:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:26 INFO - 'XPC_FLAGS': '0x0', 09:55:26 INFO - 'XPC_SERVICE_NAME': '0', 09:55:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:55: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 09:55: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 09:55: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 09:55: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 09:55: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 09:55: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 09:55:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:55:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:55:29 INFO - Installing collected packages: mozsystemmonitor 09:55:29 INFO - Running setup.py install for mozsystemmonitor 09:55:29 INFO - Successfully installed mozsystemmonitor 09:55:29 INFO - Cleaning up... 09:55:29 INFO - Return code: 0 09:55:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:55:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa72146d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108234d30>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822bb20>, '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.rYGfPgRW5C/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.fIgcmYSVzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 09:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:55:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rYGfPgRW5C/Render', 09:55:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:29 INFO - 'HOME': '/Users/cltbld', 09:55:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:29 INFO - 'LOGNAME': 'cltbld', 09:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:29 INFO - 'MOZ_NO_REMOTE': '1', 09:55:29 INFO - 'NO_EM_RESTART': '1', 09:55:29 INFO - 'PAGER': '/bin/cat', 09:55:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:29 INFO - 'PWD': '/builds/slave/test', 09:55:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:29 INFO - 'SHELL': '/bin/bash', 09:55:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fIgcmYSVzz/Listeners', 09:55:29 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 09:55:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:29 INFO - 'USER': 'cltbld', 09:55:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:29 INFO - 'XPC_FLAGS': '0x0', 09:55:29 INFO - 'XPC_SERVICE_NAME': '0', 09:55:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:30 INFO - Downloading/unpacking blobuploader==1.2.4 09:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:32 INFO - Downloading blobuploader-1.2.4.tar.gz 09:55:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:55:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:55:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:33 INFO - Downloading docopt-0.6.1.tar.gz 09:55:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:55:33 INFO - Installing collected packages: blobuploader, requests, docopt 09:55:33 INFO - Running setup.py install for blobuploader 09:55:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:55:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:55:34 INFO - Running setup.py install for requests 09:55:34 INFO - Running setup.py install for docopt 09:55:34 INFO - Successfully installed blobuploader requests docopt 09:55:34 INFO - Cleaning up... 09:55:34 INFO - Return code: 0 09:55:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55: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')]} 09:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55: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')]} 09:55:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa72146d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108234d30>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822bb20>, '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.rYGfPgRW5C/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.fIgcmYSVzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 09:55:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:55:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:55:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rYGfPgRW5C/Render', 09:55:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:34 INFO - 'HOME': '/Users/cltbld', 09:55:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:34 INFO - 'LOGNAME': 'cltbld', 09:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:34 INFO - 'MOZ_NO_REMOTE': '1', 09:55:34 INFO - 'NO_EM_RESTART': '1', 09:55:34 INFO - 'PAGER': '/bin/cat', 09:55:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:34 INFO - 'PWD': '/builds/slave/test', 09:55:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:34 INFO - 'SHELL': '/bin/bash', 09:55:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fIgcmYSVzz/Listeners', 09:55:34 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 09:55:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:34 INFO - 'USER': 'cltbld', 09:55:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:34 INFO - 'XPC_FLAGS': '0x0', 09:55:34 INFO - 'XPC_SERVICE_NAME': '0', 09:55:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:55:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-7ySBZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:55:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-9cBPD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:55:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-wwjr3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:55:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-9FnigO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:55:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-9Pjb1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:55:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-j_ONmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:55:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-kBoQd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:55:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-J2JDyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:55:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-3UtD39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:55:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-1QwO7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:55:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-IhUS26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:55:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-fAZ1aK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:55:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Hqwsfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:55:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-UV8n9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-QadCRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:55:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-pY3l4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:55:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-T_QR0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:55:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:55:36 INFO - Running setup.py install for manifestparser 09:55:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:55:36 INFO - Running setup.py install for mozcrash 09:55:37 INFO - Running setup.py install for mozdebug 09:55:37 INFO - Running setup.py install for mozdevice 09:55:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:55:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:55:37 INFO - Running setup.py install for mozfile 09:55:37 INFO - Running setup.py install for mozhttpd 09:55:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:55:37 INFO - Running setup.py install for mozinfo 09:55:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:55:37 INFO - Running setup.py install for mozInstall 09:55:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:55:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:55:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:55:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:55:37 INFO - Running setup.py install for mozleak 09:55:38 INFO - Running setup.py install for mozlog 09:55:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:55:38 INFO - Running setup.py install for moznetwork 09:55:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:55:38 INFO - Running setup.py install for mozprocess 09:55:38 INFO - Running setup.py install for mozprofile 09:55:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:55:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:55:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:55:38 INFO - Running setup.py install for mozrunner 09:55:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:55:38 INFO - Running setup.py install for mozscreenshot 09:55:39 INFO - Running setup.py install for moztest 09:55:39 INFO - Running setup.py install for mozversion 09:55:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:55:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:55:39 INFO - Cleaning up... 09:55:39 INFO - Return code: 0 09:55:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55: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')]} 09:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55: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')]} 09:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa72146d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108234d30>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822bb20>, '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.rYGfPgRW5C/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.fIgcmYSVzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 09:55:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:55:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rYGfPgRW5C/Render', 09:55:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:39 INFO - 'HOME': '/Users/cltbld', 09:55:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:39 INFO - 'LOGNAME': 'cltbld', 09:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:39 INFO - 'MOZ_NO_REMOTE': '1', 09:55:39 INFO - 'NO_EM_RESTART': '1', 09:55:39 INFO - 'PAGER': '/bin/cat', 09:55:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:39 INFO - 'PWD': '/builds/slave/test', 09:55:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:39 INFO - 'SHELL': '/bin/bash', 09:55:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fIgcmYSVzz/Listeners', 09:55:39 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 09:55:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:39 INFO - 'USER': 'cltbld', 09:55:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:39 INFO - 'XPC_FLAGS': '0x0', 09:55:39 INFO - 'XPC_SERVICE_NAME': '0', 09:55:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:55:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-L9_hjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:55:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:55:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-SltOWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:55:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:55:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Wt186m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:55:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:55:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-XZURmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:55:40 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)) 09:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:55:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-UmSdaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:55:40 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)) 09:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:55:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-CU8zq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:55:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-aiyw3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:55:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Ze_EXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:55:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-1v_HRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:55:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-9U_60L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:55:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-tNQj9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:55:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-oKrV1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:55:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-xYLe9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:55:41 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)) 09:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:55:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-bHz954-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:55:41 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)) 09:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-28_kaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:55:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-7GAIzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:55:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-1Mg1PP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:55:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:43 INFO - Downloading blessings-1.6.tar.gz 09:55:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:55:44 INFO - Installing collected packages: blessings 09:55:44 INFO - Running setup.py install for blessings 09:55:44 INFO - Successfully installed blessings 09:55:44 INFO - Cleaning up... 09:55:44 INFO - Return code: 0 09:55:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:55:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:55:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:55:44 INFO - Reading from file tmpfile_stdout 09:55:44 INFO - Current package versions: 09:55:44 INFO - blessings == 1.6 09:55:44 INFO - blobuploader == 1.2.4 09:55:44 INFO - docopt == 0.6.1 09:55:44 INFO - manifestparser == 1.1 09:55:44 INFO - mozInstall == 1.12 09:55:44 INFO - mozcrash == 0.17 09:55:44 INFO - mozdebug == 0.1 09:55:44 INFO - mozdevice == 0.48 09:55:44 INFO - mozfile == 1.2 09:55:44 INFO - mozhttpd == 0.7 09:55:44 INFO - mozinfo == 0.9 09:55:44 INFO - mozleak == 0.1 09:55:44 INFO - mozlog == 3.1 09:55:44 INFO - moznetwork == 0.27 09:55:44 INFO - mozprocess == 0.22 09:55:44 INFO - mozprofile == 0.28 09:55:44 INFO - mozrunner == 6.11 09:55:44 INFO - mozscreenshot == 0.1 09:55:44 INFO - mozsystemmonitor == 0.0 09:55:44 INFO - moztest == 0.7 09:55:44 INFO - mozversion == 1.4 09:55:44 INFO - psutil == 3.1.1 09:55:44 INFO - requests == 1.2.3 09:55:44 INFO - wsgiref == 0.1.2 09:55:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa72146d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108234d30>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822bb20>, '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.rYGfPgRW5C/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.fIgcmYSVzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 09:55:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:55:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:55:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rYGfPgRW5C/Render', 09:55:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:44 INFO - 'HOME': '/Users/cltbld', 09:55:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:44 INFO - 'LOGNAME': 'cltbld', 09:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:44 INFO - 'MOZ_NO_REMOTE': '1', 09:55:44 INFO - 'NO_EM_RESTART': '1', 09:55:44 INFO - 'PAGER': '/bin/cat', 09:55:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:44 INFO - 'PWD': '/builds/slave/test', 09:55:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:44 INFO - 'SHELL': '/bin/bash', 09:55:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fIgcmYSVzz/Listeners', 09:55:44 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 09:55:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:44 INFO - 'USER': 'cltbld', 09:55:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:44 INFO - 'XPC_FLAGS': '0x0', 09:55:44 INFO - 'XPC_SERVICE_NAME': '0', 09:55:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:55:44 INFO - Cleaning up... 09:55:44 INFO - Return code: 0 09:55:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa72146d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108234d30>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822bb20>, '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.rYGfPgRW5C/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.fIgcmYSVzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 09:55:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:55:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:55:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rYGfPgRW5C/Render', 09:55:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:44 INFO - 'HOME': '/Users/cltbld', 09:55:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:44 INFO - 'LOGNAME': 'cltbld', 09:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:44 INFO - 'MOZ_NO_REMOTE': '1', 09:55:44 INFO - 'NO_EM_RESTART': '1', 09:55:44 INFO - 'PAGER': '/bin/cat', 09:55:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:44 INFO - 'PWD': '/builds/slave/test', 09:55:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:44 INFO - 'SHELL': '/bin/bash', 09:55:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fIgcmYSVzz/Listeners', 09:55:44 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 09:55:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:44 INFO - 'USER': 'cltbld', 09:55:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:44 INFO - 'XPC_FLAGS': '0x0', 09:55:44 INFO - 'XPC_SERVICE_NAME': '0', 09:55:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:45 INFO - Downloading/unpacking jsonschema 09:55:45 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 09:55:45 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 09:55:45 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 09:55:45 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 09:55:45 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 09:55:45 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 09:55:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:55:47 INFO - Downloading/unpacking functools32 (from jsonschema) 09:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:47 INFO - Downloading functools32-3.2.3-2.tar.gz 09:55:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:55:47 INFO - warning: no files found matching '*.txt' 09:55:47 INFO - no previously-included directories found matching 'build' 09:55:47 INFO - no previously-included directories found matching 'dist' 09:55:47 INFO - no previously-included directories found matching '.git*' 09:55:47 INFO - Installing collected packages: jsonschema, functools32 09:55:48 INFO - Running setup.py install for functools32 09:55:48 INFO - warning: no files found matching '*.txt' 09:55:48 INFO - no previously-included directories found matching 'build' 09:55:48 INFO - no previously-included directories found matching 'dist' 09:55:48 INFO - no previously-included directories found matching '.git*' 09:55:48 INFO - Successfully installed jsonschema functools32 09:55:48 INFO - Cleaning up... 09:55:48 INFO - Return code: 0 09:55:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa72146d500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108234d30>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822bb20>, '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.rYGfPgRW5C/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.fIgcmYSVzz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 09:55:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:55:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:55:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rYGfPgRW5C/Render', 09:55:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:48 INFO - 'HOME': '/Users/cltbld', 09:55:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:48 INFO - 'LOGNAME': 'cltbld', 09:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:48 INFO - 'MOZ_NO_REMOTE': '1', 09:55:48 INFO - 'NO_EM_RESTART': '1', 09:55:48 INFO - 'PAGER': '/bin/cat', 09:55:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:48 INFO - 'PWD': '/builds/slave/test', 09:55:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:48 INFO - 'SHELL': '/bin/bash', 09:55:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fIgcmYSVzz/Listeners', 09:55:48 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 09:55:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:48 INFO - 'USER': 'cltbld', 09:55:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:48 INFO - 'XPC_FLAGS': '0x0', 09:55:48 INFO - 'XPC_SERVICE_NAME': '0', 09:55:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:48 INFO - Downloading/unpacking flake8 09:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:55:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:55:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:55:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:55:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:55:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:55:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:55:53 INFO - no previously-included directories found matching 'docs/_build' 09:55:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:55:53 INFO - Running setup.py install for pep8 09:55:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:55:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:55:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:55:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:55:53 INFO - no previously-included directories found matching 'docs/_build' 09:55:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:55:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:55:53 INFO - Cleaning up... 09:55:53 INFO - Return code: 0 09:55:53 INFO - Running post-action listener: _resource_record_post_action 09:55:53 INFO - Running post-action listener: _start_resource_monitoring 09:55:53 INFO - Starting resource monitoring. 09:55:53 INFO - ##### 09:55:53 INFO - ##### Running install step. 09:55:53 INFO - ##### 09:55:53 INFO - Running pre-action listener: _resource_record_pre_action 09:55:53 INFO - Running main action method: install 09:55:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:55:53 INFO - Reading from file tmpfile_stdout 09:55:53 INFO - Detecting whether we're running mozinstall >=1.0... 09:55:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:55:53 INFO - Reading from file tmpfile_stdout 09:55:53 INFO - Output received: 09:55:53 INFO - Usage: mozinstall [options] installer 09:55:53 INFO - Options: 09:55:53 INFO - -h, --help show this help message and exit 09:55:53 INFO - -d DEST, --destination=DEST 09:55:53 INFO - Directory to install application into. [default: 09:55:53 INFO - "/builds/slave/test"] 09:55:53 INFO - --app=APP Application being installed. [default: firefox] 09:55:53 INFO - mkdir: /builds/slave/test/build/application 09:55:53 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'] 09:55:53 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 09:56:16 INFO - Reading from file tmpfile_stdout 09:56:16 INFO - Output received: 09:56:16 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:56:16 INFO - Running post-action listener: _resource_record_post_action 09:56:16 INFO - ##### 09:56:16 INFO - ##### Running run-tests step. 09:56:16 INFO - ##### 09:56:16 INFO - Running pre-action listener: _resource_record_pre_action 09:56:16 INFO - Running main action method: run_tests 09:56:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:56:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:56:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:56:16 INFO - 2016-04-27 09:56:16.425 screenresolution[1639:7464] starting screenresolution argv=screenresolution get 09:56:16 INFO - 2016-04-27 09:56:16.428 screenresolution[1639:7464] Display 0: 1600x1200x32@60 09:56:16 INFO - 2016-04-27 09:56:16.433 screenresolution[1640:7467] starting screenresolution argv=screenresolution list 09:56:16 INFO - Available Modes on Display 0 09:56:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:56:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:56:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:56:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:56:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:56:16 INFO - Intel Iris: 09:56:16 INFO - Chipset Model: Intel Iris 09:56:16 INFO - Type: GPU 09:56:16 INFO - Bus: Built-In 09:56:16 INFO - VRAM (Dynamic, Max): 1536 MB 09:56:16 INFO - Vendor: Intel (0x8086) 09:56:16 INFO - Device ID: 0x0a2e 09:56:16 INFO - Revision ID: 0x0009 09:56:16 INFO - Displays: 09:56:16 INFO - Display: 09:56:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:56:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:56:16 INFO - Display Serial Number: 1600x1200 60 09:56:16 INFO - Main Display: Yes 09:56:16 INFO - Mirror: Off 09:56:16 INFO - Online: Yes 09:56:16 INFO - Rotation: Supported 09:56:16 INFO - Return code: 0 09:56:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:56:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:56:16 INFO - Python 2.7.3 09:56:16 INFO - Return code: 0 09:56:16 INFO - grabbing minidump binary from tooltool 09:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:16 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 0x108234d30>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:56:16 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 09:56:16 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 09:56:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:56:16 INFO - Return code: 0 09:56:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:56:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:56:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:56:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:56:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:56:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:56:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:56:17 INFO - Return code: 0 09:56:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:56:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rYGfPgRW5C/Render', 09:56:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:17 INFO - 'HOME': '/Users/cltbld', 09:56:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:17 INFO - 'LOGNAME': 'cltbld', 09:56:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:56:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:17 INFO - 'MOZ_NO_REMOTE': '1', 09:56:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:56:17 INFO - 'NO_EM_RESTART': '1', 09:56:17 INFO - 'PAGER': '/bin/cat', 09:56:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:17 INFO - 'PWD': '/builds/slave/test', 09:56:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:56:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:17 INFO - 'SHELL': '/bin/bash', 09:56:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fIgcmYSVzz/Listeners', 09:56:17 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 09:56:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:17 INFO - 'USER': 'cltbld', 09:56:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:17 INFO - 'XPC_FLAGS': '0x0', 09:56:17 INFO - 'XPC_SERVICE_NAME': '0', 09:56:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:56:18 INFO - mozversion application_buildid: 20160427075503 09:56:18 INFO - mozversion application_changeset: e0cddb21b2849605a49f8ace1b786e0dd04ef4ce 09:56:18 INFO - mozversion application_display_name: Firefox 09:56:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:56:18 INFO - mozversion application_name: Firefox 09:56:18 INFO - mozversion application_remotingname: firefox 09:56:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:56:18 INFO - mozversion application_vendor: Mozilla 09:56:18 INFO - mozversion application_version: 47.0 09:56:18 INFO - mozversion platform_buildid: 20160427075503 09:56:18 INFO - mozversion platform_changeset: e0cddb21b2849605a49f8ace1b786e0dd04ef4ce 09:56:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:56:18 INFO - mozversion platform_version: 47.0 09:56:18 INFO - using testdate: 1461776178 09:56:18 INFO - actual date: 1461776178 09:56:18 INFO - starting webserver on 'localhost:49275' 09:56:18 INFO - SUITE-START | Running 2 tests 09:56:18 INFO - TEST-START | dromaeo_css 09:56:18 INFO - operating with platform_type : mac_ 09:56:18 INFO - Initialising browser for dromaeo_css test... 09:56:18 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpbZNyFc/profile http://localhost:49275/getInfo.html) 09:56:20 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 09:56:20 INFO - PROCESS | 1658 | colorDepth:24 09:56:20 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 09:56:20 INFO - PROCESS | 1658 | __metrics 09:56:20 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:56:20 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:56:20 INFO - TEST-INFO | 1658: exit 0 09:56:20 INFO - Browser initialized. 09:56:20 INFO - Running cycle 1/1 for dromaeo_css test... 09:56:20 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpbZNyFc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:56:32 INFO - PROCESS | 1661 | RSS: Main: 156737536 09:56:32 INFO - PROCESS | 1661 | 09:57:23 INFO - PROCESS | 1661 | 1461776243723 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] 09:59:33 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 09:59:34 INFO - PROCESS | 1661 | RSS: Main: 272429056 09:59:34 INFO - PROCESS | 1661 | 10:02:37 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 10:02:37 INFO - PROCESS | 1661 | RSS: Main: 294219776 10:02:37 INFO - PROCESS | 1661 | 10:05:39 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 10:05:40 INFO - PROCESS | 1661 | RSS: Main: 295366656 10:05:40 INFO - PROCESS | 1661 | 10:08:42 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 10:08:42 INFO - PROCESS | 1661 | RSS: Main: 253755392 10:08:42 INFO - PROCESS | 1661 | 10:11:45 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 10:11:46 INFO - PROCESS | 1661 | RSS: Main: 254406656 10:11:46 INFO - PROCESS | 1661 | 10:14:48 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 10:14:49 INFO - PROCESS | 1661 | RSS: Main: 301608960 10:14:49 INFO - PROCESS | 1661 | 10:14:49 INFO - PROCESS | 1661 | __start_tp_report 10:14:49 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 10:14:49 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 10:14:49 INFO - PROCESS | 1661 | |i|pagename|runs| 10:14:49 INFO - PROCESS | 1661 | |0;dojo.html;3107.3008573071056;3673.3020726062064;3675.4854320395134;3681.134933290676;3740.0649837540614;5922.496587790032;5942.1978032965535;5987.700614969245;5995.160677505148;6046.606970546917;5910.556708246877;5967.925773360794;5987.610805297652;5999;6002.06967919972;5240.737963101848;5318.30861987942;5341.973290133544;5401.70290634015;5426.8371948841595;5422.810201642943;5436.429174936634;5438.646487978289;5441.564674826004;5442;5350.973245133769;5394.244805727201;5412.702301373423;5416.4312747161575;5425.213344065108;5396.163594642837;5410.945890541084;5442.482964118402;5445.455454454563;5501.559875210014;5151.253068305112;5320.095583750772;5334.439883812182;5357.142857142839;5365.168398898177;5781.566382521328;5823.388544202882;5839.6204246724255;5863.355030946593;5869.618474799125;6310.495160387158;6375.904361434582;6392.105105285264;6408.67956602168;6416.839579010562;6315.273743519462;6320.81037568869;6339.524535659798;6359.109724638554;6369.108324834527;6064.727087281083;6083.239595050619;6086.634801911855;6097.268327800648;6136.079588061737;6311.747530098836;6365.2679941806355;6465.418112369909;6480.902786458207;6486.805395838132;6341.302456729756;6362;6373.776917807947;6381.329960354189;6381.8085457436355;6347.5239357047485;6381.266154392304;6381.712822922979;6395.616263024233;6399.712012959335;6288.622682638965;6298.149749783812;6304.054391841169;6370.426661600478;6386.10594516768;5386.703731294738;6315.021171718391;6336.334684858116;6375.649339286384;6399.104125422445;5019.046381187636;5025.773840177201;5046.419661738947;5051.419086804991;5054.241863720398;4493.191225579427;4591.380163677861;4599.2871104978785;4614.192516309632;4623.815047398134;6076.635401875901;6121.81881567809;6159.29168145669;6161.876762464725;6177.660228687465;6334.936650633527;6344.302126766052;6344.49244060474;6350.269718982284;6363.7772677956045;6051.243594550681;6110.663913484801;6133.6319820810895;6170.197874276315;6172.938270617326;5537.1140617501005;5588;5593.133064375028;5605.1031834907035;5630.408807075198;6545.574537655038;6553.839728737972;6575.638339891352;6584.5061620378665;6596.109525214035;6279.340669229665;6311.084892690443;6373.171487706569;6378.170837791057;6387.073874288295;6563.573367731082;6588.143541339595;6617.702203400762;6628.7017084230365;6640.402363787282;6283.96858015707;6312.14786003902;6360.427561519486;6365.8726825464155;6368.713407896748;6227;6283.183186185766;6322.936770632235;6361.554691171574;6380.96809515968;6359.17330747;6360.968195158995;6361;6375.87248255023;6380.96809515968;6363.14097596837;6369.20384951881;6375.87248255023;6380.234371875405;6393.424591786761;6124.197855633957;6188.907166392418;6291.02489114188;6299.527535434769;6306.779262725782;6310.7791227306825;6324.430801227912;6369.267534233437;6373.362663733589;6382.266039405527;6138.878900475427;6261.217347831521;6304.936950630435;6316.810495685137;6332.335104813928 10:14:49 INFO - PROCESS | 1661 | |1;ext.html;480.94950030246844;591.7958304384986;626.9968650156749;668.7358493395109;672.5258692621701;40521;40966.7951660242;41076.38385424221;41090.7672769817;41137;43893;44388.55611443885;44508.77745611267;44542.33186502205;44588.3311750324;9685.95157024214;9928.503574821267;9938;9940.15508681763;9954.153896918771;9719.368241064343;9730.464824434654;9832.213422926185;9869.161121304698;9873.506324683736;9915.058069483388;9933.90066099337;9980.650677226298;9997.90002099977;10005.799884002316;9885.703428897108;9949;9958.900410995906;9966.003399660049;9966.302358834884;9829.655962041366;9857.950710246474;9958.950205249;9977.201823854075;9990.900090999143;42854.14291714179;43214.919627009265;43300.78349608263;43304.3504347435;43320.566794332284;3283.605967283941;3438.896833094986;3466.497357883118;3691.5570131584113;3922.7057970652313;29315;30173.245668858453;30230.24424389386;30241.69758302411;30559;2760.3651160233057;2805.565137403685;2846.245744877609;2858.8999385021634;2875.353045564752;448409.5159048433;487784;488059.1194088085;488802;489179;64550;69749.65125174444;69800.65099674571;69806.30193697997;69817;76889.61555192189;79288.20711792924;79538.60230698809;79582;79819.60090199512;18187.818121818877;18533.81466185321;18550.72173917392;18552.814471855378;18587;12600.306983116017;13275.203487790763;13953.093048951785;14051.929740351234;14091.859081409055;18481.353152639593;22064.88967555152;23067.653985190234;23192.840357982033;23583.646245306336;8767.693130740394;8991.595378207996;9455.196308313733;9653.324267301363;9712.3201375903;1029.4749677664445;1037.408677054087;1082.8538147350164;1126.3298337489182;1246.2833870524485;31369.52945705816;32268.83865580704;33144.3371132576;33207.66792332094;33699.663003370144;1118.6308518188978;1168.112234701616;1176.3823992403886;1206.457094307565;1278.7442511497738;12147.149699521126;15887.443939462064;16970.57573560646;16999.49001529956;17231.913840430967;659629;670377;671333;672299;673087;63420;64201.67899160474;64202.35797642057;64218;64251.678741605996;1370.766969615148;1421.7062473149385;1553.6581951970547;1577.8579927806552;1598.5044636163059;24570.38062352897;26126.477470450864;27909.581356279265;28873.56689649699;30081;49007.75496122639;49440.25839612337;49715.75142124266;49844;49969.50030499794;351592;352412.2379388087;352426;352466;353622;34082.488762669076;34865.12837179091;35140.64859351476;35666.28667426585;35695.28609427745;46612.834679133295;46622.53377466182;48157.55527334186;48366.516334836204;48554.514454855;31903;38746;38890.6110938887;39131.02172445712;39559.40660890032;37046.814765927076;37840.81079594584;38336.42495362516;38548.6145138545;38575.035624108496;37124.44313335356;37588.060298492754;37991.43012854864;38908.41637375385;38948.41577376285;32827;33772.98681039573;33916.49125263172;33929.83035084809;33932.49101263532;22006.669899951834;22469.550608987403;23631.054757810183;25168.37079073038;25443.982240710164 10:14:49 INFO - PROCESS | 1661 | |2;jquery.html;382.8686232183897;383.2144104585599;388.64439038279977;394.37688452245453;394.68228076398486;16334.410831310965;16688.249028793703;19893;21227.938603069844;21257.93710314484;17055.317787288524;22238.777612223872;22267;22311.665325020098;23092.845357732087;5847.210626565402;6150.261968563778;6226.937730622681;6241.251049874021;6259.155014073087;5819.30168379795;6186.226721659793;6204.8448788780415;6205;6208;6141.447269745722;6157.1995640566665;6158.199434073586;6158.6612736299485;6181.474574661159;5658.377578466366;5887.4112588741;5898.734556944905;5901.439363260483;5904.380040095771;5461.644993075477;5556.749946252428;5587.161925711135;5638.774449022034;5653.9151912721345;14250.71988481838;14482.565523034325;14483.927580362137;23846.880765596063;26703.599446008324;2139.882306473143;2205.5258119504383;2261.547690461914;2268.4555706630454;2521.886515106806;10176.982301769838;10338.844917326247;10372.636957706443;10446.05985461312;10519.211059170593;1775.112443778111;1825.3246298869503;1858.3402891973426;1875.8780679255806;1974.3188599933;100795;105512.47243763732;108515;108628.99999999921;109226.361604576;11297.152713546353;11656.475458604384;11739;11888.524459021542;12060.155789094679;14476.203808790618;14497.420103195966;14522.85477145215;14531.418743250362;14573.92713036428;7260;8965.50689712072;9032.548372581345;9068.093190681011;9107.316951228684;9193.402428842237;9200.6779762708;9213.216876565433;9270.304727145356;9273.072692730673;4531.207038768202;4577.816887324537;4583.243764778841;4587.954120458753;4650.9767451162525;1682.4195652499868;1904.8571357148269;1962.4112766170092;1986.523234423728;2008.8593798434263;745.7688116683845;876.8421684096796;1103.779244151173;1112.9054030407506;1129.0290350298737;19794.90102549507;21161.470963225736;21336.78663213379;21462.141514339564;21532.354029379145;1029.7219750667277;1051.8790339110947;1054.3884546962743;1063.994680026595;1069.2835800014009;11232.66302010941;11671.533138674527;11692.883071169179;11708.12189085822;11752.94123529394;608257;663052;665051;665667;672007;120381;127247.72752272358;128613;128897;128976.71023289835;972.9999999999858;992.712113487095;1051.621416290135;1066.626680661762;1068.3216157739892;17923;18880.52798680044;19208.423747287605;19298;19546;50838.98322033613;50950.49049509457;52319.738401307746;52733.47266527439;53072.67318316919;74490.25509744833;75325.35059870422;76143.61928190323;76693.61653191698;76782.61608692144;8364.623591938256;8388.454750441202;8509.36179786531;8510.914890851012;8638.308935285288;9906.504674766376;13004.21974681522;13420.597382078553;13519.121257118255;14102.224377659328;10739;11566.306021638393;11887.940560297144;12043.397830108635;12085;10306.142230131089;11388;11590.130740194687;11814.173007889365;12006.519739210335;11679;11883.82174267404;12175.330356830105;12303.384830758247;12339;8264.793380165544;8272.958635206785;8432.072472028194;8502.78743031429;8598.097199793932;11273.830892536454;11331.093512519143;11947.223430476992;12182.451789669309;12190.57332993341 10:14:49 INFO - PROCESS | 1661 | |3;mootools.html;1471.6173794813349;1478.3864696151097;1643.0224016710058;1912;2069.327468572714;8286.295664868487;8883.75627412162;9037.005929347766;9041.502717350542;9063.365564410495;8881.156290152425;8888.644454221823;9014.90985090149;9033.683821066264;9068.727938161866;2560.1807421625135;2595.5587550116525;2596.350912271932;2597.4025974025985;2600.7139214686367;2529.84820910745;2589.1714651311495;2592.7796137328255;2598.8050896182767;2599;2537.860417677027;2578.8194826362164;2587.40489687372;2588.2623452316093;2594.753498417657;2556.9360765980905;2570.3317137544186;2582.780463660591;2590.3912580543556;2593.247958092151;2560;2577.265479338398;2595.169545745362;2602.3103877472486;2605.9348516287246;9056.456612603199;9124.908750912538;9136.451812891248;9140;9187.81624367509;5577.191307260425;5642.802501912454;5712.171735098429;5746.540276777848;5759.769609215627;3665.706743460517;3748.4377343398437;3804.619538046201;3810.2950954073585;3833.616638336172;1056.7252514346249;1084.5553323137556;1086.2721976275914;1100.1254003067581;1119.2556949628488;12298.508059677602;12301.01591872648;12314.753704925852;12322.876771232352;12330.63008109758;4979.427365852974;5055.368078990126;5105.8723531912;5163.302954101148;5178.067947769362;10271.486425678686;10397.532111055021;10408.5836566538;10418.01028902253;10436.791264174673;5647.915281270784;5675.1770993205755;5695.145728140812;5743.8564035899435;5765.423457654201;4644.7213167210075;4653.837115700934;4771.5467030632035;4784.40194975628;5228.529432351107;4081.9795901020307;4109.3425051991535;4193.874183774492;4194.517630472535;4199.748015119103;1346.4479563378968;1368.5141774670049;1376.4769387632637;1380.5513208207374;1383.8131852200027;1410.400579753621;1434.2255182201495;1450.57933199371;1453.25157543865;1473.1455755661905;8336.374771892133;8426.831463370698;8445;8448.493090414471;8451.36614753896;464.1575540394174;529.8993191293641;538.7198656698495;543.4158279849178;545.6562365709577;5300.390455097713;6293.748250069946;6326.2092238470195;6379.776707815297;6392.9360706392345;10675.893241067646;11064.502097405637;11190.832137517944;11207.831882521768;11220.270682405617;10445.477726113664;10779.514921828537;10790.406527641055;10951;11018.39398833056;8484.32125429964;8596.312295016383;8651.307895368482;8661;8668.956655216683;6840.9315906842285;6896.4827637926355;7931.929189559336;8173.632186551738;8202.343812494866;9696.85454718194;9904.702858914245;9932.25508086882;9959;9984.750381240527;10030.949845250727;10252.333598316383;10266.897331026594;10270.589176432859;10413.9479302603;7585.734499292498;7606.923930760621;7668.501547399401;7691.807704807425;7759.92240077592;8450.492970421794;8481.830363392573;8530.232279094911;8537.18896704812;8545.658173673231;7446.888296675445;7609.391248700202;7613.809654758676;7737.6518056686455;7805;7531.924680753342;7570.470067095251;7604.923950760643;7644.655990480553;7775;8008.399370047153;8059.194080592129;8063.314618257279;8077.434579579373;8080.353571714131;7141.500094993508;7256.383207427428;7281.672324745293;7295.854082918206;7315.451341149329;7357.852842943004;7400.370968467525;7453.701851925862;7456.813579660552;7460 10:14:49 INFO - PROCESS | 1661 | |4;prototype.html;338.8627605819643;346.1087699174626;349.40775385721196;351.63956944132275;355.9893203203905;6892.724291028359;6915.273896240898;6919.4118499927445;6957.860842783141;6988.091548098746;6850.246472887979;6871.244163142051;6871.518993670445;6881.759138430156;6884.380405763481;4929;5033.874153146182;5054.393472783271;5129.974350128244;5156.948430515703;5125.923111153335;5139.306193663845;5147.330846989905;5161.819336323229;5171.17261238202;5076.263941728447;5104.387473503166;5108.8978220435565;5111.284420181178;5112.284280200774;4879.268109783526;4953.801847926079;4976.726280054596;4994.001199760062;4996.7501624918605;4372.3004319309075;4384.934225986613;4392.582704643054;4396.054848207618;4410.338449232609;5851.76592936282;6114.938850611481;6628.5691430056895;6654.467642588581;6660.200775906874;6017.097435384728;6028.879422411571;6029.397060293979;6035.3059398169335;6036.426539478743;7121.715131394738;7302.087239095114;7321.963390183015;7332.8900066499045;7341.816454588625;4881;4898.02039592083;4927.014597080598;4931.0630980113665;4939.629527785431;7542.094948606147;7606.467547271694;7625.389968802482;7628.351590114791;7721.884171737428;5006.07387633289;5012.448630650625;5014.498550144956;5018.949810501921;5027.145385284511;5097.515736005073;5098.59211263098;5103.413107492686;5109.770060347293;5112.105381558213;4893.95106048942;5602.1036634138345;5763.279590051244;5959.761609535657;6034.24571928509;6324.873502529924;7239.131304243525;7316.6341682915645;7318.743843965436;7340.743073992491;1604.4705247268373;1702.8807983441288;1759.9032053237195;1795.973060404095;1797.748315235868;1081.5781845080426;1143.2226086261255;1149.9195056346143;1173.0732721150196;1181.3030312115893;5283.577313814885;5572.247746554163;5726.742296596663;7104.893426598605;7133.072700548999;6112.816615501542;7624.42816788743;7642.057807744059;7660.5020673657145;7677.270659287359;7054.929450705427;7058.153021637437;7065.4700897432895;7068.787936361918;7088.149422069281;3603.7747165963174;3985.163115745726;4054.499835060987;4060.4924384451942;4065.0447144920918;6088.056351265561;7309.89035164473;7592.671282525536;7970.123286438487;8001.719939802079;6736.292689267654;7938.5236885787035;7943.086545047278;7953.880691789628;7955.204479552114;8018.4787988780545;8019.15798841125;8023;8026.237507436784;8032.919670803451;7365.7790266292095;7628;7657.6554055066545;7675.846483070419;7680.193579674277;7418.480706350504;7452.888206677013;7468.290512401313;7478.813029674302;7515;7811.4922530035365;7936.682532698627;7949;7953.403494737802;7953.8409231816195;4767.73777442244;4819.469858315512;4829.927551086666;4841.975790121027;4847.297141914473;6825.2151002633345;6942.930570694229;7259.346658800733;7625.351845093229;7631.122420921665;7232.710691572278;7270.200277969525;7297.379722723628;7328.926710732824;7333.6699848508015;7282.417406607353;7291.234420385783;7324.047873776375;7337.192908780136;7338.302861228175;7160.964195178991;7163.570185788869;7192.532485388433;7193.964030179815;7212.675429605575;7110.577884423033;7335.046443962251;7347.33873951347;7366.926330736838;7399.223081576572;6054.515638748801;6292;6770.32296770319;7004.649767511706;7207.13514378278 10:14:49 INFO - PROCESS | 1661 | |5;yui.html;725.9818504537386;750.051185250658;785.7407055671629;792.0614072324296;815.7430409421033;15304.770428443582;15566.610834729108;15634.765478517831;15661.373545058199;15732.528024159279;14581;14597;14619.561413157595;14639.780403293958;14646.926765366185;792.9444938854268;811.0510702478115;957.0955447102491;958.9691082086784;959.3524371049549;947.4362754161263;955.6655170690273;956.617353058775;957.0620791624212;981.3523074770653;835.064727505195;1017.760826205841;1018.1752780247986;1020.8877023527406;1047.738065483629;1046.3930920066343;1070.8340207267847;1071.7642118733866;1074.4949873559492;1075.999320631812;795.3358945280697;796.7729197178834;797.7407342613674;799.908010578785;811.3590263691676;13771.311434428238;13976.860231397657;14204.92897535516;14268.57194284173;14275.928620356832;12951.611451656465;13194.472221111144;13359.666008349868;13371.26458044807;13408.530701425501;10222.693319200436;10355.223358248086;10484.685459436228;10553.41956192409;10616.256862019662;3528;3616.692581130607;3629.219717760694;3654.9817250913843;3689.206820533598;68798;85548.57225713893;86267;89008.55495722545;89523.20953580957;9692.079252471003;9767.609295628095;9786.461744603972;10010.04904534068;10188.643397481053;22864.428389290068;22939;22989.96545155472;23024.539509210055;23076.653850192262;7783.29950304464;7792.142864284924;7821.765347039598;7875.212478752193;7894.052713674396;4207.368894665763;4235.53409124996;4289.356596510486;4374.912501749947;4396.428464299621;3740.8129593520216;3793.981030094832;3794.8102594870697;3801.809909504569;3831.942520862189;659.1233659233209;678.4979115454627;689.5001124185026;690.9723611055603;693.9410150137295;555.7888002559001;558.4471373340364;579.5189992306375;611.9663418511935;629.8267976306553;7904.20957904205;8409.831803363899;8475.406721529556;8578.957105214558;8766.736997890073;598.2252982387819;612.7457105301339;621.4407033669643;627.2786295759821;629.9055141728686;3795.2599243147874;3910.667593254548;3918.9020274493364;4034.7175697700877;4041.373587094005;91361;91756;92855.071449286;92990;93194;77850.61074694703;78907;79540.60229698815;79899.60050199828;82917.75623365655;53001;68967.65516172488;69749.65125174342;69794.60410791756;71145.57708845897;7814.21857814214;7947.682092716226;8023.799405014921;8061.395395345256;8374.95812520958;47079.52920470751;51114.16643751659;51383;51604.74197628988;52320;52869.94260114699;67104.66447667731;67457.66271168613;68332.658336708;69651.30348696448;11185.161112916727;11352.943235284101;11437.59968401102;11467.178396006695;11645.010174135294;11916.404179791149;12021.81967270509;12260.75478490443;12264.693382665504;12526.686832829253;11716.70708232301;11778.882211178121;11807.940960295144;11939.283642981449;12129.21160124589;11688.36311438902;12157.331346776013;12160.939195303967;12352.691182720144;12393.256404615751;11496.310221386744;11831.053515718893;11891.643250702493;11986.041116710468;12130.514779408724;9847.704568862946;10060.84908726355;10204.795904082026;10368.688939331832;10371.325863818827;9682.080202380763;9971.950140249251;9984.151347135576;10213.234007449619;10246 10:14:49 INFO - PROCESS | 1661 | __end_tp_report 10:14:49 INFO - PROCESS | 1661 | __start_cc_report 10:14:49 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1065 10:14:49 INFO - PROCESS | 1661 | __end_cc_report 10:14:49 INFO - PROCESS | 1661 | __startTimestamp1461777289128__endTimestamp 10:14:49 INFO - PROCESS | 1661 | 10:14:49 INFO - PROCESS | 1661 | ------- Summary: start ------- 10:14:49 INFO - PROCESS | 1661 | Number of tests: 6 10:14:49 INFO - PROCESS | 1661 | 10:14:49 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5951.06 Median:6283.18 stddev:645.43 (10.3%) stddev-sans-first:607.64 10:14:49 INFO - PROCESS | 1661 | Values: 3107.3 3673.3 3675.5 3681.1 3740.1 5922.5 5942.2 5987.7 5995.2 6046.6 5910.6 5967.9 5987.6 5999.0 6002.1 5240.7 5318.3 5342.0 5401.7 5426.8 5422.8 5436.4 5438.6 5441.6 5442.0 5351.0 5394.2 5412.7 5416.4 5425.2 5396.2 5410.9 5442.5 5445.5 5501.6 5151.3 5320.1 5334.4 5357.1 5365.2 5781.6 5823.4 5839.6 5863.4 5869.6 6310.5 6375.9 6392.1 6408.7 6416.8 6315.3 6320.8 6339.5 6359.1 6369.1 6064.7 6083.2 6086.6 6097.3 6136.1 6311.7 6365.3 6465.4 6480.9 6486.8 6341.3 6362.0 6373.8 6381.3 6381.8 6347.5 6381.3 6381.7 6395.6 6399.7 6288.6 6298.1 6304.1 6370.4 6386.1 5386.7 6315.0 6336.3 6375.6 6399.1 5019.0 5025.8 5046.4 5051.4 5054.2 4493.2 4591.4 4599.3 4614.2 4623.8 6076.6 6121.8 6159.3 6161.9 6177.7 6334.9 6344.3 6344.5 6350.3 6363.8 6051.2 6110.7 6133.6 6170.2 6172.9 5537.1 5588.0 5593.1 5605.1 5630.4 6545.6 6553.8 6575.6 6584.5 6596.1 6279.3 6311.1 6373.2 6378.2 6387.1 6563.6 6588.1 6617.7 6628.7 6640.4 6284.0 6312.1 6360.4 6365.9 6368.7 6227.0 6283.2 6322.9 6361.6 6381.0 6359.2 6361.0 6361.0 6375.9 6381.0 6363.1 6369.2 6375.9 6380.2 6393.4 6124.2 6188.9 6291.0 6299.5 6306.8 6310.8 6324.4 6369.3 6373.4 6382.3 6138.9 6261.2 6304.9 6316.8 6332.3 10:14:49 INFO - PROCESS | 1661 | 10:14:49 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:66007.16 Median:38899.51 stddev:138199.08 (355.3%) stddev-sans-first:138499.20 10:14:49 INFO - PROCESS | 1661 | Values: 480.9 591.8 627.0 668.7 672.5 40521.0 40966.8 41076.4 41090.8 41137.0 43893.0 44388.6 44508.8 44542.3 44588.3 9686.0 9928.5 9938.0 9940.2 9954.2 9719.4 9730.5 9832.2 9869.2 9873.5 9915.1 9933.9 9980.7 9997.9 10005.8 9885.7 9949.0 9958.9 9966.0 9966.3 9829.7 9858.0 9959.0 9977.2 9990.9 42854.1 43214.9 43300.8 43304.4 43320.6 3283.6 3438.9 3466.5 3691.6 3922.7 29315.0 30173.2 30230.2 30241.7 30559.0 2760.4 2805.6 2846.2 2858.9 2875.4 448409.5 487784.0 488059.1 488802.0 489179.0 64550.0 69749.7 69800.7 69806.3 69817.0 76889.6 79288.2 79538.6 79582.0 79819.6 18187.8 18533.8 18550.7 18552.8 18587.0 12600.3 13275.2 13953.1 14051.9 14091.9 18481.4 22064.9 23067.7 23192.8 23583.6 8767.7 8991.6 9455.2 9653.3 9712.3 1029.5 1037.4 1082.9 1126.3 1246.3 31369.5 32268.8 33144.3 33207.7 33699.7 1118.6 1168.1 1176.4 1206.5 1278.7 12147.1 15887.4 16970.6 16999.5 17231.9 659629.0 670377.0 671333.0 672299.0 673087.0 63420.0 64201.7 64202.4 64218.0 64251.7 1370.8 1421.7 1553.7 1577.9 1598.5 24570.4 26126.5 27909.6 28873.6 30081.0 49007.8 49440.3 49715.8 49844.0 49969.5 351592.0 352412.2 352426.0 352466.0 353622.0 34082.5 34865.1 35140.6 35666.3 35695.3 46612.8 46622.5 48157.6 48366.5 48554.5 31903.0 38746.0 38890.6 39131.0 39559.4 37046.8 37840.8 38336.4 38548.6 38575.0 37124.4 37588.1 37991.4 38908.4 38948.4 32827.0 33773.0 33916.5 33929.8 33932.5 22006.7 22469.6 23631.1 25168.4 25444.0 10:14:49 INFO - PROCESS | 1661 | 10:14:49 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:36167.63 Median:21297.36 stddev:108570.27 (509.8%) stddev-sans-first:108841.58 10:14:49 INFO - PROCESS | 1661 | Values: 382.9 383.2 388.6 394.4 394.7 16334.4 16688.2 19893.0 21227.9 21257.9 17055.3 22238.8 22267.0 22311.7 23092.8 5847.2 6150.3 6226.9 6241.3 6259.2 5819.3 6186.2 6204.8 6205.0 6208.0 6141.4 6157.2 6158.2 6158.7 6181.5 5658.4 5887.4 5898.7 5901.4 5904.4 5461.6 5556.7 5587.2 5638.8 5653.9 14250.7 14482.6 14483.9 23846.9 26703.6 2139.9 2205.5 2261.5 2268.5 2521.9 10177.0 10338.8 10372.6 10446.1 10519.2 1775.1 1825.3 1858.3 1875.9 1974.3 100795.0 105512.5 108515.0 108629.0 109226.4 11297.2 11656.5 11739.0 11888.5 12060.2 14476.2 14497.4 14522.9 14531.4 14573.9 7260.0 8965.5 9032.5 9068.1 9107.3 9193.4 9200.7 9213.2 9270.3 9273.1 4531.2 4577.8 4583.2 4588.0 4651.0 1682.4 1904.9 1962.4 1986.5 2008.9 745.8 876.8 1103.8 1112.9 1129.0 19794.9 21161.5 21336.8 21462.1 21532.4 1029.7 1051.9 1054.4 1064.0 1069.3 11232.7 11671.5 11692.9 11708.1 11752.9 608257.0 663052.0 665051.0 665667.0 672007.0 120381.0 127247.7 128613.0 128897.0 128976.7 973.0 992.7 1051.6 1066.6 1068.3 17923.0 18880.5 19208.4 19298.0 19546.0 50839.0 50950.5 52319.7 52733.5 53072.7 74490.3 75325.4 76143.6 76693.6 76782.6 8364.6 8388.5 8509.4 8510.9 8638.3 9906.5 13004.2 13420.6 13519.1 14102.2 10739.0 11566.3 11887.9 12043.4 12085.0 10306.1 11388.0 11590.1 11814.2 12006.5 11679.0 11883.8 12175.3 12303.4 12339.0 8264.8 8273.0 8432.1 8502.8 8598.1 11273.8 11331.1 11947.2 12182.5 12190.6 10:14:49 INFO - PROCESS | 1661 | 10:14:49 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:6248.28 Median:2879.21 stddev:3291.78 (114.3%) stddev-sans-first:3281.43 10:14:49 INFO - PROCESS | 1661 | Values: 1471.6 1478.4 1643.0 1912.0 2069.3 8286.3 8883.8 9037.0 9041.5 9063.4 8881.2 8888.6 9014.9 9033.7 9068.7 2560.2 2595.6 2596.4 2597.4 2600.7 2529.8 2589.2 2592.8 2598.8 2599.0 2537.9 2578.8 2587.4 2588.3 2594.8 2556.9 2570.3 2582.8 2590.4 2593.2 2560.0 2577.3 2595.2 2602.3 2605.9 9056.5 9124.9 9136.5 9140.0 9187.8 5577.2 5642.8 5712.2 5746.5 5759.8 3665.7 3748.4 3804.6 3810.3 3833.6 1056.7 1084.6 1086.3 1100.1 1119.3 12298.5 12301.0 12314.8 12322.9 12330.6 4979.4 5055.4 5105.9 5163.3 5178.1 10271.5 10397.5 10408.6 10418.0 10436.8 5647.9 5675.2 5695.1 5743.9 5765.4 4644.7 4653.8 4771.5 4784.4 5228.5 4082.0 4109.3 4193.9 4194.5 4199.7 1346.4 1368.5 1376.5 1380.6 1383.8 1410.4 1434.2 1450.6 1453.3 1473.1 8336.4 8426.8 8445.0 8448.5 8451.4 464.2 529.9 538.7 543.4 545.7 5300.4 6293.7 6326.2 6379.8 6392.9 10675.9 11064.5 11190.8 11207.8 11220.3 10445.5 10779.5 10790.4 10951.0 11018.4 8484.3 8596.3 8651.3 8661.0 8669.0 6840.9 6896.5 7931.9 8173.6 8202.3 9696.9 9904.7 9932.3 9959.0 9984.8 10030.9 10252.3 10266.9 10270.6 10413.9 7585.7 7606.9 7668.5 7691.8 7759.9 8450.5 8481.8 8530.2 8537.2 8545.7 7446.9 7609.4 7613.8 7737.7 7805.0 7531.9 7570.5 7604.9 7644.7 7775.0 8008.4 8059.2 8063.3 8077.4 8080.4 7141.5 7256.4 7281.7 7295.9 7315.5 7357.9 7400.4 7453.7 7456.8 7460.0 10:14:49 INFO - PROCESS | 1661 | 10:14:49 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:5980.51 Median:6837.73 stddev:1884.59 (27.6%) stddev-sans-first:1841.69 10:14:49 INFO - PROCESS | 1661 | Values: 338.9 346.1 349.4 351.6 356.0 6892.7 6915.3 6919.4 6957.9 6988.1 6850.2 6871.2 6871.5 6881.8 6884.4 4929.0 5033.9 5054.4 5130.0 5156.9 5125.9 5139.3 5147.3 5161.8 5171.2 5076.3 5104.4 5108.9 5111.3 5112.3 4879.3 4953.8 4976.7 4994.0 4996.8 4372.3 4384.9 4392.6 4396.1 4410.3 5851.8 6114.9 6628.6 6654.5 6660.2 6017.1 6028.9 6029.4 6035.3 6036.4 7121.7 7302.1 7322.0 7332.9 7341.8 4881.0 4898.0 4927.0 4931.1 4939.6 7542.1 7606.5 7625.4 7628.4 7721.9 5006.1 5012.4 5014.5 5018.9 5027.1 5097.5 5098.6 5103.4 5109.8 5112.1 4894.0 5602.1 5763.3 5959.8 6034.2 6324.9 7239.1 7316.6 7318.7 7340.7 1604.5 1702.9 1759.9 1796.0 1797.7 1081.6 1143.2 1149.9 1173.1 1181.3 5283.6 5572.2 5726.7 7104.9 7133.1 6112.8 7624.4 7642.1 7660.5 7677.3 7054.9 7058.2 7065.5 7068.8 7088.1 3603.8 3985.2 4054.5 4060.5 4065.0 6088.1 7309.9 7592.7 7970.1 8001.7 6736.3 7938.5 7943.1 7953.9 7955.2 8018.5 8019.2 8023.0 8026.2 8032.9 7365.8 7628.0 7657.7 7675.8 7680.2 7418.5 7452.9 7468.3 7478.8 7515.0 7811.5 7936.7 7949.0 7953.4 7953.8 4767.7 4819.5 4829.9 4842.0 4847.3 6825.2 6942.9 7259.3 7625.4 7631.1 7232.7 7270.2 7297.4 7328.9 7333.7 7282.4 7291.2 7324.0 7337.2 7338.3 7161.0 7163.6 7192.5 7194.0 7212.7 7110.6 7335.0 7347.3 7366.9 7399.2 6054.5 6292.0 6770.3 7004.6 7207.1 10:14:49 INFO - PROCESS | 1661 | 10:14:49 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:18508.31 Median:4385.67 stddev:25749.72 (587.1%) stddev-sans-first:25787.33 10:14:49 INFO - PROCESS | 1661 | Values: 726.0 750.1 785.7 792.1 815.7 15304.8 15566.6 15634.8 15661.4 15732.5 14581.0 14597.0 14619.6 14639.8 14646.9 792.9 811.1 957.1 959.0 959.4 947.4 955.7 956.6 957.1 981.4 835.1 1017.8 1018.2 1020.9 1047.7 1046.4 1070.8 1071.8 1074.5 1076.0 795.3 796.8 797.7 799.9 811.4 13771.3 13976.9 14204.9 14268.6 14275.9 12951.6 13194.5 13359.7 13371.3 13408.5 10222.7 10355.2 10484.7 10553.4 10616.3 3528.0 3616.7 3629.2 3655.0 3689.2 68798.0 85548.6 86267.0 89008.6 89523.2 9692.1 9767.6 9786.5 10010.0 10188.6 22864.4 22939.0 22990.0 23024.5 23076.7 7783.3 7792.1 7821.8 7875.2 7894.1 4207.4 4235.5 4289.4 4374.9 4396.4 3740.8 3794.0 3794.8 3801.8 3831.9 659.1 678.5 689.5 691.0 693.9 555.8 558.4 579.5 612.0 629.8 7904.2 8409.8 8475.4 8579.0 8766.7 598.2 612.7 621.4 627.3 629.9 3795.3 3910.7 3918.9 4034.7 4041.4 91361.0 91756.0 92855.1 92990.0 93194.0 77850.6 78907.0 79540.6 79899.6 82917.8 53001.0 68967.7 69749.7 69794.6 71145.6 7814.2 7947.7 8023.8 8061.4 8375.0 47079.5 51114.2 51383.0 51604.7 52320.0 52869.9 67104.7 67457.7 68332.7 69651.3 11185.2 11352.9 11437.6 11467.2 11645.0 11916.4 12021.8 12260.8 12264.7 12526.7 11716.7 11778.9 11807.9 11939.3 12129.2 11688.4 12157.3 12160.9 12352.7 12393.3 11496.3 11831.1 11891.6 11986.0 12130.5 9847.7 10060.8 10204.8 10368.7 10371.3 9682.1 9972.0 9984.2 10213.2 10246.0 10:14:49 INFO - PROCESS | 1661 | -------- Summary: end -------- 10:14:49 INFO - PROCESS | 1661 | 10:14:49 INFO - TEST-INFO | 1661: exit 0 10:14:49 INFO - TEST-OK | dromaeo_css | took 1111472ms 10:14:49 INFO - TEST-START | kraken 10:14:49 INFO - operating with platform_type : mac_ 10:14:49 INFO - Initialising browser for kraken test... 10:14:49 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmp_6Q2u1/profile http://localhost:49275/getInfo.html) 10:14:51 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 10:14:51 INFO - PROCESS | 1670 | colorDepth:24 10:14:51 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 10:14:51 INFO - PROCESS | 1670 | __metrics 10:14:51 INFO - PROCESS | 1670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:14:51 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:14:52 INFO - TEST-INFO | 1670: exit 0 10:14:52 INFO - Browser initialized. 10:14:52 INFO - Running cycle 1/1 for kraken test... 10:14:52 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmp_6Q2u1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:04 INFO - PROCESS | 1673 | RSS: Main: 157073408 10:15:04 INFO - PROCESS | 1673 | 10:15:06 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 10:15:07 INFO - PROCESS | 1673 | RSS: Main: 213417984 10:15:07 INFO - PROCESS | 1673 | 10:15:09 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 10:15:10 INFO - PROCESS | 1673 | RSS: Main: 224145408 10:15:10 INFO - PROCESS | 1673 | 10:15:13 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 10:15:14 INFO - PROCESS | 1673 | RSS: Main: 213164032 10:15:14 INFO - PROCESS | 1673 | 10:15:16 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 10:15:16 INFO - PROCESS | 1673 | RSS: Main: 216698880 10:15:16 INFO - PROCESS | 1673 | 10:15:18 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:15:19 INFO - PROCESS | 1673 | RSS: Main: 215322624 10:15:19 INFO - PROCESS | 1673 | 10:15:22 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 10:15:22 INFO - PROCESS | 1673 | RSS: Main: 215347200 10:15:22 INFO - PROCESS | 1673 | 10:15:25 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 10:15:26 INFO - PROCESS | 1673 | RSS: Main: 215375872 10:15:26 INFO - PROCESS | 1673 | 10:15:28 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 10:15:29 INFO - PROCESS | 1673 | RSS: Main: 215748608 10:15:29 INFO - PROCESS | 1673 | 10:15:31 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:15:31 INFO - PROCESS | 1673 | RSS: Main: 249266176 10:15:31 INFO - PROCESS | 1673 | 10:15:33 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:15:34 INFO - PROCESS | 1673 | RSS: Main: 249253888 10:15:34 INFO - PROCESS | 1673 | 10:15:36 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:15:36 INFO - PROCESS | 1673 | RSS: Main: 254349312 10:15:36 INFO - PROCESS | 1673 | 10:15:39 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:15:40 INFO - PROCESS | 1673 | RSS: Main: 255614976 10:15:40 INFO - PROCESS | 1673 | 10:15:42 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:15:43 INFO - PROCESS | 1673 | RSS: Main: 255778816 10:15:43 INFO - PROCESS | 1673 | 10:15:44 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 10:15:45 INFO - PROCESS | 1673 | RSS: Main: 317857792 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - PROCESS | 1673 | __start_tp_report 10:15:45 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 10:15:45 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 10:15:45 INFO - PROCESS | 1673 | |i|pagename|runs| 10:15:45 INFO - PROCESS | 1673 | |0;ai-astar;111;108;112;111;113;114;121;113;110;111 10:15:45 INFO - PROCESS | 1673 | |1;audio-beat-detection;155;120;152;151;115;140;112;149;147;119 10:15:45 INFO - PROCESS | 1673 | |2;audio-dft;181;185;182;180;183;185;186;183;185;183 10:15:45 INFO - PROCESS | 1673 | |3;audio-fft;74;71;78;114;58;74;82;84;141;59 10:15:45 INFO - PROCESS | 1673 | |4;audio-oscillator;87;93;127;77;80;83;115;76;78;114 10:15:45 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;89;86;90;86;118;131;90;88;89;86 10:15:45 INFO - PROCESS | 1673 | |6;imaging-darkroom;94;94;94;94;93;95;94;93;93;94 10:15:45 INFO - PROCESS | 1673 | |7;imaging-desaturate;86;84;85;86;87;85;86;84;84;87 10:15:45 INFO - PROCESS | 1673 | |8;json-parse-financial;56;57;56;54;87;87;87;87;54;54 10:15:45 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;63;60;65;73;75;71;65;64;64;65 10:15:45 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;83;82;81;79;81;79;78;78;82;82 10:15:45 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;104;124;132;103;127;128;126;138;118;128 10:15:45 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;135;123;139;129;127;153;170;170;155;135 10:15:45 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;66;67;85;96;92;94;65;66;65;66 10:15:45 INFO - PROCESS | 1673 | __end_tp_report 10:15:45 INFO - PROCESS | 1673 | __start_cc_report 10:15:45 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1180 10:15:45 INFO - PROCESS | 1673 | __end_cc_report 10:15:45 INFO - PROCESS | 1673 | __startTimestamp1461777345213__endTimestamp 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - PROCESS | 1673 | ------- Summary: start ------- 10:15:45 INFO - PROCESS | 1673 | Number of tests: 14 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:3.47 (3.1%) stddev-sans-first:3.64 10:15:45 INFO - PROCESS | 1673 | Values: 111.0 108.0 112.0 111.0 113.0 114.0 121.0 113.0 110.0 111.0 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:148.00 stddev:17.35 (11.7%) stddev-sans-first:16.99 10:15:45 INFO - PROCESS | 1673 | Values: 155.0 120.0 152.0 151.0 115.0 140.0 112.0 149.0 147.0 119.0 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:1.95 (1.1%) stddev-sans-first:1.88 10:15:45 INFO - PROCESS | 1673 | Values: 181.0 185.0 182.0 180.0 183.0 185.0 186.0 183.0 185.0 183.0 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:83.50 Median:74.00 stddev:25.51 (34.5%) stddev-sans-first:26.82 10:15:45 INFO - PROCESS | 1673 | Values: 74.0 71.0 78.0 114.0 58.0 74.0 82.0 84.0 141.0 59.0 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:79.00 stddev:18.73 (23.7%) stddev-sans-first:19.74 10:15:45 INFO - PROCESS | 1673 | Values: 87.0 93.0 127.0 77.0 80.0 83.0 115.0 76.0 78.0 114.0 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:95.30 Median:88.50 stddev:15.77 (17.8%) stddev-sans-first:16.56 10:15:45 INFO - PROCESS | 1673 | Values: 89.0 86.0 90.0 86.0 118.0 131.0 90.0 88.0 89.0 86.0 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 10:15:45 INFO - PROCESS | 1673 | Values: 94.0 94.0 94.0 94.0 93.0 95.0 94.0 93.0 93.0 94.0 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:1.17 (1.4%) stddev-sans-first:1.22 10:15:45 INFO - PROCESS | 1673 | Values: 86.0 84.0 85.0 86.0 87.0 85.0 86.0 84.0 84.0 87.0 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:72.00 stddev:16.47 (22.9%) stddev-sans-first:16.90 10:15:45 INFO - PROCESS | 1673 | Values: 56.0 57.0 56.0 54.0 87.0 87.0 87.0 87.0 54.0 54.0 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:65.00 stddev:4.81 (7.4%) stddev-sans-first:4.94 10:15:45 INFO - PROCESS | 1673 | Values: 63.0 60.0 65.0 73.0 75.0 71.0 65.0 64.0 64.0 65.0 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:81.50 stddev:1.84 (2.3%) stddev-sans-first:1.72 10:15:45 INFO - PROCESS | 1673 | Values: 83.0 82.0 81.0 79.0 81.0 79.0 78.0 78.0 82.0 82.0 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:127.50 stddev:11.39 (8.9%) stddev-sans-first:9.84 10:15:45 INFO - PROCESS | 1673 | Values: 104.0 124.0 132.0 103.0 127.0 128.0 126.0 138.0 118.0 128.0 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.60 Median:146.00 stddev:17.30 (11.9%) stddev-sans-first:18.07 10:15:45 INFO - PROCESS | 1673 | Values: 135.0 123.0 139.0 129.0 127.0 153.0 170.0 170.0 155.0 135.0 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:76.00 stddev:13.68 (18.0%) stddev-sans-first:14.00 10:15:45 INFO - PROCESS | 1673 | Values: 66.0 67.0 85.0 96.0 92.0 94.0 65.0 66.0 65.0 66.0 10:15:45 INFO - PROCESS | 1673 | -------- Summary: end -------- 10:15:45 INFO - PROCESS | 1673 | 10:15:45 INFO - TEST-INFO | 1673: exit 0 10:15:45 INFO - TEST-OK | kraken | took 56327ms 10:15:45 INFO - SUITE-END | took 1167s 10:15:46 INFO - Completed test suite (00:19:28) 10:15:46 INFO - javascript benchmark 10:15:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3107.3008573071056, 3673.3020726062064, 3675.4854320395134, 3681.134933290676, 3740.0649837540614, 5922.496587790032, 5942.1978032965535, 5987.700614969245, 5995.160677505148, 6046.606970546917, 5910.556708246877, 5967.925773360794, 5987.610805297652, 5999.0, 6002.06967919972, 5240.737963101848, 5318.30861987942, 5341.973290133544, 5401.70290634015, 5426.8371948841595, 5422.810201642943, 5436.429174936634, 5438.646487978289, 5441.564674826004, 5442.0, 5350.973245133769, 5394.244805727201, 5412.702301373423, 5416.4312747161575, 5425.213344065108, 5396.163594642837, 5410.945890541084, 5442.482964118402, 5445.455454454563, 5501.559875210014, 5151.253068305112, 5320.095583750772, 5334.439883812182, 5357.142857142839, 5365.168398898177, 5781.566382521328, 5823.388544202882, 5839.6204246724255, 5863.355030946593, 5869.618474799125, 6310.495160387158, 6375.904361434582, 6392.105105285264, 6408.67956602168, 6416.839579010562, 6315.273743519462, 6320.81037568869, 6339.524535659798, 6359.109724638554, 6369.108324834527, 6064.727087281083, 6083.239595050619, 6086.634801911855, 6097.268327800648, 6136.079588061737, 6311.747530098836, 6365.2679941806355, 6465.418112369909, 6480.902786458207, 6486.805395838132, 6341.302456729756, 6362.0, 6373.776917807947, 6381.329960354189, 6381.8085457436355, 6347.5239357047485, 6381.266154392304, 6381.712822922979, 6395.616263024233, 6399.712012959335, 6288.622682638965, 6298.149749783812, 6304.054391841169, 6370.426661600478, 6386.10594516768, 5386.703731294738, 6315.021171718391, 6336.334684858116, 6375.649339286384, 6399.104125422445, 5019.046381187636, 5025.773840177201, 5046.419661738947, 5051.419086804991, 5054.241863720398, 4493.191225579427, 4591.380163677861, 4599.2871104978785, 4614.192516309632, 4623.815047398134, 6076.635401875901, 6121.81881567809, 6159.29168145669, 6161.876762464725, 6177.660228687465, 6334.936650633527, 6344.302126766052, 6344.49244060474, 6350.269718982284, 6363.7772677956045, 6051.243594550681, 6110.663913484801, 6133.6319820810895, 6170.197874276315, 6172.938270617326, 5537.1140617501005, 5588.0, 5593.133064375028, 5605.1031834907035, 5630.408807075198, 6545.574537655038, 6553.839728737972, 6575.638339891352, 6584.5061620378665, 6596.109525214035, 6279.340669229665, 6311.084892690443, 6373.171487706569, 6378.170837791057, 6387.073874288295, 6563.573367731082, 6588.143541339595, 6617.702203400762, 6628.7017084230365, 6640.402363787282, 6283.96858015707, 6312.14786003902, 6360.427561519486, 6365.8726825464155, 6368.713407896748, 6227.0, 6283.183186185766, 6322.936770632235, 6361.554691171574, 6380.96809515968, 6359.17330747, 6360.968195158995, 6361.0, 6375.87248255023, 6380.96809515968, 6363.14097596837, 6369.20384951881, 6375.87248255023, 6380.234371875405, 6393.424591786761, 6124.197855633957, 6188.907166392418, 6291.02489114188, 6299.527535434769, 6306.779262725782, 6310.7791227306825, 6324.430801227912, 6369.267534233437, 6373.362663733589, 6382.266039405527, 6138.878900475427, 6261.217347831521, 6304.936950630435, 6316.810495685137, 6332.335104813928], "unit": "score", "name": "dojo.html", "value": 5910.5274687384}, {"lowerIsBetter": false, "replicates": [480.94950030246844, 591.7958304384986, 626.9968650156749, 668.7358493395109, 672.5258692621701, 40521.0, 40966.7951660242, 41076.38385424221, 41090.7672769817, 41137.0, 43893.0, 44388.55611443885, 44508.77745611267, 44542.33186502205, 44588.3311750324, 9685.95157024214, 9928.503574821267, 9938.0, 9940.15508681763, 9954.153896918771, 9719.368241064343, 9730.464824434654, 9832.213422926185, 9869.161121304698, 9873.506324683736, 9915.058069483388, 9933.90066099337, 9980.650677226298, 9997.90002099977, 10005.799884002316, 9885.703428897108, 9949.0, 9958.900410995906, 9966.003399660049, 9966.302358834884, 9829.655962041366, 9857.950710246474, 9958.950205249, 9977.201823854075, 9990.900090999143, 42854.14291714179, 43214.919627009265, 43300.78349608263, 43304.3504347435, 43320.566794332284, 3283.605967283941, 3438.896833094986, 3466.497357883118, 3691.5570131584113, 3922.7057970652313, 29315.0, 30173.245668858453, 30230.24424389386, 30241.69758302411, 30559.0, 2760.3651160233057, 2805.565137403685, 2846.245744877609, 2858.8999385021634, 2875.353045564752, 448409.5159048433, 487784.0, 488059.1194088085, 488802.0, 489179.0, 64550.0, 69749.65125174444, 69800.65099674571, 69806.30193697997, 69817.0, 76889.61555192189, 79288.20711792924, 79538.60230698809, 79582.0, 79819.60090199512, 18187.818121818877, 18533.81466185321, 18550.72173917392, 18552.814471855378, 18587.0, 12600.306983116017, 13275.203487790763, 13953.093048951785, 14051.929740351234, 14091.859081409055, 18481.353152639593, 22064.88967555152, 23067.653985190234, 23192.840357982033, 23583.646245306336, 8767.693130740394, 8991.595378207996, 9455.196308313733, 9653.324267301363, 9712.3201375903, 1029.4749677664445, 1037.408677054087, 1082.8538147350164, 1126.3298337489182, 1246.2833870524485, 31369.52945705816, 32268.83865580704, 33144.3371132576, 33207.66792332094, 33699.663003370144, 1118.6308518188978, 1168.112234701616, 1176.3823992403886, 1206.457094307565, 1278.7442511497738, 12147.149699521126, 15887.443939462064, 16970.57573560646, 16999.49001529956, 17231.913840430967, 659629.0, 670377.0, 671333.0, 672299.0, 673087.0, 63420.0, 64201.67899160474, 64202.35797642057, 64218.0, 64251.678741605996, 1370.766969615148, 1421.7062473149385, 1553.6581951970547, 1577.8579927806552, 1598.5044636163059, 24570.38062352897, 26126.477470450864, 27909.581356279265, 28873.56689649699, 30081.0, 49007.75496122639, 49440.25839612337, 49715.75142124266, 49844.0, 49969.50030499794, 351592.0, 352412.2379388087, 352426.0, 352466.0, 353622.0, 34082.488762669076, 34865.12837179091, 35140.64859351476, 35666.28667426585, 35695.28609427745, 46612.834679133295, 46622.53377466182, 48157.55527334186, 48366.516334836204, 48554.514454855, 31903.0, 38746.0, 38890.6110938887, 39131.02172445712, 39559.40660890032, 37046.814765927076, 37840.81079594584, 38336.42495362516, 38548.6145138545, 38575.035624108496, 37124.44313335356, 37588.060298492754, 37991.43012854864, 38908.41637375385, 38948.41577376285, 32827.0, 33772.98681039573, 33916.49125263172, 33929.83035084809, 33932.49101263532, 22006.669899951834, 22469.550608987403, 23631.054757810183, 25168.37079073038, 25443.982240710164], "unit": "score", "name": "ext.html", "value": 20814.351853610384}, {"lowerIsBetter": false, "replicates": [382.8686232183897, 383.2144104585599, 388.64439038279977, 394.37688452245453, 394.68228076398486, 16334.410831310965, 16688.249028793703, 19893.0, 21227.938603069844, 21257.93710314484, 17055.317787288524, 22238.777612223872, 22267.0, 22311.665325020098, 23092.845357732087, 5847.210626565402, 6150.261968563778, 6226.937730622681, 6241.251049874021, 6259.155014073087, 5819.30168379795, 6186.226721659793, 6204.8448788780415, 6205.0, 6208.0, 6141.447269745722, 6157.1995640566665, 6158.199434073586, 6158.6612736299485, 6181.474574661159, 5658.377578466366, 5887.4112588741, 5898.734556944905, 5901.439363260483, 5904.380040095771, 5461.644993075477, 5556.749946252428, 5587.161925711135, 5638.774449022034, 5653.9151912721345, 14250.71988481838, 14482.565523034325, 14483.927580362137, 23846.880765596063, 26703.599446008324, 2139.882306473143, 2205.5258119504383, 2261.547690461914, 2268.4555706630454, 2521.886515106806, 10176.982301769838, 10338.844917326247, 10372.636957706443, 10446.05985461312, 10519.211059170593, 1775.112443778111, 1825.3246298869503, 1858.3402891973426, 1875.8780679255806, 1974.3188599933, 100795.0, 105512.47243763732, 108515.0, 108628.99999999921, 109226.361604576, 11297.152713546353, 11656.475458604384, 11739.0, 11888.524459021542, 12060.155789094679, 14476.203808790618, 14497.420103195966, 14522.85477145215, 14531.418743250362, 14573.92713036428, 7260.0, 8965.50689712072, 9032.548372581345, 9068.093190681011, 9107.316951228684, 9193.402428842237, 9200.6779762708, 9213.216876565433, 9270.304727145356, 9273.072692730673, 4531.207038768202, 4577.816887324537, 4583.243764778841, 4587.954120458753, 4650.9767451162525, 1682.4195652499868, 1904.8571357148269, 1962.4112766170092, 1986.523234423728, 2008.8593798434263, 745.7688116683845, 876.8421684096796, 1103.779244151173, 1112.9054030407506, 1129.0290350298737, 19794.90102549507, 21161.470963225736, 21336.78663213379, 21462.141514339564, 21532.354029379145, 1029.7219750667277, 1051.8790339110947, 1054.3884546962743, 1063.994680026595, 1069.2835800014009, 11232.66302010941, 11671.533138674527, 11692.883071169179, 11708.12189085822, 11752.94123529394, 608257.0, 663052.0, 665051.0, 665667.0, 672007.0, 120381.0, 127247.72752272358, 128613.0, 128897.0, 128976.71023289835, 972.9999999999858, 992.712113487095, 1051.621416290135, 1066.626680661762, 1068.3216157739892, 17923.0, 18880.52798680044, 19208.423747287605, 19298.0, 19546.0, 50838.98322033613, 50950.49049509457, 52319.738401307746, 52733.47266527439, 53072.67318316919, 74490.25509744833, 75325.35059870422, 76143.61928190323, 76693.61653191698, 76782.61608692144, 8364.623591938256, 8388.454750441202, 8509.36179786531, 8510.914890851012, 8638.308935285288, 9906.504674766376, 13004.21974681522, 13420.597382078553, 13519.121257118255, 14102.224377659328, 10739.0, 11566.306021638393, 11887.940560297144, 12043.397830108635, 12085.0, 10306.142230131089, 11388.0, 11590.130740194687, 11814.173007889365, 12006.519739210335, 11679.0, 11883.82174267404, 12175.330356830105, 12303.384830758247, 12339.0, 8264.793380165544, 8272.958635206785, 8432.072472028194, 8502.78743031429, 8598.097199793932, 11273.830892536454, 11331.093512519143, 11947.223430476992, 12182.451789669309, 12190.57332993341], "unit": "score", "name": "jquery.html", "value": 9720.448281080102}, {"lowerIsBetter": false, "replicates": [1471.6173794813349, 1478.3864696151097, 1643.0224016710058, 1912.0, 2069.327468572714, 8286.295664868487, 8883.75627412162, 9037.005929347766, 9041.502717350542, 9063.365564410495, 8881.156290152425, 8888.644454221823, 9014.90985090149, 9033.683821066264, 9068.727938161866, 2560.1807421625135, 2595.5587550116525, 2596.350912271932, 2597.4025974025985, 2600.7139214686367, 2529.84820910745, 2589.1714651311495, 2592.7796137328255, 2598.8050896182767, 2599.0, 2537.860417677027, 2578.8194826362164, 2587.40489687372, 2588.2623452316093, 2594.753498417657, 2556.9360765980905, 2570.3317137544186, 2582.780463660591, 2590.3912580543556, 2593.247958092151, 2560.0, 2577.265479338398, 2595.169545745362, 2602.3103877472486, 2605.9348516287246, 9056.456612603199, 9124.908750912538, 9136.451812891248, 9140.0, 9187.81624367509, 5577.191307260425, 5642.802501912454, 5712.171735098429, 5746.540276777848, 5759.769609215627, 3665.706743460517, 3748.4377343398437, 3804.619538046201, 3810.2950954073585, 3833.616638336172, 1056.7252514346249, 1084.5553323137556, 1086.2721976275914, 1100.1254003067581, 1119.2556949628488, 12298.508059677602, 12301.01591872648, 12314.753704925852, 12322.876771232352, 12330.63008109758, 4979.427365852974, 5055.368078990126, 5105.8723531912, 5163.302954101148, 5178.067947769362, 10271.486425678686, 10397.532111055021, 10408.5836566538, 10418.01028902253, 10436.791264174673, 5647.915281270784, 5675.1770993205755, 5695.145728140812, 5743.8564035899435, 5765.423457654201, 4644.7213167210075, 4653.837115700934, 4771.5467030632035, 4784.40194975628, 5228.529432351107, 4081.9795901020307, 4109.3425051991535, 4193.874183774492, 4194.517630472535, 4199.748015119103, 1346.4479563378968, 1368.5141774670049, 1376.4769387632637, 1380.5513208207374, 1383.8131852200027, 1410.400579753621, 1434.2255182201495, 1450.57933199371, 1453.25157543865, 1473.1455755661905, 8336.374771892133, 8426.831463370698, 8445.0, 8448.493090414471, 8451.36614753896, 464.1575540394174, 529.8993191293641, 538.7198656698495, 543.4158279849178, 545.6562365709577, 5300.390455097713, 6293.748250069946, 6326.2092238470195, 6379.776707815297, 6392.9360706392345, 10675.893241067646, 11064.502097405637, 11190.832137517944, 11207.831882521768, 11220.270682405617, 10445.477726113664, 10779.514921828537, 10790.406527641055, 10951.0, 11018.39398833056, 8484.32125429964, 8596.312295016383, 8651.307895368482, 8661.0, 8668.956655216683, 6840.9315906842285, 6896.4827637926355, 7931.929189559336, 8173.632186551738, 8202.343812494866, 9696.85454718194, 9904.702858914245, 9932.25508086882, 9959.0, 9984.750381240527, 10030.949845250727, 10252.333598316383, 10266.897331026594, 10270.589176432859, 10413.9479302603, 7585.734499292498, 7606.923930760621, 7668.501547399401, 7691.807704807425, 7759.92240077592, 8450.492970421794, 8481.830363392573, 8530.232279094911, 8537.18896704812, 8545.658173673231, 7446.888296675445, 7609.391248700202, 7613.809654758676, 7737.6518056686455, 7805.0, 7531.924680753342, 7570.470067095251, 7604.923950760643, 7644.655990480553, 7775.0, 8008.399370047153, 8059.194080592129, 8063.314618257279, 8077.434579579373, 8080.353571714131, 7141.500094993508, 7256.383207427428, 7281.672324745293, 7295.854082918206, 7315.451341149329, 7357.852842943004, 7400.370968467525, 7453.701851925862, 7456.813579660552, 7460.0], "unit": "score", "name": "mootools.html", "value": 5026.494549294931}, {"lowerIsBetter": false, "replicates": [338.8627605819643, 346.1087699174626, 349.40775385721196, 351.63956944132275, 355.9893203203905, 6892.724291028359, 6915.273896240898, 6919.4118499927445, 6957.860842783141, 6988.091548098746, 6850.246472887979, 6871.244163142051, 6871.518993670445, 6881.759138430156, 6884.380405763481, 4929.0, 5033.874153146182, 5054.393472783271, 5129.974350128244, 5156.948430515703, 5125.923111153335, 5139.306193663845, 5147.330846989905, 5161.819336323229, 5171.17261238202, 5076.263941728447, 5104.387473503166, 5108.8978220435565, 5111.284420181178, 5112.284280200774, 4879.268109783526, 4953.801847926079, 4976.726280054596, 4994.001199760062, 4996.7501624918605, 4372.3004319309075, 4384.934225986613, 4392.582704643054, 4396.054848207618, 4410.338449232609, 5851.76592936282, 6114.938850611481, 6628.5691430056895, 6654.467642588581, 6660.200775906874, 6017.097435384728, 6028.879422411571, 6029.397060293979, 6035.3059398169335, 6036.426539478743, 7121.715131394738, 7302.087239095114, 7321.963390183015, 7332.8900066499045, 7341.816454588625, 4881.0, 4898.02039592083, 4927.014597080598, 4931.0630980113665, 4939.629527785431, 7542.094948606147, 7606.467547271694, 7625.389968802482, 7628.351590114791, 7721.884171737428, 5006.07387633289, 5012.448630650625, 5014.498550144956, 5018.949810501921, 5027.145385284511, 5097.515736005073, 5098.59211263098, 5103.413107492686, 5109.770060347293, 5112.105381558213, 4893.95106048942, 5602.1036634138345, 5763.279590051244, 5959.761609535657, 6034.24571928509, 6324.873502529924, 7239.131304243525, 7316.6341682915645, 7318.743843965436, 7340.743073992491, 1604.4705247268373, 1702.8807983441288, 1759.9032053237195, 1795.973060404095, 1797.748315235868, 1081.5781845080426, 1143.2226086261255, 1149.9195056346143, 1173.0732721150196, 1181.3030312115893, 5283.577313814885, 5572.247746554163, 5726.742296596663, 7104.893426598605, 7133.072700548999, 6112.816615501542, 7624.42816788743, 7642.057807744059, 7660.5020673657145, 7677.270659287359, 7054.929450705427, 7058.153021637437, 7065.4700897432895, 7068.787936361918, 7088.149422069281, 3603.7747165963174, 3985.163115745726, 4054.499835060987, 4060.4924384451942, 4065.0447144920918, 6088.056351265561, 7309.89035164473, 7592.671282525536, 7970.123286438487, 8001.719939802079, 6736.292689267654, 7938.5236885787035, 7943.086545047278, 7953.880691789628, 7955.204479552114, 8018.4787988780545, 8019.15798841125, 8023.0, 8026.237507436784, 8032.919670803451, 7365.7790266292095, 7628.0, 7657.6554055066545, 7675.846483070419, 7680.193579674277, 7418.480706350504, 7452.888206677013, 7468.290512401313, 7478.813029674302, 7515.0, 7811.4922530035365, 7936.682532698627, 7949.0, 7953.403494737802, 7953.8409231816195, 4767.73777442244, 4819.469858315512, 4829.927551086666, 4841.975790121027, 4847.297141914473, 6825.2151002633345, 6942.930570694229, 7259.346658800733, 7625.351845093229, 7631.122420921665, 7232.710691572278, 7270.200277969525, 7297.379722723628, 7328.926710732824, 7333.6699848508015, 7282.417406607353, 7291.234420385783, 7324.047873776375, 7337.192908780136, 7338.302861228175, 7160.964195178991, 7163.570185788869, 7192.532485388433, 7193.964030179815, 7212.675429605575, 7110.577884423033, 7335.046443962251, 7347.33873951347, 7366.926330736838, 7399.223081576572, 6054.515638748801, 6292.0, 6770.32296770319, 7004.649767511706, 7207.13514378278], "unit": "score", "name": "prototype.html", "value": 5358.162890748972}, {"lowerIsBetter": false, "replicates": [725.9818504537386, 750.051185250658, 785.7407055671629, 792.0614072324296, 815.7430409421033, 15304.770428443582, 15566.610834729108, 15634.765478517831, 15661.373545058199, 15732.528024159279, 14581.0, 14597.0, 14619.561413157595, 14639.780403293958, 14646.926765366185, 792.9444938854268, 811.0510702478115, 957.0955447102491, 958.9691082086784, 959.3524371049549, 947.4362754161263, 955.6655170690273, 956.617353058775, 957.0620791624212, 981.3523074770653, 835.064727505195, 1017.760826205841, 1018.1752780247986, 1020.8877023527406, 1047.738065483629, 1046.3930920066343, 1070.8340207267847, 1071.7642118733866, 1074.4949873559492, 1075.999320631812, 795.3358945280697, 796.7729197178834, 797.7407342613674, 799.908010578785, 811.3590263691676, 13771.311434428238, 13976.860231397657, 14204.92897535516, 14268.57194284173, 14275.928620356832, 12951.611451656465, 13194.472221111144, 13359.666008349868, 13371.26458044807, 13408.530701425501, 10222.693319200436, 10355.223358248086, 10484.685459436228, 10553.41956192409, 10616.256862019662, 3528.0, 3616.692581130607, 3629.219717760694, 3654.9817250913843, 3689.206820533598, 68798.0, 85548.57225713893, 86267.0, 89008.55495722545, 89523.20953580957, 9692.079252471003, 9767.609295628095, 9786.461744603972, 10010.04904534068, 10188.643397481053, 22864.428389290068, 22939.0, 22989.96545155472, 23024.539509210055, 23076.653850192262, 7783.29950304464, 7792.142864284924, 7821.765347039598, 7875.212478752193, 7894.052713674396, 4207.368894665763, 4235.53409124996, 4289.356596510486, 4374.912501749947, 4396.428464299621, 3740.8129593520216, 3793.981030094832, 3794.8102594870697, 3801.809909504569, 3831.942520862189, 659.1233659233209, 678.4979115454627, 689.5001124185026, 690.9723611055603, 693.9410150137295, 555.7888002559001, 558.4471373340364, 579.5189992306375, 611.9663418511935, 629.8267976306553, 7904.20957904205, 8409.831803363899, 8475.406721529556, 8578.957105214558, 8766.736997890073, 598.2252982387819, 612.7457105301339, 621.4407033669643, 627.2786295759821, 629.9055141728686, 3795.2599243147874, 3910.667593254548, 3918.9020274493364, 4034.7175697700877, 4041.373587094005, 91361.0, 91756.0, 92855.071449286, 92990.0, 93194.0, 77850.61074694703, 78907.0, 79540.60229698815, 79899.60050199828, 82917.75623365655, 53001.0, 68967.65516172488, 69749.65125174342, 69794.60410791756, 71145.57708845897, 7814.21857814214, 7947.682092716226, 8023.799405014921, 8061.395395345256, 8374.95812520958, 47079.52920470751, 51114.16643751659, 51383.0, 51604.74197628988, 52320.0, 52869.94260114699, 67104.66447667731, 67457.66271168613, 68332.658336708, 69651.30348696448, 11185.161112916727, 11352.943235284101, 11437.59968401102, 11467.178396006695, 11645.010174135294, 11916.404179791149, 12021.81967270509, 12260.75478490443, 12264.693382665504, 12526.686832829253, 11716.70708232301, 11778.882211178121, 11807.940960295144, 11939.283642981449, 12129.21160124589, 11688.36311438902, 12157.331346776013, 12160.939195303967, 12352.691182720144, 12393.256404615751, 11496.310221386744, 11831.053515718893, 11891.643250702493, 11986.041116710468, 12130.514779408724, 9847.704568862946, 10060.84908726355, 10204.795904082026, 10368.688939331832, 10371.325863818827, 9682.080202380763, 9971.950140249251, 9984.151347135576, 10213.234007449619, 10246.0], "unit": "score", "name": "yui.html", "value": 7153.361631823363}], "name": "dromaeo_css", "value": 7829.791285259937}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 112.0, 111.0, 113.0, 114.0, 121.0, 113.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [155.0, 120.0, 152.0, 151.0, 115.0, 140.0, 112.0, 149.0, 147.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 136.0}, {"lowerIsBetter": true, "replicates": [181.0, 185.0, 182.0, 180.0, 183.0, 185.0, 186.0, 183.0, 185.0, 183.0], "unit": "score", "name": "audio-dft", "value": 183.3}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 78.0, 114.0, 58.0, 74.0, 82.0, 84.0, 141.0, 59.0], "unit": "score", "name": "audio-fft", "value": 83.5}, {"lowerIsBetter": true, "replicates": [87.0, 93.0, 127.0, 77.0, 80.0, 83.0, 115.0, 76.0, 78.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 93.0}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 90.0, 86.0, 118.0, 131.0, 90.0, 88.0, 89.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 95.3}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 95.0, 94.0, 93.0, 93.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 93.8}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 85.0, 86.0, 87.0, 85.0, 86.0, 84.0, 84.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 85.4}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 56.0, 54.0, 87.0, 87.0, 87.0, 87.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 67.9}, {"lowerIsBetter": true, "replicates": [63.0, 60.0, 65.0, 73.0, 75.0, 71.0, 65.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 81.0, 79.0, 81.0, 79.0, 78.0, 78.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.5}, {"lowerIsBetter": true, "replicates": [104.0, 124.0, 132.0, 103.0, 127.0, 128.0, 126.0, 138.0, 118.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.8}, {"lowerIsBetter": true, "replicates": [135.0, 123.0, 139.0, 129.0, 127.0, 153.0, 170.0, 170.0, 155.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.6}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 85.0, 96.0, 92.0, 94.0, 65.0, 66.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.2}], "name": "kraken", "value": 1440.1999999999998}]} 10:15:46 INFO - Return code: 0 10:15:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:15:46 INFO - # TBPL SUCCESS # 10:15:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:15:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:15:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:15:46 INFO - 2016-04-27 10:15:46.535 screenresolution[1677:9672] starting screenresolution argv=screenresolution get 10:15:46 INFO - 2016-04-27 10:15:46.538 screenresolution[1677:9672] Display 0: 1600x1200x32@60 10:15:46 INFO - 2016-04-27 10:15:46.544 screenresolution[1678:9675] starting screenresolution argv=screenresolution list 10:15:46 INFO - Available Modes on Display 0 10:15:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:15:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:15:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:15:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:15:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:15:46 INFO - Intel Iris: 10:15:46 INFO - Chipset Model: Intel Iris 10:15:46 INFO - Type: GPU 10:15:46 INFO - Bus: Built-In 10:15:46 INFO - VRAM (Dynamic, Max): 1536 MB 10:15:46 INFO - Vendor: Intel (0x8086) 10:15:46 INFO - Device ID: 0x0a2e 10:15:46 INFO - Revision ID: 0x0009 10:15:46 INFO - Displays: 10:15:46 INFO - Display: 10:15:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:15:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:15:46 INFO - Display Serial Number: 1600x1200 60 10:15:46 INFO - Main Display: Yes 10:15:46 INFO - Mirror: Off 10:15:46 INFO - Online: Yes 10:15:46 INFO - Rotation: Supported 10:15:46 INFO - Return code: 0 10:15:46 INFO - Running post-action listener: _resource_record_post_action 10:15:46 INFO - Running post-run listener: _resource_record_post_run 10:15:47 INFO - Total resource usage - Wall time: 1192s; CPU: 52.0%; Read bytes: 37824000; Write bytes: 508881920; Read time: 400; Write time: 1815 10:15:47 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 194871808; Write bytes: 197400064; Read time: 17727; Write time: 422 10:15:47 INFO - run-tests - Wall time: 1170s; CPU: 52.0%; Read bytes: 36869632; Write bytes: 299898368; Read time: 377; Write time: 1351 10:15:47 INFO - Running post-run listener: _upload_blobber_files 10:15:47 INFO - Blob upload gear active. 10:15:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:15:47 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 10:15:47 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'] 10:15:47 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 10:15:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:15:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:15:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:15:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:15:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:15:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:15:49 INFO - (blobuploader) - INFO - Done attempting. 10:15:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:15:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:15:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:15:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:15:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:15:50 INFO - (blobuploader) - INFO - Done attempting. 10:15:50 INFO - (blobuploader) - INFO - Iteration through files over. 10:15:50 INFO - Return code: 0 10:15:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:15:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:15:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3bf82c7389d9871331fe438e563e647fdaa7eadf49207700286a8a1c99347f532b686fc36e5b12cad2e2f8e6b5a985abfb5dc0d162a998a4ceaa9348418a1228", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/afa8454509322931745d76352a5701939b104643d08b193df33bc037b7b2ce19c4eeadf7f4a3d48b6ed86d9850c32dbfcc060ddad6b6414540847f74fe0ff06b"} 10:15:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:15:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:15:50 INFO - Contents: 10:15:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3bf82c7389d9871331fe438e563e647fdaa7eadf49207700286a8a1c99347f532b686fc36e5b12cad2e2f8e6b5a985abfb5dc0d162a998a4ceaa9348418a1228", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/afa8454509322931745d76352a5701939b104643d08b193df33bc037b7b2ce19c4eeadf7f4a3d48b6ed86d9850c32dbfcc060ddad6b6414540847f74fe0ff06b"} 10:15:50 INFO - Running post-run listener: copy_logs_to_upload_dir 10:15:50 INFO - Copying logs to upload dir... 10:15:50 INFO - mkdir: /builds/slave/test/build/upload/logs 10:15:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.311154 ========= master_lag: 2.78 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-27 10:15:53.703141) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 10:15:53.709321) ========= 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.rYGfPgRW5C/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.fIgcmYSVzz/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3bf82c7389d9871331fe438e563e647fdaa7eadf49207700286a8a1c99347f532b686fc36e5b12cad2e2f8e6b5a985abfb5dc0d162a998a4ceaa9348418a1228", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/afa8454509322931745d76352a5701939b104643d08b193df33bc037b7b2ce19c4eeadf7f4a3d48b6ed86d9850c32dbfcc060ddad6b6414540847f74fe0ff06b"} build_url:https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010991 build_url: 'https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3bf82c7389d9871331fe438e563e647fdaa7eadf49207700286a8a1c99347f532b686fc36e5b12cad2e2f8e6b5a985abfb5dc0d162a998a4ceaa9348418a1228", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/afa8454509322931745d76352a5701939b104643d08b193df33bc037b7b2ce19c4eeadf7f4a3d48b6ed86d9850c32dbfcc060ddad6b6414540847f74fe0ff06b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 10:15:53.738531) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 10:15:53.738913) ========= 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.rYGfPgRW5C/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.fIgcmYSVzz/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005174 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 10:15:53.787805) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 10:15:53.788133) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 10:15:53.788519) ========= ========= Total master_lag: 2.93 =========