builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0007 starttime: 1462530101.95 results: success (0) buildid: 20160505123841 builduid: 1457772db7ef4c1982b4796b67a4914d revision: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 03:21:41.950011) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 03:21:41.950452) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 03:21:41.950751) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 03:21:41.968286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:21:41.968635) ========= 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.4M6a3Gdgf4/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.HATlHdO4R7/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-06 03:21:41-- 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% 16.5M=0.001s 2016-05-06 03:21:42 (16.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088071 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:21:42.074349) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:21:42.074891) ========= 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.4M6a3Gdgf4/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.HATlHdO4R7/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.021307 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:21:42.124377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 03:21:42.124759) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b --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-aurora --rev 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4M6a3Gdgf4/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.HATlHdO4R7/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-06 03:21:42,191 truncating revision to first 12 chars 2016-05-06 03:21:42,191 Setting DEBUG logging. 2016-05-06 03:21:42,191 attempt 1/10 2016-05-06 03:21:42,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0123e9f41ced?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 03:21:43,785 unpacking tar archive at: mozilla-aurora-0123e9f41ced/testing/mozharness/ program finished with exit code 0 elapsedTime=1.889173 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 03:21:44.031000) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 03:21:44.031320) ========= script_repo_revision: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 03:21:44.031724) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 03:21:44.032018) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 03:21:44.045399) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-05-06 03:21:44.045710) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4M6a3Gdgf4/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.HATlHdO4R7/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 03:21:44 INFO - MultiFileLogger online at 20160506 03:21:44 in /builds/slave/test 03:21:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:21:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:21:44 INFO - {'append_to_log': False, 03:21:44 INFO - 'base_work_dir': '/builds/slave/test', 03:21:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:21:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:21:44 INFO - 'branch': 'Mozilla-Aurora', 03:21:44 INFO - 'buildbot_json_path': 'buildprops.json', 03:21:44 INFO - 'config_files': ('talos/mac_config.py',), 03:21:44 INFO - 'default_actions': ('clobber', 03:21:44 INFO - 'read-buildbot-config', 03:21:44 INFO - 'download-and-extract', 03:21:44 INFO - 'populate-webroot', 03:21:44 INFO - 'create-virtualenv', 03:21:44 INFO - 'install', 03:21:44 INFO - 'run-tests'), 03:21:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:21:44 INFO - 'download_minidump_stackwalk': True, 03:21:44 INFO - 'download_symbols': 'ondemand', 03:21:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:21:44 INFO - 'tooltool.py': '/tools/tooltool.py', 03:21:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:21:44 INFO - '/tools/misc-python/virtualenv.py')}, 03:21:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:21:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:21:44 INFO - 'installer_path': 'installer.exe', 03:21:44 INFO - 'log_level': 'info', 03:21:44 INFO - 'log_name': 'talos', 03:21:44 INFO - 'log_to_console': True, 03:21:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:21:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:21:44 INFO - 'opt_config_files': (), 03:21:44 INFO - 'pip_index': False, 03:21:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:21:44 INFO - 'cmd': ('bash', 03:21:44 INFO - '-c', 03:21:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:21:44 INFO - 'enabled': True, 03:21:44 INFO - 'halt_on_failure': False, 03:21:44 INFO - 'name': 'check_screen_resolution'},), 03:21:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:21:44 INFO - 'cmd': ('bash', 03:21:44 INFO - '-c', 03:21:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:21:44 INFO - 'enabled': True, 03:21:44 INFO - 'halt_on_failure': False, 03:21:44 INFO - 'name': 'check_screen_resolution'},), 03:21:44 INFO - 'run_cmd_checks_enabled': True, 03:21:44 INFO - 'sps_profile': False, 03:21:44 INFO - 'sps_profile_interval': 0, 03:21:44 INFO - 'suite': 'dromaeojs-e10s', 03:21:44 INFO - 'system_bits': '32', 03:21:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:21:44 INFO - 'title': 't-yosemite-r7-0007', 03:21:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:21:44 INFO - 'use_talos_json': True, 03:21:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:21:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:21:44 INFO - 'work_dir': 'build'} 03:21:44 INFO - ##### 03:21:44 INFO - ##### Running clobber step. 03:21:44 INFO - ##### 03:21:44 INFO - Running pre-action listener: _resource_record_pre_action 03:21:44 INFO - Running main action method: clobber 03:21:44 INFO - rmtree: /builds/slave/test/build 03:21:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:21:45 INFO - Running post-action listener: _resource_record_post_action 03:21:45 INFO - ##### 03:21:45 INFO - ##### Running read-buildbot-config step. 03:21:45 INFO - ##### 03:21:45 INFO - Running pre-action listener: _resource_record_pre_action 03:21:45 INFO - Running main action method: read_buildbot_config 03:21:45 INFO - Using buildbot properties: 03:21:45 INFO - { 03:21:45 INFO - "project": "", 03:21:45 INFO - "product": "firefox", 03:21:45 INFO - "script_repo_revision": "production", 03:21:45 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:21:45 INFO - "repository": "", 03:21:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:21:45 INFO - "buildid": "20160505123841", 03:21:45 INFO - "pgo_build": "False", 03:21:45 INFO - "basedir": "/builds/slave/test", 03:21:45 INFO - "buildnumber": 0, 03:21:45 INFO - "slavename": "t-yosemite-r7-0007", 03:21:45 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 03:21:45 INFO - "platform": "yosemite_r7", 03:21:45 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:21:45 INFO - "branch": "mozilla-aurora", 03:21:45 INFO - "repo_path": "releases/mozilla-aurora", 03:21:45 INFO - "revision": "0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b", 03:21:45 INFO - "stage_platform": "macosx64", 03:21:45 INFO - "builduid": "1457772db7ef4c1982b4796b67a4914d", 03:21:45 INFO - "slavebuilddir": "test" 03:21:45 INFO - } 03:21:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 03:21:45 INFO - Running post-action listener: _resource_record_post_action 03:21:45 INFO - ##### 03:21:45 INFO - ##### Running download-and-extract step. 03:21:45 INFO - ##### 03:21:45 INFO - Running pre-action listener: _resource_record_pre_action 03:21:45 INFO - Running main action method: download_and_extract 03:21:45 INFO - mkdir: /builds/slave/test/build/tests 03:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:45 INFO - https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:21:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 03:21:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 03:21:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 03:21:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 03:21:47 INFO - Downloaded 1199 bytes. 03:21:47 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 03:21:47 INFO - Using the following test package requirements: 03:21:47 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 03:21:47 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:21:47 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 03:21:47 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:21:47 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 03:21:47 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:21:47 INFO - u'jsshell-mac.zip'], 03:21:47 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:21:47 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 03:21:47 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 03:21:47 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:21:47 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 03:21:47 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:21:47 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 03:21:47 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:21:47 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 03:21:47 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:21:47 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 03:21:47 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:21:47 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')]} 03:21:47 INFO - https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:21:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:21:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:21:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:21:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:21:48 INFO - Downloaded 18114223 bytes. 03:21:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:21:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:21:51 INFO - Return code: 0 03:21:51 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:51 INFO - https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:21:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:21:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:21:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:21:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:21:53 INFO - Downloaded 18114223 bytes. 03:21:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:21:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:21:56 INFO - Return code: 0 03:21:56 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')]} 03:21:56 INFO - https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:21:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 03:21:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 03:21:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 03:21:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:21:57 INFO - Downloaded 10840145 bytes. 03:21:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:21:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:21:57 INFO - Return code: 0 03:21: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')]} 03:21:57 INFO - https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 03:21:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:21:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:21:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 03:21:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 03:22:01 INFO - Downloaded 114081343 bytes. 03:22:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:22:01 INFO - mkdir: /builds/slave/test/properties 03:22:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:22:01 INFO - Writing to file /builds/slave/test/properties/build_url 03:22:01 INFO - Contents: 03:22:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:22:02 INFO - Running post-action listener: _resource_record_post_action 03:22:02 INFO - Running post-action listener: set_extra_try_arguments 03:22:02 INFO - ##### 03:22:02 INFO - ##### Running populate-webroot step. 03:22:02 INFO - ##### 03:22:02 INFO - Running pre-action listener: _resource_record_pre_action 03:22:02 INFO - Running main action method: populate_webroot 03:22:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:22:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:22:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:22:02 INFO - '--tppagecycles', 03:22:02 INFO - '7'], 03:22:02 INFO - 'tests': ['tsvgm']}}, 03:22:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:22:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:22:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:22:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:22:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:22:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:22:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:02 INFO - 'talos_options': ['--disable-e10s'], 03:22:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:02 INFO - 'talos_options': ['--disable-e10s'], 03:22:02 INFO - 'tests': ['damp', 'tps']}, 03:22:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:02 INFO - 'tests': ['damp', 'tps']}, 03:22:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:22:02 INFO - 'tests': ['dromaeo_dom']}, 03:22:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:22:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:22:02 INFO - 'tests': ['a11yr', 03:22:02 INFO - 'ts_paint', 03:22:02 INFO - 'tpaint', 03:22:02 INFO - 'sessionrestore', 03:22:02 INFO - 'sessionrestore_no_auto_restore', 03:22:02 INFO - 'tabpaint']}, 03:22:02 INFO - 'other-e10s': {'tests': ['a11yr', 03:22:02 INFO - 'ts_paint', 03:22:02 INFO - 'tpaint', 03:22:02 INFO - 'sessionrestore', 03:22:02 INFO - 'sessionrestore_no_auto_restore', 03:22:02 INFO - 'tabpaint']}, 03:22:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:22:02 INFO - 'ts_paint', 03:22:02 INFO - 'tpaint', 03:22:02 INFO - 'sessionrestore', 03:22:02 INFO - 'sessionrestore_no_auto_restore', 03:22:02 INFO - 'tabpaint']}, 03:22:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:22:02 INFO - 'ts_paint', 03:22:02 INFO - 'tpaint', 03:22:02 INFO - 'sessionrestore', 03:22:02 INFO - 'sessionrestore_no_auto_restore', 03:22:02 INFO - 'tabpaint']}, 03:22:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:22:02 INFO - 'tests': ['a11yr', 03:22:02 INFO - 'ts_paint', 03:22:02 INFO - 'tpaint', 03:22:02 INFO - 'sessionrestore', 03:22:02 INFO - 'sessionrestore_no_auto_restore', 03:22:02 INFO - 'tabpaint']}, 03:22:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:22:02 INFO - 'tests': ['a11yr', 03:22:02 INFO - 'ts_paint', 03:22:02 INFO - 'tpaint', 03:22:02 INFO - 'sessionrestore', 03:22:02 INFO - 'sessionrestore_no_auto_restore', 03:22:02 INFO - 'tabpaint']}, 03:22:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:22:02 INFO - 'tests': ['tsvgx', 03:22:02 INFO - 'tsvgr_opacity', 03:22:02 INFO - 'tart', 03:22:02 INFO - 'tscrollx', 03:22:02 INFO - 'cart']}, 03:22:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:22:02 INFO - 'tsvgr_opacity', 03:22:02 INFO - 'tart', 03:22:02 INFO - 'tscrollx', 03:22:02 INFO - 'cart']}, 03:22:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:02 INFO - 'talos_options': ['--disable-e10s'], 03:22:02 INFO - 'tests': ['tp5o']}, 03:22:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:02 INFO - 'tests': ['tp5o']}, 03:22:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:02 INFO - 'talos_options': ['--disable-e10s', 03:22:02 INFO - '--xperf_path', 03:22:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:02 INFO - 'tests': ['tp5n']}, 03:22:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:02 INFO - 'talos_options': ['--xperf_path', 03:22:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:02 INFO - 'tests': ['tp5n']}}, 03:22:02 INFO - 'talos.zip': {'path': '', 03:22:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:22:02 INFO - Running post-action listener: _resource_record_post_action 03:22:02 INFO - ##### 03:22:02 INFO - ##### Running create-virtualenv step. 03:22:02 INFO - ##### 03:22:02 INFO - Running pre-action listener: _resource_record_pre_action 03:22:02 INFO - Running main action method: create_virtualenv 03:22:02 INFO - Creating virtualenv /builds/slave/test/build/venv 03:22:02 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 03:22:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:22:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:22:02 INFO - Using real prefix '/tools/python27' 03:22:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:22:02 INFO - Installing distribute.............................................................................................................................................................................................done. 03:22:05 INFO - Installing pip.................done. 03:22:05 INFO - Return code: 0 03:22:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:05 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 0x104ebca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ecc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbab24a1710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5be00>, '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 0x104bc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d56b20>, '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.4M6a3Gdgf4/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.HATlHdO4R7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 03:22:05 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 03:22:05 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 03:22:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6a3Gdgf4/Render', 03:22:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:05 INFO - 'HOME': '/Users/cltbld', 03:22:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:05 INFO - 'LOGNAME': 'cltbld', 03:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:05 INFO - 'MOZ_NO_REMOTE': '1', 03:22:05 INFO - 'NO_EM_RESTART': '1', 03:22:05 INFO - 'PAGER': '/bin/cat', 03:22:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:05 INFO - 'PWD': '/builds/slave/test', 03:22:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:05 INFO - 'SHELL': '/bin/bash', 03:22:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HATlHdO4R7/Listeners', 03:22:05 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 03:22:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:05 INFO - 'USER': 'cltbld', 03:22:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:05 INFO - 'XPC_FLAGS': '0x0', 03:22:05 INFO - 'XPC_SERVICE_NAME': '0', 03:22:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:06 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 03:22:06 INFO - Cleaning up... 03:22:06 INFO - Return code: 0 03:22:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104ebca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ecc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbab24a1710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5be00>, '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 0x104bc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d56b20>, '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.4M6a3Gdgf4/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.HATlHdO4R7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 03:22:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:22:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6a3Gdgf4/Render', 03:22:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:06 INFO - 'HOME': '/Users/cltbld', 03:22:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:06 INFO - 'LOGNAME': 'cltbld', 03:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:06 INFO - 'MOZ_NO_REMOTE': '1', 03:22:06 INFO - 'NO_EM_RESTART': '1', 03:22:06 INFO - 'PAGER': '/bin/cat', 03:22:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:06 INFO - 'PWD': '/builds/slave/test', 03:22:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:06 INFO - 'SHELL': '/bin/bash', 03:22:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HATlHdO4R7/Listeners', 03:22:06 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 03:22:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:06 INFO - 'USER': 'cltbld', 03:22:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:06 INFO - 'XPC_FLAGS': '0x0', 03:22:06 INFO - 'XPC_SERVICE_NAME': '0', 03:22:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:06 INFO - Downloading/unpacking psutil>=0.7.1 03:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:22:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:09 INFO - Installing collected packages: psutil 03:22:09 INFO - Running setup.py install for psutil 03:22:09 INFO - building 'psutil._psutil_osx' extension 03:22:09 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 03:22:09 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 03:22:09 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 03:22:09 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 03:22:09 INFO - building 'psutil._psutil_posix' extension 03:22:09 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 03:22:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:22:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:22:09 INFO - ^ 03:22:09 INFO - 1 warning generated. 03:22:09 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 03:22:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:10 INFO - Successfully installed psutil 03:22:10 INFO - Cleaning up... 03:22:10 INFO - Return code: 0 03:22:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:10 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 0x104ebca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ecc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbab24a1710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5be00>, '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 0x104bc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d56b20>, '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.4M6a3Gdgf4/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.HATlHdO4R7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 03:22:10 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 03:22:10 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 03:22:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6a3Gdgf4/Render', 03:22:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:10 INFO - 'HOME': '/Users/cltbld', 03:22:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:10 INFO - 'LOGNAME': 'cltbld', 03:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:10 INFO - 'MOZ_NO_REMOTE': '1', 03:22:10 INFO - 'NO_EM_RESTART': '1', 03:22:10 INFO - 'PAGER': '/bin/cat', 03:22:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:10 INFO - 'PWD': '/builds/slave/test', 03:22:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:10 INFO - 'SHELL': '/bin/bash', 03:22:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HATlHdO4R7/Listeners', 03:22:10 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 03:22:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:10 INFO - 'USER': 'cltbld', 03:22:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:10 INFO - 'XPC_FLAGS': '0x0', 03:22:10 INFO - 'XPC_SERVICE_NAME': '0', 03:22:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:22:10 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 03:22:10 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 03:22:10 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 03:22:10 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 03:22:10 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 03:22:10 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 03:22:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:22:12 INFO - Installing collected packages: mozsystemmonitor 03:22:12 INFO - Running setup.py install for mozsystemmonitor 03:22:12 INFO - Successfully installed mozsystemmonitor 03:22:12 INFO - Cleaning up... 03:22:13 INFO - Return code: 0 03:22:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:13 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 0x104ebca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ecc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbab24a1710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5be00>, '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 0x104bc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d56b20>, '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.4M6a3Gdgf4/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.HATlHdO4R7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 03:22:13 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 03:22:13 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 03:22:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6a3Gdgf4/Render', 03:22:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:13 INFO - 'HOME': '/Users/cltbld', 03:22:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:13 INFO - 'LOGNAME': 'cltbld', 03:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:13 INFO - 'MOZ_NO_REMOTE': '1', 03:22:13 INFO - 'NO_EM_RESTART': '1', 03:22:13 INFO - 'PAGER': '/bin/cat', 03:22:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:13 INFO - 'PWD': '/builds/slave/test', 03:22:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:13 INFO - 'SHELL': '/bin/bash', 03:22:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HATlHdO4R7/Listeners', 03:22:13 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 03:22:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:13 INFO - 'USER': 'cltbld', 03:22:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:13 INFO - 'XPC_FLAGS': '0x0', 03:22:13 INFO - 'XPC_SERVICE_NAME': '0', 03:22:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:13 INFO - Downloading/unpacking blobuploader==1.2.4 03:22:13 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 03:22:13 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 03:22:13 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 03:22:13 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 03:22:13 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 03:22:13 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 03:22:15 INFO - Downloading blobuploader-1.2.4.tar.gz 03:22:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:22:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:22:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:16 INFO - Downloading docopt-0.6.1.tar.gz 03:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:22:16 INFO - Installing collected packages: blobuploader, requests, docopt 03:22:16 INFO - Running setup.py install for blobuploader 03:22:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:22:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:22:17 INFO - Running setup.py install for requests 03:22:17 INFO - Running setup.py install for docopt 03:22:17 INFO - Successfully installed blobuploader requests docopt 03:22:17 INFO - Cleaning up... 03:22:17 INFO - Return code: 0 03:22:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:17 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')]} 03:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:17 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')]} 03:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:17 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 0x104ebca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ecc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbab24a1710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5be00>, '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 0x104bc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d56b20>, '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.4M6a3Gdgf4/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.HATlHdO4R7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 03:22:17 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 03:22:17 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 03:22:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6a3Gdgf4/Render', 03:22:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:17 INFO - 'HOME': '/Users/cltbld', 03:22:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:17 INFO - 'LOGNAME': 'cltbld', 03:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:17 INFO - 'MOZ_NO_REMOTE': '1', 03:22:17 INFO - 'NO_EM_RESTART': '1', 03:22:17 INFO - 'PAGER': '/bin/cat', 03:22:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:17 INFO - 'PWD': '/builds/slave/test', 03:22:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:17 INFO - 'SHELL': '/bin/bash', 03:22:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HATlHdO4R7/Listeners', 03:22:17 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 03:22:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:17 INFO - 'USER': 'cltbld', 03:22:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:17 INFO - 'XPC_FLAGS': '0x0', 03:22:17 INFO - 'XPC_SERVICE_NAME': '0', 03:22:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:18 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-XEvmbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:18 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-soM5YI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:18 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-8Tud7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:18 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-n_YGcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:18 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-AyY_jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:18 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-Rxwouh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:18 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-p4TfWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:18 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-lvoEQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:18 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-l5BV9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-CYWEX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-sGAjft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-raxaDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-UND4PZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-UIQAIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-LQEvKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-oG1JNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-1UjmVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:22:19 INFO - Running setup.py install for manifestparser 03:22:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:22:20 INFO - Running setup.py install for mozcrash 03:22:20 INFO - Running setup.py install for mozdebug 03:22:20 INFO - Running setup.py install for mozdevice 03:22:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:22:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:22:20 INFO - Running setup.py install for mozfile 03:22:20 INFO - Running setup.py install for mozhttpd 03:22:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:22:20 INFO - Running setup.py install for mozinfo 03:22:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:22:20 INFO - Running setup.py install for mozInstall 03:22:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:22:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:22:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:22:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:22:21 INFO - Running setup.py install for mozleak 03:22:21 INFO - Running setup.py install for mozlog 03:22:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:22:21 INFO - Running setup.py install for moznetwork 03:22:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:22:21 INFO - Running setup.py install for mozprocess 03:22:21 INFO - Running setup.py install for mozprofile 03:22:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:22:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:22:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:22:21 INFO - Running setup.py install for mozrunner 03:22:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:22:22 INFO - Running setup.py install for mozscreenshot 03:22:22 INFO - Running setup.py install for moztest 03:22:22 INFO - Running setup.py install for mozversion 03:22:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:22:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:22:22 INFO - Cleaning up... 03:22:22 INFO - Return code: 0 03:22:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:22 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 0x104ebca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ecc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbab24a1710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5be00>, '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 0x104bc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d56b20>, '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.4M6a3Gdgf4/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.HATlHdO4R7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 03:22:22 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 03:22:22 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 03:22:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6a3Gdgf4/Render', 03:22:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:22 INFO - 'HOME': '/Users/cltbld', 03:22:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:22 INFO - 'LOGNAME': 'cltbld', 03:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:22 INFO - 'MOZ_NO_REMOTE': '1', 03:22:22 INFO - 'NO_EM_RESTART': '1', 03:22:22 INFO - 'PAGER': '/bin/cat', 03:22:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:22 INFO - 'PWD': '/builds/slave/test', 03:22:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:22 INFO - 'SHELL': '/bin/bash', 03:22:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HATlHdO4R7/Listeners', 03:22:22 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 03:22:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:22 INFO - 'USER': 'cltbld', 03:22:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:22 INFO - 'XPC_FLAGS': '0x0', 03:22:22 INFO - 'XPC_SERVICE_NAME': '0', 03:22:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:22 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-GsZc2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:22 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)) 03:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:22 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-arnZuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:22 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)) 03:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:22 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-WKjbHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:23 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)) 03:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-CpbVUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:23 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)) 03:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-09vWmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:23 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)) 03:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-iEknIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:23 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)) 03:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-0x3y7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:23 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)) 03:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-hURlJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:23 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)) 03:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ar_i3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:23 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)) 03:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-qDlThz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:23 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)) 03:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-3hEspT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:23 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)) 03:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-_8PLjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:24 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)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:24 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-2nAzmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:24 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)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:24 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-TQrlsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:24 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)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:24 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-j9mBy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:24 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)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:24 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-pkq90s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:24 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)) 03:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:24 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-UBhclj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:24 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)) 03:22:24 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)) 03:22:24 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)) 03:22:24 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)) 03:22:24 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)) 03:22:24 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)) 03:22:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:26 INFO - Downloading blessings-1.6.tar.gz 03:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:22:27 INFO - Installing collected packages: blessings 03:22:27 INFO - Running setup.py install for blessings 03:22:27 INFO - Successfully installed blessings 03:22:27 INFO - Cleaning up... 03:22:27 INFO - Return code: 0 03:22:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:22:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:27 INFO - Reading from file tmpfile_stdout 03:22:27 INFO - Current package versions: 03:22:27 INFO - blessings == 1.6 03:22:27 INFO - blobuploader == 1.2.4 03:22:27 INFO - docopt == 0.6.1 03:22:27 INFO - manifestparser == 1.1 03:22:27 INFO - mozInstall == 1.12 03:22:27 INFO - mozcrash == 0.17 03:22:27 INFO - mozdebug == 0.1 03:22:27 INFO - mozdevice == 0.48 03:22:27 INFO - mozfile == 1.2 03:22:27 INFO - mozhttpd == 0.7 03:22:27 INFO - mozinfo == 0.9 03:22:27 INFO - mozleak == 0.1 03:22:27 INFO - mozlog == 3.1 03:22:27 INFO - moznetwork == 0.27 03:22:27 INFO - mozprocess == 0.22 03:22:27 INFO - mozprofile == 0.28 03:22:27 INFO - mozrunner == 6.11 03:22:27 INFO - mozscreenshot == 0.1 03:22:27 INFO - mozsystemmonitor == 0.0 03:22:27 INFO - moztest == 0.7 03:22:27 INFO - mozversion == 1.4 03:22:27 INFO - psutil == 3.1.1 03:22:27 INFO - requests == 1.2.3 03:22:27 INFO - wsgiref == 0.1.2 03:22:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:27 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 0x104ebca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ecc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbab24a1710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5be00>, '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 0x104bc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d56b20>, '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.4M6a3Gdgf4/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.HATlHdO4R7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 03:22:27 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 03:22:27 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 03:22:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6a3Gdgf4/Render', 03:22:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:27 INFO - 'HOME': '/Users/cltbld', 03:22:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:27 INFO - 'LOGNAME': 'cltbld', 03:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:27 INFO - 'MOZ_NO_REMOTE': '1', 03:22:27 INFO - 'NO_EM_RESTART': '1', 03:22:27 INFO - 'PAGER': '/bin/cat', 03:22:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:27 INFO - 'PWD': '/builds/slave/test', 03:22:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:27 INFO - 'SHELL': '/bin/bash', 03:22:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HATlHdO4R7/Listeners', 03:22:27 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 03:22:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:27 INFO - 'USER': 'cltbld', 03:22:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:27 INFO - 'XPC_FLAGS': '0x0', 03:22:27 INFO - 'XPC_SERVICE_NAME': '0', 03:22:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:27 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)) 03:22:27 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)) 03:22:27 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)) 03:22:27 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)) 03:22:27 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)) 03:22:27 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)) 03:22:27 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)) 03:22:27 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)) 03:22:27 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)) 03:22:27 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)) 03:22:27 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)) 03:22:27 INFO - Cleaning up... 03:22:27 INFO - Return code: 0 03:22:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:27 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 0x104ebca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ecc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbab24a1710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5be00>, '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 0x104bc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d56b20>, '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.4M6a3Gdgf4/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.HATlHdO4R7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 03:22:27 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 03:22:27 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 03:22:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6a3Gdgf4/Render', 03:22:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:27 INFO - 'HOME': '/Users/cltbld', 03:22:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:27 INFO - 'LOGNAME': 'cltbld', 03:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:27 INFO - 'MOZ_NO_REMOTE': '1', 03:22:27 INFO - 'NO_EM_RESTART': '1', 03:22:27 INFO - 'PAGER': '/bin/cat', 03:22:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:27 INFO - 'PWD': '/builds/slave/test', 03:22:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:27 INFO - 'SHELL': '/bin/bash', 03:22:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HATlHdO4R7/Listeners', 03:22:27 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 03:22:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:27 INFO - 'USER': 'cltbld', 03:22:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:27 INFO - 'XPC_FLAGS': '0x0', 03:22:27 INFO - 'XPC_SERVICE_NAME': '0', 03:22:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:28 INFO - Downloading/unpacking jsonschema 03:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:22:30 INFO - Downloading/unpacking functools32 (from jsonschema) 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22:30 INFO - Downloading functools32-3.2.3-2.tar.gz 03:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:22:31 INFO - warning: no files found matching '*.txt' 03:22:31 INFO - no previously-included directories found matching 'build' 03:22:31 INFO - no previously-included directories found matching 'dist' 03:22:31 INFO - no previously-included directories found matching '.git*' 03:22:31 INFO - Installing collected packages: jsonschema, functools32 03:22:31 INFO - Running setup.py install for functools32 03:22:31 INFO - warning: no files found matching '*.txt' 03:22:31 INFO - no previously-included directories found matching 'build' 03:22:31 INFO - no previously-included directories found matching 'dist' 03:22:31 INFO - no previously-included directories found matching '.git*' 03:22:31 INFO - Successfully installed jsonschema functools32 03:22:31 INFO - Cleaning up... 03:22:31 INFO - Return code: 0 03:22:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:31 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 0x104ebca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ecc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbab24a1710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5be00>, '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 0x104bc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d56b20>, '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.4M6a3Gdgf4/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.HATlHdO4R7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 03:22:31 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 03:22:31 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 03:22:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6a3Gdgf4/Render', 03:22:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:31 INFO - 'HOME': '/Users/cltbld', 03:22:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:31 INFO - 'LOGNAME': 'cltbld', 03:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:31 INFO - 'MOZ_NO_REMOTE': '1', 03:22:31 INFO - 'NO_EM_RESTART': '1', 03:22:31 INFO - 'PAGER': '/bin/cat', 03:22:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:31 INFO - 'PWD': '/builds/slave/test', 03:22:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:31 INFO - 'SHELL': '/bin/bash', 03:22:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HATlHdO4R7/Listeners', 03:22:31 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 03:22:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:31 INFO - 'USER': 'cltbld', 03:22:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:31 INFO - 'XPC_FLAGS': '0x0', 03:22:31 INFO - 'XPC_SERVICE_NAME': '0', 03:22:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:31 INFO - Downloading/unpacking flake8 03:22:31 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 03:22:31 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 03:22:31 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 03:22:31 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 03:22:31 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 03:22:31 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 03:22:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:22:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:22:34 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 03:22:34 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 03:22:34 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 03:22:34 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 03:22:34 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 03:22:34 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 03:22:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:22:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:22:34 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 03:22:34 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 03:22:34 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 03:22:34 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 03:22:34 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 03:22:34 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 03:22:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:22:34 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 03:22:34 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 03:22:34 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 03:22:34 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 03:22:34 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 03:22:34 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 03:22:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:22:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:22:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:22:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:22:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:22:35 INFO - no previously-included directories found matching 'docs/_build' 03:22:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:22:35 INFO - Running setup.py install for pep8 03:22:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:22:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:22:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:22:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:22:35 INFO - no previously-included directories found matching 'docs/_build' 03:22:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:22:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:22:35 INFO - Cleaning up... 03:22:35 INFO - Return code: 0 03:22:35 INFO - Running post-action listener: _resource_record_post_action 03:22:35 INFO - Running post-action listener: _start_resource_monitoring 03:22:35 INFO - Starting resource monitoring. 03:22:35 INFO - ##### 03:22:35 INFO - ##### Running install step. 03:22:35 INFO - ##### 03:22:35 INFO - Running pre-action listener: _resource_record_pre_action 03:22:35 INFO - Running main action method: install 03:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:35 INFO - Reading from file tmpfile_stdout 03:22:35 INFO - Detecting whether we're running mozinstall >=1.0... 03:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:22:35 INFO - Reading from file tmpfile_stdout 03:22:35 INFO - Output received: 03:22:35 INFO - Usage: mozinstall [options] installer 03:22:35 INFO - Options: 03:22:35 INFO - -h, --help show this help message and exit 03:22:35 INFO - -d DEST, --destination=DEST 03:22:35 INFO - Directory to install application into. [default: 03:22:35 INFO - "/builds/slave/test"] 03:22:35 INFO - --app=APP Application being installed. [default: firefox] 03:22:35 INFO - mkdir: /builds/slave/test/build/application 03:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:23:07 INFO - Reading from file tmpfile_stdout 03:23:07 INFO - Output received: 03:23:07 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:23:07 INFO - Running post-action listener: _resource_record_post_action 03:23:07 INFO - ##### 03:23:07 INFO - ##### Running run-tests step. 03:23:07 INFO - ##### 03:23:07 INFO - Running pre-action listener: _resource_record_pre_action 03:23:07 INFO - Running main action method: run_tests 03:23:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:23:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:23:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:23:07 INFO - 2016-05-06 03:23:07.611 screenresolution[2516:21842] starting screenresolution argv=screenresolution get 03:23:07 INFO - 2016-05-06 03:23:07.613 screenresolution[2516:21842] Display 0: 1600x1200x32@60 03:23:07 INFO - 2016-05-06 03:23:07.619 screenresolution[2517:21845] starting screenresolution argv=screenresolution list 03:23:07 INFO - Available Modes on Display 0 03:23:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:23:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:23:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:23:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:23:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:23:07 INFO - Intel Iris: 03:23:07 INFO - Chipset Model: Intel Iris 03:23:07 INFO - Type: GPU 03:23:07 INFO - Bus: Built-In 03:23:07 INFO - VRAM (Dynamic, Max): 1536 MB 03:23:07 INFO - Vendor: Intel (0x8086) 03:23:07 INFO - Device ID: 0x0a2e 03:23:07 INFO - Revision ID: 0x0009 03:23:07 INFO - Displays: 03:23:07 INFO - Display: 03:23:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:23:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:23:07 INFO - Display Serial Number: 1600x1200 60 03:23:07 INFO - Main Display: Yes 03:23:07 INFO - Mirror: Off 03:23:07 INFO - Online: Yes 03:23:07 INFO - Rotation: Supported 03:23:07 INFO - Return code: 0 03:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:23:07 INFO - Python 2.7.3 03:23:07 INFO - Return code: 0 03:23:07 INFO - grabbing minidump binary from tooltool 03:23:07 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')]} 03:23:07 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 0x104d5be00>, '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 0x104bc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d56b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:23:07 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 03:23:07 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 03:23:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:23:07 INFO - Return code: 0 03:23:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:23:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:23:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:23:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:23:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:23:09 INFO - Return code: 0 03:23:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:23:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6a3Gdgf4/Render', 03:23:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:09 INFO - 'HOME': '/Users/cltbld', 03:23:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:09 INFO - 'LOGNAME': 'cltbld', 03:23:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:23:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:09 INFO - 'MOZ_NO_REMOTE': '1', 03:23:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:23:09 INFO - 'NO_EM_RESTART': '1', 03:23:09 INFO - 'PAGER': '/bin/cat', 03:23:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:09 INFO - 'PWD': '/builds/slave/test', 03:23:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:23:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:09 INFO - 'SHELL': '/bin/bash', 03:23:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HATlHdO4R7/Listeners', 03:23:09 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 03:23:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:09 INFO - 'USER': 'cltbld', 03:23:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:09 INFO - 'XPC_FLAGS': '0x0', 03:23:09 INFO - 'XPC_SERVICE_NAME': '0', 03:23:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:23:09 INFO - mozversion application_buildid: 20160505123841 03:23:09 INFO - mozversion application_changeset: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b 03:23:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:23:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:23:09 INFO - mozversion application_name: Firefox 03:23:09 INFO - mozversion application_remotingname: firefox-dev 03:23:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:23:09 INFO - mozversion application_vendor: Mozilla 03:23:09 INFO - mozversion application_version: 48.0a2 03:23:09 INFO - mozversion platform_buildid: 20160505123841 03:23:09 INFO - mozversion platform_changeset: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b 03:23:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:23:09 INFO - mozversion platform_version: 48.0a2 03:23:09 INFO - using testdate: 1462530189 03:23:09 INFO - actual date: 1462530189 03:23:09 INFO - starting webserver on 'localhost:54051' 03:23:09 INFO - SUITE-START | Running 2 tests 03:23:09 INFO - TEST-START | dromaeo_css 03:23:09 INFO - operating with platform_type : mac_ 03:23:09 INFO - Initialising browser for dromaeo_css test... 03:23:09 INFO - TEST-INFO | started process 2535 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmphrJ4gp/profile http://localhost:54051/getInfo.html) 03:23:11 INFO - PROCESS | 2535 | __metrics Screen width/height:1600/1200 03:23:11 INFO - PROCESS | 2535 | colorDepth:24 03:23:11 INFO - PROCESS | 2535 | Browser inner width/height: 1024/689 03:23:11 INFO - PROCESS | 2535 | __metrics 03:23:12 ERROR - PROCESS | 2535 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:23:12 INFO - TEST-INFO | 2535: exit 0 03:23:12 INFO - Browser initialized. 03:23:12 INFO - Running cycle 1/1 for dromaeo_css test... 03:23:12 INFO - TEST-INFO | started process 2538 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmphrJ4gp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:24 INFO - PROCESS | 2538 | RSS: Main: 221536256 03:23:24 INFO - PROCESS | 2538 | 03:24:14 INFO - PROCESS | 2538 | 1462530254514 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] 03:26:26 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:54051/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54051/tests/dromaeo/cssquery-ext.html) 03:26:27 INFO - PROCESS | 2538 | RSS: Main: 231788544 03:26:27 INFO - PROCESS | 2538 | 03:29:29 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:54051/tests/dromaeo/cssquery-ext.html (next: http://localhost:54051/tests/dromaeo/cssquery-jquery.html) 03:29:30 INFO - PROCESS | 2538 | RSS: Main: 243298304 03:29:30 INFO - PROCESS | 2538 | 03:32:32 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:54051/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54051/tests/dromaeo/cssquery-mootools.html) 03:32:32 INFO - PROCESS | 2538 | RSS: Main: 245334016 03:32:32 INFO - PROCESS | 2538 | 03:35:34 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:54051/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54051/tests/dromaeo/cssquery-prototype.html) 03:35:35 INFO - PROCESS | 2538 | RSS: Main: 247783424 03:35:35 INFO - PROCESS | 2538 | 03:38:37 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:54051/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54051/tests/dromaeo/cssquery-yui.html) 03:38:38 INFO - PROCESS | 2538 | RSS: Main: 250003456 03:38:38 INFO - PROCESS | 2538 | 03:41:40 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:54051/tests/dromaeo/cssquery-yui.html (next: http://localhost:54051/tests/dromaeo/cssquery-dojo.html) 03:41:40 INFO - PROCESS | 2538 | RSS: Main: 251019264 03:41:40 INFO - PROCESS | 2538 | 03:41:40 INFO - PROCESS | 2538 | __start_tp_report 03:41:40 INFO - PROCESS | 2538 | _x_x_mozilla_page_load 03:41:40 INFO - PROCESS | 2538 | _x_x_mozilla_page_load_details 03:41:40 INFO - PROCESS | 2538 | |i|pagename|runs| 03:41:40 INFO - PROCESS | 2538 | |0;dojo.html;3173.5398367236753;3520.542329497165;3538.203904121571;3564.9643503564957;3581.623929487404;5648.915266271004;5757.683327416996;5764.510016648579;5784;5795.15970184323;5711.143328500727;5768.567357448187;5783.566232532556;5790.971045144768;5798.739056742446;5161.819336323229;5220.347456567929;5273.2617433559335;5298.7350632468415;5312;5230.476952304777;5359.08895487768;5359.5712343012665;5369.328833895763;5378.435264297251;5281.445448227938;5304.018756530054;5335.986162629088;5338.652987555816;5357.919631205535;4553.248713962193;5193.376794784613;5319.654222475527;5326.973365133169;5366.543843773284;5176.171812510018;5256.369235691742;5274.736263186825;5283.445238249967;5364.168553874117;5835.620684655526;5843.6493810371085;5859.296884373903;5874.5006674432725;5891.909996650634;6160.1991741073825;6204;6280.528960327993;6299.65351905645;6300.716467758916;5193.2989046479;6191.81424557264;6194.318624951252;6235.906461403082;6272.498200144023;5870.442307980735;5889.116632505115;5917.349091599921;5932.792352267693;5990.6705131218205;5271.6309858310315;6247.312795592481;6364.809055728336;6444.871102577922;6473.579217350952;6206.627602343874;6241.251049874044;6253.218347706536;6257.74969001244;6276.780312689034;6299.905501417483;6324.968375158187;6327.778527751507;6332.430081292706;6392.105105285264;6118.984682626245;6180.6600636965395;6202.906956395657;6210.875782484415;6333.809985700436;6272.090546870678;6274.435300822948;6289.496840252768;6293.37066293367;6293.874122517615;4987.80048798044;5036.5718913892;5049.621278404061;5052.115879721107;5068.974655126701;4444.466664000341;4472.993576445274;4530.22986092365;4554.590086892195;4563.817447302137;5891.469767720926;5929.584929054925;5976.641401515923;5999.220101386879;6007.909881351783;6255.12428260044;6265.216847894013;6267.059941008794;6357.332480089616;6361.982082866719;5916.763329466859;5961.2846458425265;5968.343482216953;5969;5977.910331345033;5478.91781623276;5509.834704958857;5516.393196748354;5520.779168833202;5538.252335934678;4713.646476514206;6292.4966002719675;6428.582142160744;6431.710573024225;6522.869542609121;5419.807642318684;5512.834614961557;6302.338254483397;6303.991361382157;6341.143945567289;6512.218533775977;6539.771108011197;6556.704948277435;6562.639054851838;6584.308647591934;5977.3424923257535;6212.502999759918;6224.844378890564;6266.624002559861;6281.15204447412;6294.087357333069;6303.401176888188;6316.242050953915;6337.2395312562785;6346.365363463801;5131.384233891957;6092.177556030057;6171.444569988723;6173.536984726074;6174.135621013152;4933.309336692794;6058.394160583906;6135.44703110649;6137.997532011396;6144.371741488599;5224.2947202127225;5770.913436298543;5927.9703601481715;5950.642961422329;5954.3152537458745;4891.5353041461;6130.336988992987;6141.938580614136;6153.907691384543;6159.722812473539;6082.817515474543;6114.2357205349335;6134.7121296814075;6154.107654390178;6158.538109641884 03:41:40 INFO - PROCESS | 2538 | |1;ext.html;524.8792777661138;533.1416419564503;581.2734082397004;605.158829227374;619.6344156947401;31164;40809.79595102024;40962.385564216485;40995.79502102485;41084.79457602712;43884.561154388444;44463.55536444634;44587;45059;45349.77325113378;7367.4474414419;9585.37695049823;9750.658726944559;9757.268204884627;9767.706968790912;9617.903820961807;9650.758731031745;9669.806603867919;9728.756781080494;9756.121949024622;9697.272704547151;9720.659776907809;9788.608455661764;9791.461469619167;9792.363496372749;9675.564599593;9706.126448619658;9731.756706082333;9753.219742420624;9792.55933482995;9629.229661627052;9764.707058788177;9766.755831104208;9769.218462522982;9800.460974646392;40128.39807402891;40415.989600260225;40505;40880.79559602183;41063;2710.7018227994904;3095.1024202981334;3290.802551846873;3306.553615261957;3339.332133573295;27300.590491142648;27738.445231095466;28151.577726334122;28451.004214852586;29590.408191836043;2752.8348299102117;2791.79061570381;2800.80394372394;2836.702146274632;2846.9003584874636;408121.95939020114;409629;491780;498342.50828745984;500193;35330.82334588311;36353.63646363556;69024.6548767253;69493.65253173701;69708;36440;36584.81707591445;36691.4496282556;36831.63168368282;36863;15096.54710358691;15430.38278468871;15694.529164125095;15713.607159821097;15722.05667659944;12974.962003039735;13010.479580816851;13025.609231723063;13040.347982600832;13053.34733263333;8290.129536398712;8299.668013279523;8511.106333834858;8529.232369086812;8549.871751923725;3456.637053109387;3470.6355832637714;3500.2299494111253;3506.579210494757;3513.7364697647777;830.4145577367941;937.8124375125002;988.2390559269322;990.5294984882267;1132.5752842683994;31086;31303.843480782907;31395.37209255848;31703;31761.523577146363;950.4249928793118;1041.890601486848;1084.0352086642895;1096.1504833753745;1159.171192597297;16197.919010404872;16282.75575866363;16292;16364.6441393982;16413.42553010663;661604;675479;680540;683981;684186;63623.36376636267;64126;64771;65013;65041.349586504475;1461.8684318411395;1486.702659468089;1499.0930487055175;1503.6616761228636;1510.0486693383098;30525;30741.692583073884;30992.69007309898;31123;31151.84424077865;56801;56954;56980.715096424254;57186;57227.42772572221;582830;582877;585222;585789;585968;28455.43089138247;40213.39679904862;41081.58918410897;41479.58520414878;42196.57803421927;36433.63566364302;43693.34459983166;44355.77822110869;44779.552204478845;46436.53563464457;36680.63319366772;37447.25105497929;37745.43381849329;37886.98228381736;39497.01257468586;38555;38628.420573690855;38657.03677633276;39402.40896386614;39426.60573394229;34049;36796;37042.8147859259;37993.62006379901;38932.832015039596;32216.19459513531;32502.85326967306;32769;32846;33378.83310583432;25239;25710.871445642653;25908.740912590634;25996.35009124787;26304.34239144037 03:41:40 INFO - PROCESS | 2538 | |2;jquery.html;366.62237894968183;400.82163437270407;401.9809782202118;409.65793562375416;413.75381647919477;14549;19402.417927462182;20146.697799533;20188;20204;17249.655006899888;20195.59608807823;20317;20474.89762551189;21462.678059829115;4337.587929146734;5207.4792520748;5440.510354068133;5457.290552228204;5461.262729531502;5355.919661205085;5441.2654291670715;5467.289252397183;5474.945250547484;5478.863028424282;4399.494058183318;5076.883085721135;5530.889382212354;6019.458248757633;6030.8793824123495;5843.678597677126;5984.521238300926;6001.369856165127;6010.8797824043495;6031.306399764039;4355.629771469429;5279.788808447657;5341.919871201935;5360.544353729938;5363.812266570691;19898;23324.883375583013;23619.464734792182;25432.745672543224;25833.870830645916;2044.37646517812;2114.947126321839;2130.4567335329393;2316.93049208524;2405.9477335455085;10187.898121018769;10193.490325483695;10195.643152489702;10494.947525262402;10552.208584356127;1707.538964479596;1733.159417682423;1757.7890653121578;1817.9181936812874;1940.7185958036148;119593;124183.37908310401;129361.70638293591;130412;132605.99999999904;11865.16943813942;11898.821517677241;11978.101642376681;11982.161248712506;12056.397180140957;15362.231888405535;15495.535133946;15598;15679.764803527956;15682.294296756674;7214.531055481377;8847.911520884838;8933.28533717301;8981.640734370683;9124.315676324302;7190.928090719026;8172.959135204286;8175.223353781381;8712.956435217784;8991.370604057653;4708.976455117702;4812.230043193073;4830.275458681155;4842.903141937141;4847.587955023792;1994.2920263306607;2023.4132101690345;2027.9594408111755;2040.510277533411;2053.620080285152;881.6737807011447;954.5418199264392;970.1801977329145;991.9454430006275;1019.0726438940528;19780.70328945067;20799.96000199984;20968;21058.684119738216;21694.915254237225;946.5220063867703;991.8660980767504;996.367306760198;1004.5931397783909;1027.9023492768174;10965.671029869116;11206.663800086011;11212.355984305133;11475.540978360772;11601.535938562363;508710;515609;519825;633541;643454;141238;147497;147535;148715;150797;1023.3706270643501;1028.8508166315842;1054.4938429553856;1057.6245432871374;1074.1997212076897;18661.626767464848;19022.334218302294;19063.428097157106;19130.521736956132;19179.61640767205;50643;53733.73133134309;56088.71955640196;57373.85252295014;58186.127208091064;74092;76516.46967060739;77008.84486732815;77708.22291777236;77815.61092194503;8035;8304.958475207826;8541.316694664536;8580.528070956158;8717.694880679146;9996.3002589818;11922.880771192176;12879.484820607071;13009.804852927404;13073.215607063607;11005.911281108547;11079.72300692489;11083.778324433628;11362.204645675054;11372.601958931398;9509.953905070575;10392;10427.843582346119;10695.572177112828;11542.307461552333;11388.373639449579;11400.543978240778;11527.135464840338;11778.823317650413;11846.763064738829;8268.545230012407;8450.19723126302;8463.28062114727;8529.189726975927;8729.170728780755;10600.628977985734;11266.324020558464;11450.312981221154;11534.077273818242;11545.960863522323 03:41:40 INFO - PROCESS | 2538 | |3;mootools.html;1616.5958510372402;1628.1452237575274;1891.8391936685382;1958.6180694764528;1973.3093417303937;8173.632186551605;8805.559722013906;8811.339149563784;9174.85314335708;9197.540122993849;8794.560271986407;8815.338849586275;8911.554422278892;8945.910540894589;9060.954695226515;2450.779429851313;2451.2033589083576;2469.6789417375717;2483.9751602483925;2490.9626355604682;2441.7802397784194;2482.6648402465617;2488.340589743719;2494.950100997979;2498.088197807796;2437.6587277781123;2449.7917676997477;2482.168473561359;2485.0680994627014;2490.8007359411295;2428.2715185444385;2446.5473887330813;2457.5207834472285;2474.1711526638596;2476.3437689012426;2429.6962879640046;2457.741937096597;2457.852528848257;2467.728549859514;2490.9252722418355;9029.82612260402;9129.589168487433;9149.22231610314;9152.679656212;9154.084591540859;5339.65292256006;5462.453754624546;5464.617476776627;5520;5537.169424586304;3141.7643676724338;3217.48520236761;3380.4591265397416;3660.6156353583024;3696.796676182809;924.7364501117216;940.4451373689556;1041.812473754724;1044.9111825494842;1056.7675111475462;12008.63974080779;12076.973457256143;12136.575219867262;12161.69595760113;12170.513179472811;4398.274284743045;4658.720476771405;4921;5020.673656212334;5021.221710634857;10246.333988290886;10362.067413932782;10363.32638378503;10363.378197308186;10386.169106471463;5390.568754499709;5406.648567843077;5475.808346707846;5479.726013699299;5514.641548299348;4479.395281637003;4861.781219845045;4974.353334066548;5016.498350164954;5023.296738456619;4104.52797928242;4109.207410502865;4155.148194620096;4229.133027729308;4257.318828987409;1365.4333451617467;1381.3093453273364;1393.8048673185763;1394.065975796219;1406.4866323791946;930.4138392812484;936.1574582875467;938.877945867033;948.2414068744977;957.9941061884992;5811.79658711943;5937.10943358491;5967.582269241111;6129.509639228851;6178.66017369049;468.9109069276827;470.1255664464094;472.7069217085429;473.11055216193336;476.92130798418566;3076.7538596912195;3370.6292307846115;3558.679718825318;4055.209234199303;4116.711830171919;9496.002919693332;10698.839517407245;10779.730506737395;10999.945000274947;11023.503942322453;9161.679341223025;10797.08224800885;10902.563897444172;11050.944745276222;11085.944570277097;8224.671013159526;8247.092819789817;8301.252887240056;8328.125546817619;8366.49801011929;4531.614812740822;5829.446202610745;5845.620034697731;5938.317093534299;5973.850653733518;8431.95784021076;10053;10193.643222487177;10218.182545396201;10243.590256389662;8564.52895090776;9739.805203896025;9938.801223975335;10476.476176191312;10556.419396933243;6995.125609298838;7434.033575635132;7607.391408687181;7662.348700360531;7740.612969351622;8362.832743344978;8454.830903381775;8476.745697629081;8519.190676885686;8557.786055348666;7472.813179670335;7515.6993720250575;7554.924450755422;7752.5348479091435;7780.416468764978;7392.408607311295;7429.294217049372;7493.812654683677;7554.962225188839;7601.011868457065;7015.333543313377;7085.39774119185;7100.289971002859;7117.572945623279;7136.143662760502;4868.80524779019;4898.5549262968225;5006.299118123393;5085.237214417867;5086.9745651271505;4129.752214867118;4207.453031105937;4261.318189089855;4299.97850010748;4388.29787234041 03:41:40 INFO - PROCESS | 2538 | |4;prototype.html;305.89293747188486;306.7867831856859;309.7583884570035;313.1482367959153;314.1188964953305;5228.562145410014;5338.946610533893;5378.408375078739;5388.488093631108;5408.269883565722;4809.615230781538;4870.926936095952;5272.973635131829;5288.418273989858;5291.391489978653;3695.780392470478;3884.3685652026215;3916.8629097981575;4008.5590585035625;4045.352743561031;3303.38887305848;3849.634284742959;3944.270309992646;4003.379476181182;4040.474738284019;3997.4403583498333;4005.9198816023663;4016.297147999103;4042.3426395177985;4042.6967977401664;3744.57706071691;3850.4609354690365;3998.7400818946676;4010.2380547695843;4039.939400908989;3093.273080826004;3474.940143256306;3481.3733527964955;3497.387957107496;3517.243792584581;3900.902477438087;4375.496817865923;4593.5406459354135;4798.976005119987;5073.1122053640465;4454.794876536135;4487.618552423048;4626.676132670715;4627.745473998929;4638.124362894993;4882.829100981484;5465.863353416156;5572.192032155314;5600.299962504687;5614.663120212759;3330.9840498647904;3343.782654127474;3869.690424766012;3882.951603067156;3887.6393262357947;5373.59698022646;5683.261176047129;5780.682062486561;5871.618344807616;5902;3161.762867784925;3527.7177825773874;3544.964550354515;3990.960090399059;4016.638502534786;3361.815100169465;3431.3823511768123;3985.5416627087675;4028.71798974069;4037.6567991720444;3813.3326667833016;4628.699134556243;4649.5815376616265;4657.9737814050995;4668.183067963161;4753.882837533177;5324;5657.4908258256955;5661.433856614306;5670.489655930986;1405.9174435684465;1406.2827957741422;1464.7729601911722;1479.423025020243;1481.3482067890093;912.5026860361119;959.822432849911;982.7837875667342;987.4667679453158;992.4987881119988;3967.4806497873483;4266.679999000087;4632.814687412533;4954.835613630794;5077.568406685399;5809.651420914759;5809.954208242557;5830.562707796932;5836.678982655994;5850.414958504116;4623.375844261049;5043.672161309503;5207.973960130175;5237.633365664443;5249.7112658804135;2970.77719171063;3060.6021217241614;3228.467302895043;3295.967040329566;3324.667533246656;5841.240638716939;6055.909161362583;6526.869462610816;6550.868982620321;6654.70053847578;5659.575531835047;6049.969750151221;6154.476869466145;6448.903266451007;6495.545311828127;5235.1623740201385;5404.648697834707;6175.258968923668;6484.092227088211;6555.8361040973405;5335.039692855324;5540.396013873473;6274.59215151032;6312.936870631235;6320.4311611955145;5398.62209645321;5640.887182256414;6201.658908760061;6234.1583886174785;6242.781502647385;5048.798048078036;6509.641969691713;6515.674216289071;6516.892128338289;6530.869382612416;3529.3294274087843;4170.457840480718;4183.121544475573;4212.241796476541;4213.5365109837285;5168.612354073534;5231.607629427732;5363.302770639792;5419.593530485308;6278.843028924313;4985.501449854985;5034.748262586929;5905.507877673805;6057.878842423039;6084.178635884276;4522.432343333191;4668.556487133853;5346.518813306821;6012.609180403259;6052.093590518973;5061.317501724092;5761.942380576141;5830.883382332415;5885.764569417347;5894.852628684317;5310.442403547572;5431.701256430776;5580.414056524169;5584.7207639617045;5591.608587398843;5447.700376479332;5496.70197881268;5510.429527584619;5516.448355164452;5570.275864137636 03:41:40 INFO - PROCESS | 2538 | |5;yui.html;602.7619090459268;666.5049096554081;697.8255436140964;745.1207575061427;748.2031636307336;16602.169891505422;16773.664526709457;17313.480595582136;17337.21982510787;17352.65294694107;16260.18699065048;16513.091779952098;16523.58691032725;16524;16573.66852662946;724.9238829922848;902.9683961061364;935.8409070458005;936.9250459963221;939.1829108675462;912.447968978765;915.3775432705758;923.9538023098818;928.633189889993;929.0802105915129;990.6433683873836;991.33085167512;993.4833886379079;993.9503024848765;997.306871724152;982.4105536677936;984.0798853072364;985.9852102218473;987.6987518806761;988.5650313861878;720.6144712578798;737.0455260437745;737.2885165814961;737.6533029476192;738.4830618567024;15197.696046079016;15239.542813715607;15504.147271900041;15517.689646207013;15536;10005.449700266483;10459.84310235347;12167.878321216851;12372.072094592851;12444.502219911192;9856.50717464131;9881.16010139139;9892.752681183028;10008.29941904067;10092.39445633257;3479.565054368204;3488.651134886491;3534.0811389038777;3580.480830279621;3587.282543491286;75342;75941.6202918993;76631.70104896862;77659.6117019417;78259.60870195669;7991.480553763987;9344.579493922789;9441.527923603793;9477.857832132524;9512.809743805085;20951.95240237982;20964.685529717066;20983.895080524806;20985.37043888655;21041.263555775473;7286.526375785557;7409.259074092548;7456;7473.065866766654;7652.73215437457;4096.774677392772;4154.231467178582;4164.229617520768;4165.8333666653;4169.2703776838935;3537.893863184109;3574.8927532174075;3619;3619.819009049537;3635.927281454409;637.9649119298483;640.2668944059119;646.0503060501056;664.1532046640475;678.2471456683078;563.9182318563785;571.3771988532519;589.7559785018047;590.1236663554618;603.5352778360638;7822.921770782219;7844.209019896236;7927.801804954922;8021.759347219593;8391.076981532027;589.5637228451001;589.9646121057517;605.5518916002214;611.5627326461602;619.7242227208849;3382.188274814027;3561.5904171020147;3729.9254014919547;3801.258754542838;3978.5225772906856;73884;93462;95447.52276238575;96504;96934.51532742291;66837.33162668408;67529.66235168891;71752.28247717457;79140.60429697814;79422.60288698635;66524.66737666377;68031.65984170047;68101;68254.31745682479;68944.96582551266;7564.167941526538;7581.166071731995;7693.346065584488;7710.537367757953;7794.571298578632;39183;41078.74066926228;44916.10167796691;44999.775001124784;45505.31742023806;42761;60925.78148437095;60977.69511152416;63744;64107.67946160239;7574.962125189339;9251;9941.65204217849;10173.135283500986;10237;10924.508397122308;11014.669559913216;11048.668539943814;11193.776124477628;11612.651620451063;8268;10099.343542669703;10178.338408003456;10271.94864025675;10683.626073087406;9715.514224288898;10236.129928956123;10283.485825708534;10642.946785266024;10716;9814.116729494379;9898.554565044735;9974.750631234278;10151.84772228432;10273.229507786797;8686.39195256326;8879.644814207359;8992.034692897518;9110.817783644157;9151.405158664666;7806.1803510632835;8556.786080348042;8767.01996744857;9023.323250756088;9101.726948191565 03:41:40 INFO - PROCESS | 2538 | __end_tp_report 03:41:40 INFO - PROCESS | 2538 | __start_cc_report 03:41:40 INFO - PROCESS | 2538 | _x_x_mozilla_cycle_collect,415 03:41:40 INFO - PROCESS | 2538 | __end_cc_report 03:41:40 INFO - PROCESS | 2538 | __startTimestamp1462531300920__endTimestamp 03:41:40 INFO - PROCESS | 2538 | 03:41:40 INFO - PROCESS | 2538 | ------- Summary: start ------- 03:41:40 INFO - PROCESS | 2538 | Number of tests: 6 03:41:40 INFO - PROCESS | 2538 | 03:41:40 INFO - PROCESS | 2538 | [#0] dojo.html Cycles:165 Average:5777.08 Median:5969.00 stddev:650.58 (10.9%) stddev-sans-first:619.69 03:41:40 INFO - PROCESS | 2538 | Values: 3173.5 3520.5 3538.2 3565.0 3581.6 5648.9 5757.7 5764.5 5784.0 5795.2 5711.1 5768.6 5783.6 5791.0 5798.7 5161.8 5220.3 5273.3 5298.7 5312.0 5230.5 5359.1 5359.6 5369.3 5378.4 5281.4 5304.0 5336.0 5338.7 5357.9 4553.2 5193.4 5319.7 5327.0 5366.5 5176.2 5256.4 5274.7 5283.4 5364.2 5835.6 5843.6 5859.3 5874.5 5891.9 6160.2 6204.0 6280.5 6299.7 6300.7 5193.3 6191.8 6194.3 6235.9 6272.5 5870.4 5889.1 5917.3 5932.8 5990.7 5271.6 6247.3 6364.8 6444.9 6473.6 6206.6 6241.3 6253.2 6257.7 6276.8 6299.9 6325.0 6327.8 6332.4 6392.1 6119.0 6180.7 6202.9 6210.9 6333.8 6272.1 6274.4 6289.5 6293.4 6293.9 4987.8 5036.6 5049.6 5052.1 5069.0 4444.5 4473.0 4530.2 4554.6 4563.8 5891.5 5929.6 5976.6 5999.2 6007.9 6255.1 6265.2 6267.1 6357.3 6362.0 5916.8 5961.3 5968.3 5969.0 5977.9 5478.9 5509.8 5516.4 5520.8 5538.3 4713.6 6292.5 6428.6 6431.7 6522.9 5419.8 5512.8 6302.3 6304.0 6341.1 6512.2 6539.8 6556.7 6562.6 6584.3 5977.3 6212.5 6224.8 6266.6 6281.2 6294.1 6303.4 6316.2 6337.2 6346.4 5131.4 6092.2 6171.4 6173.5 6174.1 4933.3 6058.4 6135.4 6138.0 6144.4 5224.3 5770.9 5928.0 5950.6 5954.3 4891.5 6130.3 6141.9 6153.9 6159.7 6082.8 6114.2 6134.7 6154.1 6158.5 03:41:40 INFO - PROCESS | 2538 | 03:41:40 INFO - PROCESS | 2538 | [#1] ext.html Cycles:180 Average:70043.21 Median:40170.90 stddev:155838.07 (387.9%) stddev-sans-first:156187.83 03:41:40 INFO - PROCESS | 2538 | Values: 524.9 533.1 581.3 605.2 619.6 31164.0 40809.8 40962.4 40995.8 41084.8 43884.6 44463.6 44587.0 45059.0 45349.8 7367.4 9585.4 9750.7 9757.3 9767.7 9617.9 9650.8 9669.8 9728.8 9756.1 9697.3 9720.7 9788.6 9791.5 9792.4 9675.6 9706.1 9731.8 9753.2 9792.6 9629.2 9764.7 9766.8 9769.2 9800.5 40128.4 40416.0 40505.0 40880.8 41063.0 2710.7 3095.1 3290.8 3306.6 3339.3 27300.6 27738.4 28151.6 28451.0 29590.4 2752.8 2791.8 2800.8 2836.7 2846.9 408122.0 409629.0 491780.0 498342.5 500193.0 35330.8 36353.6 69024.7 69493.7 69708.0 36440.0 36584.8 36691.4 36831.6 36863.0 15096.5 15430.4 15694.5 15713.6 15722.1 12975.0 13010.5 13025.6 13040.3 13053.3 8290.1 8299.7 8511.1 8529.2 8549.9 3456.6 3470.6 3500.2 3506.6 3513.7 830.4 937.8 988.2 990.5 1132.6 31086.0 31303.8 31395.4 31703.0 31761.5 950.4 1041.9 1084.0 1096.2 1159.2 16197.9 16282.8 16292.0 16364.6 16413.4 661604.0 675479.0 680540.0 683981.0 684186.0 63623.4 64126.0 64771.0 65013.0 65041.3 1461.9 1486.7 1499.1 1503.7 1510.0 30525.0 30741.7 30992.7 31123.0 31151.8 56801.0 56954.0 56980.7 57186.0 57227.4 582830.0 582877.0 585222.0 585789.0 585968.0 28455.4 40213.4 41081.6 41479.6 42196.6 36433.6 43693.3 44355.8 44779.6 46436.5 36680.6 37447.3 37745.4 37887.0 39497.0 38555.0 38628.4 38657.0 39402.4 39426.6 34049.0 36796.0 37042.8 37993.6 38932.8 32216.2 32502.9 32769.0 32846.0 33378.8 25239.0 25710.9 25908.7 25996.4 26304.3 03:41:40 INFO - PROCESS | 2538 | 03:41:40 INFO - PROCESS | 2538 | [#2] jquery.html Cycles:180 Average:34828.70 Median:11586.82 stddev:95871.29 (827.4%) stddev-sans-first:96105.32 03:41:40 INFO - PROCESS | 2538 | Values: 366.6 400.8 402.0 409.7 413.8 14549.0 19402.4 20146.7 20188.0 20204.0 17249.7 20195.6 20317.0 20474.9 21462.7 4337.6 5207.5 5440.5 5457.3 5461.3 5355.9 5441.3 5467.3 5474.9 5478.9 4399.5 5076.9 5530.9 6019.5 6030.9 5843.7 5984.5 6001.4 6010.9 6031.3 4355.6 5279.8 5341.9 5360.5 5363.8 19898.0 23324.9 23619.5 25432.7 25833.9 2044.4 2114.9 2130.5 2316.9 2405.9 10187.9 10193.5 10195.6 10494.9 10552.2 1707.5 1733.2 1757.8 1817.9 1940.7 119593.0 124183.4 129361.7 130412.0 132606.0 11865.2 11898.8 11978.1 11982.2 12056.4 15362.2 15495.5 15598.0 15679.8 15682.3 7214.5 8847.9 8933.3 8981.6 9124.3 7190.9 8173.0 8175.2 8713.0 8991.4 4709.0 4812.2 4830.3 4842.9 4847.6 1994.3 2023.4 2028.0 2040.5 2053.6 881.7 954.5 970.2 991.9 1019.1 19780.7 20800.0 20968.0 21058.7 21694.9 946.5 991.9 996.4 1004.6 1027.9 10965.7 11206.7 11212.4 11475.5 11601.5 508710.0 515609.0 519825.0 633541.0 643454.0 141238.0 147497.0 147535.0 148715.0 150797.0 1023.4 1028.9 1054.5 1057.6 1074.2 18661.6 19022.3 19063.4 19130.5 19179.6 50643.0 53733.7 56088.7 57373.9 58186.1 74092.0 76516.5 77008.8 77708.2 77815.6 8035.0 8305.0 8541.3 8580.5 8717.7 9996.3 11922.9 12879.5 13009.8 13073.2 11005.9 11079.7 11083.8 11362.2 11372.6 9510.0 10392.0 10427.8 10695.6 11542.3 11388.4 11400.5 11527.1 11778.8 11846.8 8268.5 8450.2 8463.3 8529.2 8729.2 10600.6 11266.3 11450.3 11534.1 11546.0 03:41:40 INFO - PROCESS | 2538 | 03:41:40 INFO - PROCESS | 2538 | [#3] mootools.html Cycles:180 Average:5758.48 Median:2669.35 stddev:3257.92 (122.0%) stddev-sans-first:3252.19 03:41:40 INFO - PROCESS | 2538 | Values: 1616.6 1628.1 1891.8 1958.6 1973.3 8173.6 8805.6 8811.3 9174.9 9197.5 8794.6 8815.3 8911.6 8945.9 9061.0 2450.8 2451.2 2469.7 2484.0 2491.0 2441.8 2482.7 2488.3 2495.0 2498.1 2437.7 2449.8 2482.2 2485.1 2490.8 2428.3 2446.5 2457.5 2474.2 2476.3 2429.7 2457.7 2457.9 2467.7 2490.9 9029.8 9129.6 9149.2 9152.7 9154.1 5339.7 5462.5 5464.6 5520.0 5537.2 3141.8 3217.5 3380.5 3660.6 3696.8 924.7 940.4 1041.8 1044.9 1056.8 12008.6 12077.0 12136.6 12161.7 12170.5 4398.3 4658.7 4921.0 5020.7 5021.2 10246.3 10362.1 10363.3 10363.4 10386.2 5390.6 5406.6 5475.8 5479.7 5514.6 4479.4 4861.8 4974.4 5016.5 5023.3 4104.5 4109.2 4155.1 4229.1 4257.3 1365.4 1381.3 1393.8 1394.1 1406.5 930.4 936.2 938.9 948.2 958.0 5811.8 5937.1 5967.6 6129.5 6178.7 468.9 470.1 472.7 473.1 476.9 3076.8 3370.6 3558.7 4055.2 4116.7 9496.0 10698.8 10779.7 10999.9 11023.5 9161.7 10797.1 10902.6 11050.9 11085.9 8224.7 8247.1 8301.3 8328.1 8366.5 4531.6 5829.4 5845.6 5938.3 5973.9 8432.0 10053.0 10193.6 10218.2 10243.6 8564.5 9739.8 9938.8 10476.5 10556.4 6995.1 7434.0 7607.4 7662.3 7740.6 8362.8 8454.8 8476.7 8519.2 8557.8 7472.8 7515.7 7554.9 7752.5 7780.4 7392.4 7429.3 7493.8 7555.0 7601.0 7015.3 7085.4 7100.3 7117.6 7136.1 4868.8 4898.6 5006.3 5085.2 5087.0 4129.8 4207.5 4261.3 4300.0 4388.3 03:41:40 INFO - PROCESS | 2538 | 03:41:40 INFO - PROCESS | 2538 | [#4] prototype.html Cycles:180 Average:4609.59 Median:5075.34 stddev:1465.41 (28.9%) stddev-sans-first:1433.48 03:41:40 INFO - PROCESS | 2538 | Values: 305.9 306.8 309.8 313.1 314.1 5228.6 5338.9 5378.4 5388.5 5408.3 4809.6 4870.9 5273.0 5288.4 5291.4 3695.8 3884.4 3916.9 4008.6 4045.4 3303.4 3849.6 3944.3 4003.4 4040.5 3997.4 4005.9 4016.3 4042.3 4042.7 3744.6 3850.5 3998.7 4010.2 4039.9 3093.3 3474.9 3481.4 3497.4 3517.2 3900.9 4375.5 4593.5 4799.0 5073.1 4454.8 4487.6 4626.7 4627.7 4638.1 4882.8 5465.9 5572.2 5600.3 5614.7 3331.0 3343.8 3869.7 3883.0 3887.6 5373.6 5683.3 5780.7 5871.6 5902.0 3161.8 3527.7 3545.0 3991.0 4016.6 3361.8 3431.4 3985.5 4028.7 4037.7 3813.3 4628.7 4649.6 4658.0 4668.2 4753.9 5324.0 5657.5 5661.4 5670.5 1405.9 1406.3 1464.8 1479.4 1481.3 912.5 959.8 982.8 987.5 992.5 3967.5 4266.7 4632.8 4954.8 5077.6 5809.7 5810.0 5830.6 5836.7 5850.4 4623.4 5043.7 5208.0 5237.6 5249.7 2970.8 3060.6 3228.5 3296.0 3324.7 5841.2 6055.9 6526.9 6550.9 6654.7 5659.6 6050.0 6154.5 6448.9 6495.5 5235.2 5404.6 6175.3 6484.1 6555.8 5335.0 5540.4 6274.6 6312.9 6320.4 5398.6 5640.9 6201.7 6234.2 6242.8 5048.8 6509.6 6515.7 6516.9 6530.9 3529.3 4170.5 4183.1 4212.2 4213.5 5168.6 5231.6 5363.3 5419.6 6278.8 4985.5 5034.7 5905.5 6057.9 6084.2 4522.4 4668.6 5346.5 6012.6 6052.1 5061.3 5761.9 5830.9 5885.8 5894.9 5310.4 5431.7 5580.4 5584.7 5591.6 5447.7 5496.7 5510.4 5516.4 5570.3 03:41:40 INFO - PROCESS | 2538 | 03:41:40 INFO - PROCESS | 2538 | [#5] yui.html Cycles:180 Average:17352.63 Median:33751.92 stddev:24365.68 (72.2%) stddev-sans-first:24401.58 03:41:40 INFO - PROCESS | 2538 | Values: 602.8 666.5 697.8 745.1 748.2 16602.2 16773.7 17313.5 17337.2 17352.7 16260.2 16513.1 16523.6 16524.0 16573.7 724.9 903.0 935.8 936.9 939.2 912.4 915.4 924.0 928.6 929.1 990.6 991.3 993.5 994.0 997.3 982.4 984.1 986.0 987.7 988.6 720.6 737.0 737.3 737.7 738.5 15197.7 15239.5 15504.1 15517.7 15536.0 10005.4 10459.8 12167.9 12372.1 12444.5 9856.5 9881.2 9892.8 10008.3 10092.4 3479.6 3488.7 3534.1 3580.5 3587.3 75342.0 75941.6 76631.7 77659.6 78259.6 7991.5 9344.6 9441.5 9477.9 9512.8 20952.0 20964.7 20983.9 20985.4 21041.3 7286.5 7409.3 7456.0 7473.1 7652.7 4096.8 4154.2 4164.2 4165.8 4169.3 3537.9 3574.9 3619.0 3619.8 3635.9 638.0 640.3 646.1 664.2 678.2 563.9 571.4 589.8 590.1 603.5 7822.9 7844.2 7927.8 8021.8 8391.1 589.6 590.0 605.6 611.6 619.7 3382.2 3561.6 3729.9 3801.3 3978.5 73884.0 93462.0 95447.5 96504.0 96934.5 66837.3 67529.7 71752.3 79140.6 79422.6 66524.7 68031.7 68101.0 68254.3 68945.0 7564.2 7581.2 7693.3 7710.5 7794.6 39183.0 41078.7 44916.1 44999.8 45505.3 42761.0 60925.8 60977.7 63744.0 64107.7 7575.0 9251.0 9941.7 10173.1 10237.0 10924.5 11014.7 11048.7 11193.8 11612.7 8268.0 10099.3 10178.3 10271.9 10683.6 9715.5 10236.1 10283.5 10642.9 10716.0 9814.1 9898.6 9974.8 10151.8 10273.2 8686.4 8879.6 8992.0 9110.8 9151.4 7806.2 8556.8 8767.0 9023.3 9101.7 03:41:40 INFO - PROCESS | 2538 | -------- Summary: end -------- 03:41:40 INFO - PROCESS | 2538 | 03:41:41 INFO - TEST-INFO | 2538: exit 0 03:41:41 INFO - TEST-OK | dromaeo_css | took 1112329ms 03:41:41 INFO - TEST-START | kraken 03:41:41 INFO - operating with platform_type : mac_ 03:41:41 INFO - Initialising browser for kraken test... 03:41:41 INFO - TEST-INFO | started process 2567 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpD2gsde/profile http://localhost:54051/getInfo.html) 03:41:44 INFO - PROCESS | 2567 | __metrics Screen width/height:1600/1200 03:41:44 INFO - PROCESS | 2567 | colorDepth:24 03:41:44 INFO - PROCESS | 2567 | Browser inner width/height: 1024/689 03:41:44 INFO - PROCESS | 2567 | __metrics 03:41:44 ERROR - PROCESS | 2567 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:41:45 INFO - TEST-INFO | 2567: exit 0 03:41:45 INFO - Browser initialized. 03:41:45 INFO - Running cycle 1/1 for kraken test... 03:41:45 INFO - TEST-INFO | started process 2570 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpD2gsde/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:57 INFO - PROCESS | 2570 | RSS: Main: 221884416 03:41:57 INFO - PROCESS | 2570 | 03:42:00 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:54051/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54051/tests/kraken/driver.html?testName=audio-beat-detection) 03:42:01 INFO - PROCESS | 2570 | RSS: Main: 233820160 03:42:01 INFO - PROCESS | 2570 | 03:42:03 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:54051/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54051/tests/kraken/driver.html?testName=audio-dft) 03:42:04 INFO - PROCESS | 2570 | RSS: Main: 242737152 03:42:04 INFO - PROCESS | 2570 | 03:42:07 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:54051/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54051/tests/kraken/driver.html?testName=audio-fft) 03:42:08 INFO - PROCESS | 2570 | RSS: Main: 245166080 03:42:08 INFO - PROCESS | 2570 | 03:42:10 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:54051/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54051/tests/kraken/driver.html?testName=audio-oscillator) 03:42:11 INFO - PROCESS | 2570 | RSS: Main: 247648256 03:42:11 INFO - PROCESS | 2570 | 03:42:13 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:54051/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54051/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:42:13 INFO - PROCESS | 2570 | RSS: Main: 248356864 03:42:13 INFO - PROCESS | 2570 | 03:42:16 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:54051/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54051/tests/kraken/driver.html?testName=imaging-darkroom) 03:42:17 INFO - PROCESS | 2570 | RSS: Main: 248594432 03:42:17 INFO - PROCESS | 2570 | 03:42:20 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:54051/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54051/tests/kraken/driver.html?testName=imaging-desaturate) 03:42:20 INFO - PROCESS | 2570 | RSS: Main: 248696832 03:42:20 INFO - PROCESS | 2570 | 03:42:23 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:54051/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54051/tests/kraken/driver.html?testName=json-parse-financial) 03:42:24 INFO - PROCESS | 2570 | RSS: Main: 248983552 03:42:24 INFO - PROCESS | 2570 | 03:42:26 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:54051/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54051/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:42:26 INFO - PROCESS | 2570 | RSS: Main: 247947264 03:42:26 INFO - PROCESS | 2570 | 03:42:28 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:54051/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54051/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:42:29 INFO - PROCESS | 2570 | RSS: Main: 248107008 03:42:29 INFO - PROCESS | 2570 | 03:42:31 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:54051/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54051/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:42:31 INFO - PROCESS | 2570 | RSS: Main: 248332288 03:42:31 INFO - PROCESS | 2570 | 03:42:34 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:54051/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54051/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:42:35 INFO - PROCESS | 2570 | RSS: Main: 248426496 03:42:35 INFO - PROCESS | 2570 | 03:42:38 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:54051/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54051/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:42:39 INFO - PROCESS | 2570 | RSS: Main: 248406016 03:42:39 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | Cycle 1(1): loaded http://localhost:54051/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54051/tests/kraken/driver.html?testName=ai-astar) 03:42:41 INFO - PROCESS | 2570 | RSS: Main: 250068992 03:42:41 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | __start_tp_report 03:42:41 INFO - PROCESS | 2570 | _x_x_mozilla_page_load 03:42:41 INFO - PROCESS | 2570 | _x_x_mozilla_page_load_details 03:42:41 INFO - PROCESS | 2570 | |i|pagename|runs| 03:42:41 INFO - PROCESS | 2570 | |0;ai-astar;142;165;158;119;118;134;116;119;114;117 03:42:41 INFO - PROCESS | 2570 | |1;audio-beat-detection;152;119;144;161;124;139;127;162;192;121 03:42:41 INFO - PROCESS | 2570 | |2;audio-dft;264;274;206;282;281;195;195;197;195;196 03:42:41 INFO - PROCESS | 2570 | |3;audio-fft;65;76;85;145;56;55;55;66;131;56 03:42:41 INFO - PROCESS | 2570 | |4;audio-oscillator;79;96;132;79;79;80;123;83;81;121 03:42:41 INFO - PROCESS | 2570 | |5;imaging-gaussian-blur;118;132;91;86;88;84;88;86;88;88 03:42:41 INFO - PROCESS | 2570 | |6;imaging-darkroom;95;115;151;128;94;96;94;95;94;95 03:42:41 INFO - PROCESS | 2570 | |7;imaging-desaturate;89;94;99;93;79;144;150;101;89;92 03:42:41 INFO - PROCESS | 2570 | |8;json-parse-financial;62;65;66;63;66;67;66;81;64;60 03:42:41 INFO - PROCESS | 2570 | |9;json-stringify-tinderbox;64;66;69;73;80;74;73;66;65;69 03:42:41 INFO - PROCESS | 2570 | |10;stanford-crypto-aes;85;81;83;83;83;79;96;81;81;84 03:42:41 INFO - PROCESS | 2570 | |11;stanford-crypto-ccm;134;161;162;139;164;153;137;143;161;156 03:42:41 INFO - PROCESS | 2570 | |12;stanford-crypto-pbkdf2;181;161;230;217;218;177;229;157;207;231 03:42:41 INFO - PROCESS | 2570 | |13;stanford-crypto-sha256-iterative;68;69;82;99;102;68;66;67;70;68 03:42:41 INFO - PROCESS | 2570 | __end_tp_report 03:42:41 INFO - PROCESS | 2570 | __start_cc_report 03:42:41 INFO - PROCESS | 2570 | _x_x_mozilla_cycle_collect,1097 03:42:41 INFO - PROCESS | 2570 | __end_cc_report 03:42:41 INFO - PROCESS | 2570 | __startTimestamp1462531361374__endTimestamp 03:42:41 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | ------- Summary: start ------- 03:42:41 INFO - PROCESS | 2570 | Number of tests: 14 03:42:41 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | [#0] ai-astar Cycles:10 Average:130.20 Median:126.50 stddev:18.78 (14.8%) stddev-sans-first:19.43 03:42:41 INFO - PROCESS | 2570 | Values: 142.0 165.0 158.0 119.0 118.0 134.0 116.0 119.0 114.0 117.0 03:42:41 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:148.00 stddev:23.21 (15.7%) stddev-sans-first:24.44 03:42:41 INFO - PROCESS | 2570 | Values: 152.0 119.0 144.0 161.0 124.0 139.0 127.0 162.0 192.0 121.0 03:42:41 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | [#2] audio-dft Cycles:10 Average:228.50 Median:235.00 stddev:40.65 (17.3%) stddev-sans-first:41.03 03:42:41 INFO - PROCESS | 2570 | Values: 264.0 274.0 206.0 282.0 281.0 195.0 195.0 197.0 195.0 196.0 03:42:41 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | [#3] audio-fft Cycles:10 Average:79.00 Median:60.50 stddev:32.80 (54.2%) stddev-sans-first:34.39 03:42:41 INFO - PROCESS | 2570 | Values: 65.0 76.0 85.0 145.0 56.0 55.0 55.0 66.0 131.0 56.0 03:42:41 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:79.50 stddev:21.50 (27.1%) stddev-sans-first:21.99 03:42:41 INFO - PROCESS | 2570 | Values: 79.0 96.0 132.0 79.0 79.0 80.0 123.0 83.0 81.0 121.0 03:42:41 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | [#5] imaging-gaussian-blur Cycles:10 Average:94.90 Median:88.00 stddev:16.31 (18.5%) stddev-sans-first:15.00 03:42:41 INFO - PROCESS | 2570 | Values: 118.0 132.0 91.0 86.0 88.0 84.0 88.0 86.0 88.0 88.0 03:42:41 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | [#6] imaging-darkroom Cycles:10 Average:105.70 Median:94.50 stddev:19.68 (20.8%) stddev-sans-first:20.48 03:42:41 INFO - PROCESS | 2570 | Values: 95.0 115.0 151.0 128.0 94.0 96.0 94.0 95.0 94.0 95.0 03:42:41 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | [#7] imaging-desaturate Cycles:10 Average:103.00 Median:90.50 stddev:23.99 (26.5%) stddev-sans-first:24.91 03:42:41 INFO - PROCESS | 2570 | Values: 89.0 94.0 99.0 93.0 79.0 144.0 150.0 101.0 89.0 92.0 03:42:41 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:5.70 (8.6%) stddev-sans-first:5.85 03:42:41 INFO - PROCESS | 2570 | Values: 62.0 65.0 66.0 63.0 66.0 67.0 66.0 81.0 64.0 60.0 03:42:41 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:71.00 stddev:5.04 (7.1%) stddev-sans-first:4.88 03:42:41 INFO - PROCESS | 2570 | Values: 64.0 66.0 69.0 73.0 80.0 74.0 73.0 66.0 65.0 69.0 03:42:41 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:4.70 (5.7%) stddev-sans-first:4.95 03:42:41 INFO - PROCESS | 2570 | Values: 85.0 81.0 83.0 83.0 83.0 79.0 96.0 81.0 81.0 84.0 03:42:41 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | [#11] stanford-crypto-ccm Cycles:10 Average:151.00 Median:158.50 stddev:11.60 (7.3%) stddev-sans-first:10.55 03:42:41 INFO - PROCESS | 2570 | Values: 134.0 161.0 162.0 139.0 164.0 153.0 137.0 143.0 161.0 156.0 03:42:41 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.80 Median:217.50 stddev:29.09 (13.4%) stddev-sans-first:29.96 03:42:41 INFO - PROCESS | 2570 | Values: 181.0 161.0 230.0 217.0 218.0 177.0 229.0 157.0 207.0 231.0 03:42:41 INFO - PROCESS | 2570 | 03:42:41 INFO - PROCESS | 2570 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:68.50 stddev:13.74 (20.1%) stddev-sans-first:14.27 03:42:41 INFO - PROCESS | 2570 | Values: 68.0 69.0 82.0 99.0 102.0 68.0 66.0 67.0 70.0 68.0 03:42:41 INFO - PROCESS | 2570 | -------- Summary: end -------- 03:42:41 INFO - PROCESS | 2570 | 03:42:42 INFO - TEST-INFO | 2570: exit 0 03:42:42 INFO - TEST-OK | kraken | took 60802ms 03:42:42 INFO - SUITE-END | took 1173s 03:42:42 INFO - Completed test suite (00:19:33) 03:42:42 INFO - javascript benchmark 03:42:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3173.5398367236753, 3520.542329497165, 3538.203904121571, 3564.9643503564957, 3581.623929487404, 5648.915266271004, 5757.683327416996, 5764.510016648579, 5784.0, 5795.15970184323, 5711.143328500727, 5768.567357448187, 5783.566232532556, 5790.971045144768, 5798.739056742446, 5161.819336323229, 5220.347456567929, 5273.2617433559335, 5298.7350632468415, 5312.0, 5230.476952304777, 5359.08895487768, 5359.5712343012665, 5369.328833895763, 5378.435264297251, 5281.445448227938, 5304.018756530054, 5335.986162629088, 5338.652987555816, 5357.919631205535, 4553.248713962193, 5193.376794784613, 5319.654222475527, 5326.973365133169, 5366.543843773284, 5176.171812510018, 5256.369235691742, 5274.736263186825, 5283.445238249967, 5364.168553874117, 5835.620684655526, 5843.6493810371085, 5859.296884373903, 5874.5006674432725, 5891.909996650634, 6160.1991741073825, 6204.0, 6280.528960327993, 6299.65351905645, 6300.716467758916, 5193.2989046479, 6191.81424557264, 6194.318624951252, 6235.906461403082, 6272.498200144023, 5870.442307980735, 5889.116632505115, 5917.349091599921, 5932.792352267693, 5990.6705131218205, 5271.6309858310315, 6247.312795592481, 6364.809055728336, 6444.871102577922, 6473.579217350952, 6206.627602343874, 6241.251049874044, 6253.218347706536, 6257.74969001244, 6276.780312689034, 6299.905501417483, 6324.968375158187, 6327.778527751507, 6332.430081292706, 6392.105105285264, 6118.984682626245, 6180.6600636965395, 6202.906956395657, 6210.875782484415, 6333.809985700436, 6272.090546870678, 6274.435300822948, 6289.496840252768, 6293.37066293367, 6293.874122517615, 4987.80048798044, 5036.5718913892, 5049.621278404061, 5052.115879721107, 5068.974655126701, 4444.466664000341, 4472.993576445274, 4530.22986092365, 4554.590086892195, 4563.817447302137, 5891.469767720926, 5929.584929054925, 5976.641401515923, 5999.220101386879, 6007.909881351783, 6255.12428260044, 6265.216847894013, 6267.059941008794, 6357.332480089616, 6361.982082866719, 5916.763329466859, 5961.2846458425265, 5968.343482216953, 5969.0, 5977.910331345033, 5478.91781623276, 5509.834704958857, 5516.393196748354, 5520.779168833202, 5538.252335934678, 4713.646476514206, 6292.4966002719675, 6428.582142160744, 6431.710573024225, 6522.869542609121, 5419.807642318684, 5512.834614961557, 6302.338254483397, 6303.991361382157, 6341.143945567289, 6512.218533775977, 6539.771108011197, 6556.704948277435, 6562.639054851838, 6584.308647591934, 5977.3424923257535, 6212.502999759918, 6224.844378890564, 6266.624002559861, 6281.15204447412, 6294.087357333069, 6303.401176888188, 6316.242050953915, 6337.2395312562785, 6346.365363463801, 5131.384233891957, 6092.177556030057, 6171.444569988723, 6173.536984726074, 6174.135621013152, 4933.309336692794, 6058.394160583906, 6135.44703110649, 6137.997532011396, 6144.371741488599, 5224.2947202127225, 5770.913436298543, 5927.9703601481715, 5950.642961422329, 5954.3152537458745, 4891.5353041461, 6130.336988992987, 6141.938580614136, 6153.907691384543, 6159.722812473539, 6082.817515474543, 6114.2357205349335, 6134.7121296814075, 6154.107654390178, 6158.538109641884], "value": 5739.839481010096, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.8792777661138, 533.1416419564503, 581.2734082397004, 605.158829227374, 619.6344156947401, 31164.0, 40809.79595102024, 40962.385564216485, 40995.79502102485, 41084.79457602712, 43884.561154388444, 44463.55536444634, 44587.0, 45059.0, 45349.77325113378, 7367.4474414419, 9585.37695049823, 9750.658726944559, 9757.268204884627, 9767.706968790912, 9617.903820961807, 9650.758731031745, 9669.806603867919, 9728.756781080494, 9756.121949024622, 9697.272704547151, 9720.659776907809, 9788.608455661764, 9791.461469619167, 9792.363496372749, 9675.564599593, 9706.126448619658, 9731.756706082333, 9753.219742420624, 9792.55933482995, 9629.229661627052, 9764.707058788177, 9766.755831104208, 9769.218462522982, 9800.460974646392, 40128.39807402891, 40415.989600260225, 40505.0, 40880.79559602183, 41063.0, 2710.7018227994904, 3095.1024202981334, 3290.802551846873, 3306.553615261957, 3339.332133573295, 27300.590491142648, 27738.445231095466, 28151.577726334122, 28451.004214852586, 29590.408191836043, 2752.8348299102117, 2791.79061570381, 2800.80394372394, 2836.702146274632, 2846.9003584874636, 408121.95939020114, 409629.0, 491780.0, 498342.50828745984, 500193.0, 35330.82334588311, 36353.63646363556, 69024.6548767253, 69493.65253173701, 69708.0, 36440.0, 36584.81707591445, 36691.4496282556, 36831.63168368282, 36863.0, 15096.54710358691, 15430.38278468871, 15694.529164125095, 15713.607159821097, 15722.05667659944, 12974.962003039735, 13010.479580816851, 13025.609231723063, 13040.347982600832, 13053.34733263333, 8290.129536398712, 8299.668013279523, 8511.106333834858, 8529.232369086812, 8549.871751923725, 3456.637053109387, 3470.6355832637714, 3500.2299494111253, 3506.579210494757, 3513.7364697647777, 830.4145577367941, 937.8124375125002, 988.2390559269322, 990.5294984882267, 1132.5752842683994, 31086.0, 31303.843480782907, 31395.37209255848, 31703.0, 31761.523577146363, 950.4249928793118, 1041.890601486848, 1084.0352086642895, 1096.1504833753745, 1159.171192597297, 16197.919010404872, 16282.75575866363, 16292.0, 16364.6441393982, 16413.42553010663, 661604.0, 675479.0, 680540.0, 683981.0, 684186.0, 63623.36376636267, 64126.0, 64771.0, 65013.0, 65041.349586504475, 1461.8684318411395, 1486.702659468089, 1499.0930487055175, 1503.6616761228636, 1510.0486693383098, 30525.0, 30741.692583073884, 30992.69007309898, 31123.0, 31151.84424077865, 56801.0, 56954.0, 56980.715096424254, 57186.0, 57227.42772572221, 582830.0, 582877.0, 585222.0, 585789.0, 585968.0, 28455.43089138247, 40213.39679904862, 41081.58918410897, 41479.58520414878, 42196.57803421927, 36433.63566364302, 43693.34459983166, 44355.77822110869, 44779.552204478845, 46436.53563464457, 36680.63319366772, 37447.25105497929, 37745.43381849329, 37886.98228381736, 39497.01257468586, 38555.0, 38628.420573690855, 38657.03677633276, 39402.40896386614, 39426.60573394229, 34049.0, 36796.0, 37042.8147859259, 37993.62006379901, 38932.832015039596, 32216.19459513531, 32502.85326967306, 32769.0, 32846.0, 33378.83310583432, 25239.0, 25710.871445642653, 25908.740912590634, 25996.35009124787, 26304.34239144037], "value": 19099.993882947703, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.62237894968183, 400.82163437270407, 401.9809782202118, 409.65793562375416, 413.75381647919477, 14549.0, 19402.417927462182, 20146.697799533, 20188.0, 20204.0, 17249.655006899888, 20195.59608807823, 20317.0, 20474.89762551189, 21462.678059829115, 4337.587929146734, 5207.4792520748, 5440.510354068133, 5457.290552228204, 5461.262729531502, 5355.919661205085, 5441.2654291670715, 5467.289252397183, 5474.945250547484, 5478.863028424282, 4399.494058183318, 5076.883085721135, 5530.889382212354, 6019.458248757633, 6030.8793824123495, 5843.678597677126, 5984.521238300926, 6001.369856165127, 6010.8797824043495, 6031.306399764039, 4355.629771469429, 5279.788808447657, 5341.919871201935, 5360.544353729938, 5363.812266570691, 19898.0, 23324.883375583013, 23619.464734792182, 25432.745672543224, 25833.870830645916, 2044.37646517812, 2114.947126321839, 2130.4567335329393, 2316.93049208524, 2405.9477335455085, 10187.898121018769, 10193.490325483695, 10195.643152489702, 10494.947525262402, 10552.208584356127, 1707.538964479596, 1733.159417682423, 1757.7890653121578, 1817.9181936812874, 1940.7185958036148, 119593.0, 124183.37908310401, 129361.70638293591, 130412.0, 132605.99999999904, 11865.16943813942, 11898.821517677241, 11978.101642376681, 11982.161248712506, 12056.397180140957, 15362.231888405535, 15495.535133946, 15598.0, 15679.764803527956, 15682.294296756674, 7214.531055481377, 8847.911520884838, 8933.28533717301, 8981.640734370683, 9124.315676324302, 7190.928090719026, 8172.959135204286, 8175.223353781381, 8712.956435217784, 8991.370604057653, 4708.976455117702, 4812.230043193073, 4830.275458681155, 4842.903141937141, 4847.587955023792, 1994.2920263306607, 2023.4132101690345, 2027.9594408111755, 2040.510277533411, 2053.620080285152, 881.6737807011447, 954.5418199264392, 970.1801977329145, 991.9454430006275, 1019.0726438940528, 19780.70328945067, 20799.96000199984, 20968.0, 21058.684119738216, 21694.915254237225, 946.5220063867703, 991.8660980767504, 996.367306760198, 1004.5931397783909, 1027.9023492768174, 10965.671029869116, 11206.663800086011, 11212.355984305133, 11475.540978360772, 11601.535938562363, 508710.0, 515609.0, 519825.0, 633541.0, 643454.0, 141238.0, 147497.0, 147535.0, 148715.0, 150797.0, 1023.3706270643501, 1028.8508166315842, 1054.4938429553856, 1057.6245432871374, 1074.1997212076897, 18661.626767464848, 19022.334218302294, 19063.428097157106, 19130.521736956132, 19179.61640767205, 50643.0, 53733.73133134309, 56088.71955640196, 57373.85252295014, 58186.127208091064, 74092.0, 76516.46967060739, 77008.84486732815, 77708.22291777236, 77815.61092194503, 8035.0, 8304.958475207826, 8541.316694664536, 8580.528070956158, 8717.694880679146, 9996.3002589818, 11922.880771192176, 12879.484820607071, 13009.804852927404, 13073.215607063607, 11005.911281108547, 11079.72300692489, 11083.778324433628, 11362.204645675054, 11372.601958931398, 9509.953905070575, 10392.0, 10427.843582346119, 10695.572177112828, 11542.307461552333, 11388.373639449579, 11400.543978240778, 11527.135464840338, 11778.823317650413, 11846.763064738829, 8268.545230012407, 8450.19723126302, 8463.28062114727, 8529.189726975927, 8729.170728780755, 10600.628977985734, 11266.324020558464, 11450.312981221154, 11534.077273818242, 11545.960863522323], "value": 9607.292445471294, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1616.5958510372402, 1628.1452237575274, 1891.8391936685382, 1958.6180694764528, 1973.3093417303937, 8173.632186551605, 8805.559722013906, 8811.339149563784, 9174.85314335708, 9197.540122993849, 8794.560271986407, 8815.338849586275, 8911.554422278892, 8945.910540894589, 9060.954695226515, 2450.779429851313, 2451.2033589083576, 2469.6789417375717, 2483.9751602483925, 2490.9626355604682, 2441.7802397784194, 2482.6648402465617, 2488.340589743719, 2494.950100997979, 2498.088197807796, 2437.6587277781123, 2449.7917676997477, 2482.168473561359, 2485.0680994627014, 2490.8007359411295, 2428.2715185444385, 2446.5473887330813, 2457.5207834472285, 2474.1711526638596, 2476.3437689012426, 2429.6962879640046, 2457.741937096597, 2457.852528848257, 2467.728549859514, 2490.9252722418355, 9029.82612260402, 9129.589168487433, 9149.22231610314, 9152.679656212, 9154.084591540859, 5339.65292256006, 5462.453754624546, 5464.617476776627, 5520.0, 5537.169424586304, 3141.7643676724338, 3217.48520236761, 3380.4591265397416, 3660.6156353583024, 3696.796676182809, 924.7364501117216, 940.4451373689556, 1041.812473754724, 1044.9111825494842, 1056.7675111475462, 12008.63974080779, 12076.973457256143, 12136.575219867262, 12161.69595760113, 12170.513179472811, 4398.274284743045, 4658.720476771405, 4921.0, 5020.673656212334, 5021.221710634857, 10246.333988290886, 10362.067413932782, 10363.32638378503, 10363.378197308186, 10386.169106471463, 5390.568754499709, 5406.648567843077, 5475.808346707846, 5479.726013699299, 5514.641548299348, 4479.395281637003, 4861.781219845045, 4974.353334066548, 5016.498350164954, 5023.296738456619, 4104.52797928242, 4109.207410502865, 4155.148194620096, 4229.133027729308, 4257.318828987409, 1365.4333451617467, 1381.3093453273364, 1393.8048673185763, 1394.065975796219, 1406.4866323791946, 930.4138392812484, 936.1574582875467, 938.877945867033, 948.2414068744977, 957.9941061884992, 5811.79658711943, 5937.10943358491, 5967.582269241111, 6129.509639228851, 6178.66017369049, 468.9109069276827, 470.1255664464094, 472.7069217085429, 473.11055216193336, 476.92130798418566, 3076.7538596912195, 3370.6292307846115, 3558.679718825318, 4055.209234199303, 4116.711830171919, 9496.002919693332, 10698.839517407245, 10779.730506737395, 10999.945000274947, 11023.503942322453, 9161.679341223025, 10797.08224800885, 10902.563897444172, 11050.944745276222, 11085.944570277097, 8224.671013159526, 8247.092819789817, 8301.252887240056, 8328.125546817619, 8366.49801011929, 4531.614812740822, 5829.446202610745, 5845.620034697731, 5938.317093534299, 5973.850653733518, 8431.95784021076, 10053.0, 10193.643222487177, 10218.182545396201, 10243.590256389662, 8564.52895090776, 9739.805203896025, 9938.801223975335, 10476.476176191312, 10556.419396933243, 6995.125609298838, 7434.033575635132, 7607.391408687181, 7662.348700360531, 7740.612969351622, 8362.832743344978, 8454.830903381775, 8476.745697629081, 8519.190676885686, 8557.786055348666, 7472.813179670335, 7515.6993720250575, 7554.924450755422, 7752.5348479091435, 7780.416468764978, 7392.408607311295, 7429.294217049372, 7493.812654683677, 7554.962225188839, 7601.011868457065, 7015.333543313377, 7085.39774119185, 7100.289971002859, 7117.572945623279, 7136.143662760502, 4868.80524779019, 4898.5549262968225, 5006.299118123393, 5085.237214417867, 5086.9745651271505, 4129.752214867118, 4207.453031105937, 4261.318189089855, 4299.97850010748, 4388.29787234041], "value": 4566.722713446469, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.89293747188486, 306.7867831856859, 309.7583884570035, 313.1482367959153, 314.1188964953305, 5228.562145410014, 5338.946610533893, 5378.408375078739, 5388.488093631108, 5408.269883565722, 4809.615230781538, 4870.926936095952, 5272.973635131829, 5288.418273989858, 5291.391489978653, 3695.780392470478, 3884.3685652026215, 3916.8629097981575, 4008.5590585035625, 4045.352743561031, 3303.38887305848, 3849.634284742959, 3944.270309992646, 4003.379476181182, 4040.474738284019, 3997.4403583498333, 4005.9198816023663, 4016.297147999103, 4042.3426395177985, 4042.6967977401664, 3744.57706071691, 3850.4609354690365, 3998.7400818946676, 4010.2380547695843, 4039.939400908989, 3093.273080826004, 3474.940143256306, 3481.3733527964955, 3497.387957107496, 3517.243792584581, 3900.902477438087, 4375.496817865923, 4593.5406459354135, 4798.976005119987, 5073.1122053640465, 4454.794876536135, 4487.618552423048, 4626.676132670715, 4627.745473998929, 4638.124362894993, 4882.829100981484, 5465.863353416156, 5572.192032155314, 5600.299962504687, 5614.663120212759, 3330.9840498647904, 3343.782654127474, 3869.690424766012, 3882.951603067156, 3887.6393262357947, 5373.59698022646, 5683.261176047129, 5780.682062486561, 5871.618344807616, 5902.0, 3161.762867784925, 3527.7177825773874, 3544.964550354515, 3990.960090399059, 4016.638502534786, 3361.815100169465, 3431.3823511768123, 3985.5416627087675, 4028.71798974069, 4037.6567991720444, 3813.3326667833016, 4628.699134556243, 4649.5815376616265, 4657.9737814050995, 4668.183067963161, 4753.882837533177, 5324.0, 5657.4908258256955, 5661.433856614306, 5670.489655930986, 1405.9174435684465, 1406.2827957741422, 1464.7729601911722, 1479.423025020243, 1481.3482067890093, 912.5026860361119, 959.822432849911, 982.7837875667342, 987.4667679453158, 992.4987881119988, 3967.4806497873483, 4266.679999000087, 4632.814687412533, 4954.835613630794, 5077.568406685399, 5809.651420914759, 5809.954208242557, 5830.562707796932, 5836.678982655994, 5850.414958504116, 4623.375844261049, 5043.672161309503, 5207.973960130175, 5237.633365664443, 5249.7112658804135, 2970.77719171063, 3060.6021217241614, 3228.467302895043, 3295.967040329566, 3324.667533246656, 5841.240638716939, 6055.909161362583, 6526.869462610816, 6550.868982620321, 6654.70053847578, 5659.575531835047, 6049.969750151221, 6154.476869466145, 6448.903266451007, 6495.545311828127, 5235.1623740201385, 5404.648697834707, 6175.258968923668, 6484.092227088211, 6555.8361040973405, 5335.039692855324, 5540.396013873473, 6274.59215151032, 6312.936870631235, 6320.4311611955145, 5398.62209645321, 5640.887182256414, 6201.658908760061, 6234.1583886174785, 6242.781502647385, 5048.798048078036, 6509.641969691713, 6515.674216289071, 6516.892128338289, 6530.869382612416, 3529.3294274087843, 4170.457840480718, 4183.121544475573, 4212.241796476541, 4213.5365109837285, 5168.612354073534, 5231.607629427732, 5363.302770639792, 5419.593530485308, 6278.843028924313, 4985.501449854985, 5034.748262586929, 5905.507877673805, 6057.878842423039, 6084.178635884276, 4522.432343333191, 4668.556487133853, 5346.518813306821, 6012.609180403259, 6052.093590518973, 5061.317501724092, 5761.942380576141, 5830.883382332415, 5885.764569417347, 5894.852628684317, 5310.442403547572, 5431.701256430776, 5580.414056524169, 5584.7207639617045, 5591.608587398843, 5447.700376479332, 5496.70197881268, 5510.429527584619, 5516.448355164452, 5570.275864137636], "value": 4158.649119635375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.7619090459268, 666.5049096554081, 697.8255436140964, 745.1207575061427, 748.2031636307336, 16602.169891505422, 16773.664526709457, 17313.480595582136, 17337.21982510787, 17352.65294694107, 16260.18699065048, 16513.091779952098, 16523.58691032725, 16524.0, 16573.66852662946, 724.9238829922848, 902.9683961061364, 935.8409070458005, 936.9250459963221, 939.1829108675462, 912.447968978765, 915.3775432705758, 923.9538023098818, 928.633189889993, 929.0802105915129, 990.6433683873836, 991.33085167512, 993.4833886379079, 993.9503024848765, 997.306871724152, 982.4105536677936, 984.0798853072364, 985.9852102218473, 987.6987518806761, 988.5650313861878, 720.6144712578798, 737.0455260437745, 737.2885165814961, 737.6533029476192, 738.4830618567024, 15197.696046079016, 15239.542813715607, 15504.147271900041, 15517.689646207013, 15536.0, 10005.449700266483, 10459.84310235347, 12167.878321216851, 12372.072094592851, 12444.502219911192, 9856.50717464131, 9881.16010139139, 9892.752681183028, 10008.29941904067, 10092.39445633257, 3479.565054368204, 3488.651134886491, 3534.0811389038777, 3580.480830279621, 3587.282543491286, 75342.0, 75941.6202918993, 76631.70104896862, 77659.6117019417, 78259.60870195669, 7991.480553763987, 9344.579493922789, 9441.527923603793, 9477.857832132524, 9512.809743805085, 20951.95240237982, 20964.685529717066, 20983.895080524806, 20985.37043888655, 21041.263555775473, 7286.526375785557, 7409.259074092548, 7456.0, 7473.065866766654, 7652.73215437457, 4096.774677392772, 4154.231467178582, 4164.229617520768, 4165.8333666653, 4169.2703776838935, 3537.893863184109, 3574.8927532174075, 3619.0, 3619.819009049537, 3635.927281454409, 637.9649119298483, 640.2668944059119, 646.0503060501056, 664.1532046640475, 678.2471456683078, 563.9182318563785, 571.3771988532519, 589.7559785018047, 590.1236663554618, 603.5352778360638, 7822.921770782219, 7844.209019896236, 7927.801804954922, 8021.759347219593, 8391.076981532027, 589.5637228451001, 589.9646121057517, 605.5518916002214, 611.5627326461602, 619.7242227208849, 3382.188274814027, 3561.5904171020147, 3729.9254014919547, 3801.258754542838, 3978.5225772906856, 73884.0, 93462.0, 95447.52276238575, 96504.0, 96934.51532742291, 66837.33162668408, 67529.66235168891, 71752.28247717457, 79140.60429697814, 79422.60288698635, 66524.66737666377, 68031.65984170047, 68101.0, 68254.31745682479, 68944.96582551266, 7564.167941526538, 7581.166071731995, 7693.346065584488, 7710.537367757953, 7794.571298578632, 39183.0, 41078.74066926228, 44916.10167796691, 44999.775001124784, 45505.31742023806, 42761.0, 60925.78148437095, 60977.69511152416, 63744.0, 64107.67946160239, 7574.962125189339, 9251.0, 9941.65204217849, 10173.135283500986, 10237.0, 10924.508397122308, 11014.669559913216, 11048.668539943814, 11193.776124477628, 11612.651620451063, 8268.0, 10099.343542669703, 10178.338408003456, 10271.94864025675, 10683.626073087406, 9715.514224288898, 10236.129928956123, 10283.485825708534, 10642.946785266024, 10716.0, 9814.116729494379, 9898.554565044735, 9974.750631234278, 10151.84772228432, 10273.229507786797, 8686.39195256326, 8879.644814207359, 8992.034692897518, 9110.817783644157, 9151.405158664666, 7806.1803510632835, 8556.786080348042, 8767.01996744857, 9023.323250756088, 9101.726948191565], "value": 6712.944522989644, "unit": "score"}], "name": "dromaeo_css", "value": 7156.070470894741, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 165.0, 158.0, 119.0, 118.0, 134.0, 116.0, 119.0, 114.0, 117.0], "value": 130.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 119.0, 144.0, 161.0, 124.0, 139.0, 127.0, 162.0, 192.0, 121.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [264.0, 274.0, 206.0, 282.0, 281.0, 195.0, 195.0, 197.0, 195.0, 196.0], "value": 228.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 76.0, 85.0, 145.0, 56.0, 55.0, 55.0, 66.0, 131.0, 56.0], "value": 79.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 96.0, 132.0, 79.0, 79.0, 80.0, 123.0, 83.0, 81.0, 121.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 132.0, 91.0, 86.0, 88.0, 84.0, 88.0, 86.0, 88.0, 88.0], "value": 94.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 115.0, 151.0, 128.0, 94.0, 96.0, 94.0, 95.0, 94.0, 95.0], "value": 105.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 94.0, 99.0, 93.0, 79.0, 144.0, 150.0, 101.0, 89.0, 92.0], "value": 103.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 66.0, 63.0, 66.0, 67.0, 66.0, 81.0, 64.0, 60.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 69.0, 73.0, 80.0, 74.0, 73.0, 66.0, 65.0, 69.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 83.0, 83.0, 83.0, 79.0, 96.0, 81.0, 81.0, 84.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 161.0, 162.0, 139.0, 164.0, 153.0, 137.0, 143.0, 161.0, 156.0], "value": 151.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 161.0, 230.0, 217.0, 218.0, 177.0, 229.0, 157.0, 207.0, 231.0], "value": 200.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 82.0, 99.0, 102.0, 68.0, 66.0, 67.0, 70.0, 68.0], "value": 75.9, "unit": "score"}], "name": "kraken", "value": 1627.8999999999999, "alertThreshold": 2.0}]} 03:42:42 INFO - Return code: 0 03:42:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:42:42 ERROR - # TBPL SUCCESS # 03:42:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:42:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:42:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:42:42 INFO - 2016-05-06 03:42:42.693 screenresolution[2575:24715] starting screenresolution argv=screenresolution get 03:42:42 INFO - 2016-05-06 03:42:42.696 screenresolution[2575:24715] Display 0: 1600x1200x32@60 03:42:42 INFO - 2016-05-06 03:42:42.702 screenresolution[2576:24717] starting screenresolution argv=screenresolution list 03:42:42 INFO - Available Modes on Display 0 03:42:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:42:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:42:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:42:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:42:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:42:42 INFO - Intel Iris: 03:42:42 INFO - Chipset Model: Intel Iris 03:42:42 INFO - Type: GPU 03:42:42 INFO - Bus: Built-In 03:42:42 INFO - VRAM (Dynamic, Max): 1536 MB 03:42:42 INFO - Vendor: Intel (0x8086) 03:42:42 INFO - Device ID: 0x0a2e 03:42:42 INFO - Revision ID: 0x0009 03:42:42 INFO - Displays: 03:42:42 INFO - Display: 03:42:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:42:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:42:42 INFO - Display Serial Number: 1600x1200 60 03:42:42 INFO - Main Display: Yes 03:42:42 INFO - Mirror: Off 03:42:42 INFO - Online: Yes 03:42:42 INFO - Rotation: Supported 03:42:42 INFO - Return code: 0 03:42:42 INFO - Running post-action listener: _resource_record_post_action 03:42:42 INFO - Running post-run listener: _resource_record_post_run 03:42:44 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 278528; Write bytes: 654150144; Read time: 4; Write time: 1869 03:42:44 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 342479360; Write bytes: 337344000; Read time: 26560; Write time: 635 03:42:44 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 278528; Write bytes: 297473024; Read time: 4; Write time: 1184 03:42:44 INFO - Running post-run listener: _upload_blobber_files 03:42:44 INFO - Blob upload gear active. 03:42:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:42:44 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 03:42:44 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:42:44 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:42:44 INFO - (blobuploader) - INFO - Open directory for files ... 03:42:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:42:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:42:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:45 INFO - (blobuploader) - INFO - Done attempting. 03:42:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:42:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:42:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:46 INFO - (blobuploader) - INFO - Done attempting. 03:42:46 INFO - (blobuploader) - INFO - Iteration through files over. 03:42:46 INFO - Return code: 0 03:42:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:42:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:42:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0faf1a611a1d504c495a630cf098651fd1956b43deb9a5ff7ded4e4e9a2a6cfd25b8d76337629a48ecb843475b0c68ea4d1ca33d0236cff375ed43423fec6132", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50080bcd6df22056bdb5a836b3ea7ef97236a24ce2184ee8c6d5babbe0c80390392c6c0dc7a9215842b8ee1355f85e94b62447f44d21183e342036a2776cdec8"} 03:42:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:42:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:42:46 INFO - Contents: 03:42:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0faf1a611a1d504c495a630cf098651fd1956b43deb9a5ff7ded4e4e9a2a6cfd25b8d76337629a48ecb843475b0c68ea4d1ca33d0236cff375ed43423fec6132", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50080bcd6df22056bdb5a836b3ea7ef97236a24ce2184ee8c6d5babbe0c80390392c6c0dc7a9215842b8ee1355f85e94b62447f44d21183e342036a2776cdec8"} 03:42:46 INFO - Running post-run listener: copy_logs_to_upload_dir 03:42:46 INFO - Copying logs to upload dir... 03:42:46 INFO - mkdir: /builds/slave/test/build/upload/logs 03:42:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.129501 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-05-06 03:42:46.240270) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 03:42:46.244947) ========= 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.4M6a3Gdgf4/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.HATlHdO4R7/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0faf1a611a1d504c495a630cf098651fd1956b43deb9a5ff7ded4e4e9a2a6cfd25b8d76337629a48ecb843475b0c68ea4d1ca33d0236cff375ed43423fec6132", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50080bcd6df22056bdb5a836b3ea7ef97236a24ce2184ee8c6d5babbe0c80390392c6c0dc7a9215842b8ee1355f85e94b62447f44d21183e342036a2776cdec8"} build_url:https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010630 build_url: 'https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0faf1a611a1d504c495a630cf098651fd1956b43deb9a5ff7ded4e4e9a2a6cfd25b8d76337629a48ecb843475b0c68ea4d1ca33d0236cff375ed43423fec6132", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50080bcd6df22056bdb5a836b3ea7ef97236a24ce2184ee8c6d5babbe0c80390392c6c0dc7a9215842b8ee1355f85e94b62447f44d21183e342036a2776cdec8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 03:42:46.273424) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:42:46.275810) ========= 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.4M6a3Gdgf4/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.HATlHdO4R7/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.005127 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:42:46.324076) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 03:42:46.324378) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 03:42:46.325793) ========= ========= Total master_lag: 0.19 =========