builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0062 starttime: 1461070921.25 results: success (0) buildid: 20160419030312 builduid: 95f374b788af453a93c87642c9d437b0 revision: ae7413abfa4d3954a6a4ce7c1613a7100f367f9a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 06:02:01.248922) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 06:02:01.249355) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 06:02:01.249627) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 06:02:01.273711) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 06:02:01.273988) ========= 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.Y0BkLU0YWG/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.dyqHzRChDi/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-19 06:02:01-- 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% 31.5M=0s 2016-04-19 06:02:01 (31.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118377 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 06:02:01.408650) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 06:02:01.408961) ========= 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.Y0BkLU0YWG/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.dyqHzRChDi/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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.019829 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 06:02:01.457666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 06:02:01.458073) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ae7413abfa4d3954a6a4ce7c1613a7100f367f9a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ae7413abfa4d3954a6a4ce7c1613a7100f367f9a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y0BkLU0YWG/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.dyqHzRChDi/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-19 06:02:01,530 truncating revision to first 12 chars 2016-04-19 06:02:01,530 Setting DEBUG logging. 2016-04-19 06:02:01,530 attempt 1/10 2016-04-19 06:02:01,530 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ae7413abfa4d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 06:02:02,318 unpacking tar archive at: mozilla-central-ae7413abfa4d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.041978 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 06:02:02.516257) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 06:02:02.516627) ========= script_repo_revision: ae7413abfa4d3954a6a4ce7c1613a7100f367f9a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 06:02:02.517047) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 06:02:02.517330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 06:02:02.530526) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-19 06:02:02.530809) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y0BkLU0YWG/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.dyqHzRChDi/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:02:02 INFO - MultiFileLogger online at 20160419 06:02:02 in /builds/slave/test 06:02:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:02:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:02:02 INFO - {'append_to_log': False, 06:02:02 INFO - 'base_work_dir': '/builds/slave/test', 06:02:02 INFO - 'blob_upload_branch': 'Firefox', 06:02:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:02:02 INFO - 'branch': 'Firefox', 06:02:02 INFO - 'buildbot_json_path': 'buildprops.json', 06:02:02 INFO - 'config_files': ('talos/mac_config.py',), 06:02:02 INFO - 'default_actions': ('clobber', 06:02:02 INFO - 'read-buildbot-config', 06:02:02 INFO - 'download-and-extract', 06:02:02 INFO - 'populate-webroot', 06:02:02 INFO - 'create-virtualenv', 06:02:02 INFO - 'install', 06:02:02 INFO - 'run-tests'), 06:02:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:02:02 INFO - 'download_minidump_stackwalk': True, 06:02:02 INFO - 'download_symbols': 'ondemand', 06:02:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:02:02 INFO - 'tooltool.py': '/tools/tooltool.py', 06:02:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:02:02 INFO - '/tools/misc-python/virtualenv.py')}, 06:02:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:02:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:02:02 INFO - 'installer_path': 'installer.exe', 06:02:02 INFO - 'log_level': 'info', 06:02:02 INFO - 'log_name': 'talos', 06:02:02 INFO - 'log_to_console': True, 06:02:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:02:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:02:02 INFO - 'opt_config_files': (), 06:02:02 INFO - 'pip_index': False, 06:02:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:02:02 INFO - 'cmd': ('bash', 06:02:02 INFO - '-c', 06:02:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:02:02 INFO - 'enabled': True, 06:02:02 INFO - 'halt_on_failure': False, 06:02:02 INFO - 'name': 'check_screen_resolution'},), 06:02:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:02:02 INFO - 'cmd': ('bash', 06:02:02 INFO - '-c', 06:02:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:02:02 INFO - 'enabled': True, 06:02:02 INFO - 'halt_on_failure': False, 06:02:02 INFO - 'name': 'check_screen_resolution'},), 06:02:02 INFO - 'run_cmd_checks_enabled': True, 06:02:02 INFO - 'sps_profile': False, 06:02:02 INFO - 'sps_profile_interval': 0, 06:02:02 INFO - 'suite': 'dromaeojs-e10s', 06:02:02 INFO - 'system_bits': '32', 06:02:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:02:02 INFO - 'title': 't-yosemite-r7-0062', 06:02:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:02:02 INFO - 'use_talos_json': True, 06:02:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:02:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:02:02 INFO - 'work_dir': 'build'} 06:02:02 INFO - ##### 06:02:02 INFO - ##### Running clobber step. 06:02:02 INFO - ##### 06:02:02 INFO - Running pre-action listener: _resource_record_pre_action 06:02:02 INFO - Running main action method: clobber 06:02:02 INFO - rmtree: /builds/slave/test/build 06:02:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:02:04 INFO - Running post-action listener: _resource_record_post_action 06:02:04 INFO - ##### 06:02:04 INFO - ##### Running read-buildbot-config step. 06:02:04 INFO - ##### 06:02:04 INFO - Running pre-action listener: _resource_record_pre_action 06:02:04 INFO - Running main action method: read_buildbot_config 06:02:04 INFO - Using buildbot properties: 06:02:04 INFO - { 06:02:04 INFO - "project": "", 06:02:04 INFO - "product": "firefox", 06:02:04 INFO - "script_repo_revision": "production", 06:02:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 06:02:04 INFO - "repository": "", 06:02:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 06:02:04 INFO - "buildid": "20160419030312", 06:02:04 INFO - "stage_platform": "macosx64", 06:02:04 INFO - "basedir": "/builds/slave/test", 06:02:04 INFO - "nightly_build": "True", 06:02:04 INFO - "buildnumber": 199, 06:02:04 INFO - "slavename": "t-yosemite-r7-0062", 06:02:04 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:02:04 INFO - "platform": "yosemite_r7", 06:02:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:02:04 INFO - "branch": "mozilla-central", 06:02:04 INFO - "repo_path": "mozilla-central", 06:02:04 INFO - "revision": "ae7413abfa4d3954a6a4ce7c1613a7100f367f9a", 06:02:04 INFO - "pgo_build": "False", 06:02:04 INFO - "builduid": "95f374b788af453a93c87642c9d437b0", 06:02:04 INFO - "slavebuilddir": "test" 06:02:04 INFO - } 06:02:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 06:02:04 INFO - Running post-action listener: _resource_record_post_action 06:02:04 INFO - ##### 06:02:04 INFO - ##### Running download-and-extract step. 06:02:04 INFO - ##### 06:02:04 INFO - Running pre-action listener: _resource_record_pre_action 06:02:04 INFO - Running main action method: download_and_extract 06:02:04 INFO - mkdir: /builds/slave/test/build/tests 06:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:04 INFO - https://queue.taskcluster.net/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:02:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:02:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:02:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 06:02:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 06:02:05 INFO - Downloaded 1199 bytes. 06:02:05 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 06:02:05 INFO - Using the following test package requirements: 06:02:05 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:02:05 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:02:05 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 06:02:05 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:02:05 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 06:02:05 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:02:05 INFO - u'jsshell-mac.zip'], 06:02:05 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:02:05 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 06:02:05 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:02:05 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:02:05 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 06:02:05 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:02:05 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 06:02:05 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:02:05 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 06:02:05 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:02:05 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 06:02:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:02: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')]} 06:02:05 INFO - https://queue.taskcluster.net/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:02:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:02:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:02:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:02:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:02:06 INFO - Downloaded 18038931 bytes. 06:02:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:02:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:02:10 INFO - Return code: 0 06:02:10 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:02: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')]} 06:02:10 INFO - https://queue.taskcluster.net/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:02:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:02:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:02:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:02:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:02:11 INFO - Downloaded 18038931 bytes. 06:02:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:02:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:02:14 INFO - Return code: 0 06:02:14 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')]} 06:02:14 INFO - https://queue.taskcluster.net/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:02:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:02:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:02:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:02:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:02:15 INFO - Downloaded 10845952 bytes. 06:02:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:02:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:02:16 INFO - Return code: 0 06:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:16 INFO - https://queue.taskcluster.net/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:02:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:02:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:02:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 06:02:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 06:02:24 INFO - Downloaded 110085176 bytes. 06:02:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:02:24 INFO - mkdir: /builds/slave/test/properties 06:02:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:02:24 INFO - Writing to file /builds/slave/test/properties/build_url 06:02:24 INFO - Contents: 06:02:24 INFO - build_url:https://queue.taskcluster.net/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:02:25 INFO - Running post-action listener: _resource_record_post_action 06:02:25 INFO - Running post-action listener: set_extra_try_arguments 06:02:25 INFO - ##### 06:02:25 INFO - ##### Running populate-webroot step. 06:02:25 INFO - ##### 06:02:25 INFO - Running pre-action listener: _resource_record_pre_action 06:02:25 INFO - Running main action method: populate_webroot 06:02:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:02:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:02:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:02:25 INFO - '--tppagecycles', 06:02:25 INFO - '7'], 06:02:25 INFO - 'tests': ['tsvgm']}}, 06:02:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:02:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:02:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:02:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:02:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:02:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:02:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:25 INFO - 'talos_options': ['--disable-e10s'], 06:02:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:02:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:02:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:25 INFO - 'talos_options': ['--disable-e10s'], 06:02:25 INFO - 'tests': ['damp', 'tps']}, 06:02:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:25 INFO - 'tests': ['damp', 'tps']}, 06:02:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:02:25 INFO - 'tests': ['dromaeo_dom']}, 06:02:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:02:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:02:25 INFO - 'tests': ['a11yr', 06:02:25 INFO - 'ts_paint', 06:02:25 INFO - 'tpaint', 06:02:25 INFO - 'sessionrestore', 06:02:25 INFO - 'sessionrestore_no_auto_restore', 06:02:25 INFO - 'tabpaint']}, 06:02:25 INFO - 'other-e10s': {'tests': ['a11yr', 06:02:25 INFO - 'ts_paint', 06:02:25 INFO - 'tpaint', 06:02:25 INFO - 'sessionrestore', 06:02:25 INFO - 'sessionrestore_no_auto_restore', 06:02:25 INFO - 'tabpaint']}, 06:02:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:02:25 INFO - 'ts_paint', 06:02:25 INFO - 'tpaint', 06:02:25 INFO - 'sessionrestore', 06:02:25 INFO - 'sessionrestore_no_auto_restore', 06:02:25 INFO - 'tabpaint']}, 06:02:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:02:25 INFO - 'ts_paint', 06:02:25 INFO - 'tpaint', 06:02:25 INFO - 'sessionrestore', 06:02:25 INFO - 'sessionrestore_no_auto_restore', 06:02:25 INFO - 'tabpaint']}, 06:02:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:02:25 INFO - 'tests': ['a11yr', 06:02:25 INFO - 'ts_paint', 06:02:25 INFO - 'tpaint', 06:02:25 INFO - 'sessionrestore', 06:02:25 INFO - 'sessionrestore_no_auto_restore', 06:02:25 INFO - 'tabpaint']}, 06:02:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:02:25 INFO - 'tests': ['a11yr', 06:02:25 INFO - 'ts_paint', 06:02:25 INFO - 'tpaint', 06:02:25 INFO - 'sessionrestore', 06:02:25 INFO - 'sessionrestore_no_auto_restore', 06:02:25 INFO - 'tabpaint']}, 06:02:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:02:25 INFO - 'tests': ['tsvgx', 06:02:25 INFO - 'tsvgr_opacity', 06:02:25 INFO - 'tart', 06:02:25 INFO - 'tscrollx', 06:02:25 INFO - 'cart']}, 06:02:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:02:25 INFO - 'tsvgr_opacity', 06:02:25 INFO - 'tart', 06:02:25 INFO - 'tscrollx', 06:02:25 INFO - 'cart']}, 06:02:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:25 INFO - 'talos_options': ['--disable-e10s'], 06:02:25 INFO - 'tests': ['tp5o']}, 06:02:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:25 INFO - 'tests': ['tp5o']}, 06:02:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:25 INFO - 'talos_options': ['--disable-e10s', 06:02:25 INFO - '--xperf_path', 06:02:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:02:25 INFO - 'tests': ['tp5n']}, 06:02:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:25 INFO - 'talos_options': ['--xperf_path', 06:02:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:02:25 INFO - 'tests': ['tp5n']}}, 06:02:25 INFO - 'talos.zip': {'path': '', 06:02:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:02:25 INFO - Running post-action listener: _resource_record_post_action 06:02:25 INFO - ##### 06:02:25 INFO - ##### Running create-virtualenv step. 06:02:25 INFO - ##### 06:02:25 INFO - Running pre-action listener: _resource_record_pre_action 06:02:25 INFO - Running main action method: create_virtualenv 06:02:25 INFO - Creating virtualenv /builds/slave/test/build/venv 06:02:25 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 06:02:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:02:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:02:25 INFO - Using real prefix '/tools/python27' 06:02:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:02:26 INFO - Installing distribute.............................................................................................................................................................................................done. 06:02:29 INFO - Installing pip.................done. 06:02:29 INFO - Return code: 0 06:02:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10544ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10545e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc36a473560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052ede00>, '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 0x105156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e8b20>, '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.Y0BkLU0YWG/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.dyqHzRChDi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:02:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:02:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0BkLU0YWG/Render', 06:02:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:29 INFO - 'HOME': '/Users/cltbld', 06:02:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:29 INFO - 'LOGNAME': 'cltbld', 06:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:29 INFO - 'MOZ_NO_REMOTE': '1', 06:02:29 INFO - 'NO_EM_RESTART': '1', 06:02:29 INFO - 'PAGER': '/bin/cat', 06:02:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:29 INFO - 'PWD': '/builds/slave/test', 06:02:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:29 INFO - 'SHELL': '/bin/bash', 06:02:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dyqHzRChDi/Listeners', 06:02:29 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:02:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:29 INFO - 'USER': 'cltbld', 06:02:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:29 INFO - 'XPC_FLAGS': '0x0', 06:02:29 INFO - 'XPC_SERVICE_NAME': '0', 06:02:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:29 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 06:02:29 INFO - Cleaning up... 06:02:29 INFO - Return code: 0 06:02:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10544ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10545e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc36a473560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052ede00>, '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 0x105156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e8b20>, '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.Y0BkLU0YWG/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.dyqHzRChDi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:02:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:02:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0BkLU0YWG/Render', 06:02:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:29 INFO - 'HOME': '/Users/cltbld', 06:02:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:29 INFO - 'LOGNAME': 'cltbld', 06:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:29 INFO - 'MOZ_NO_REMOTE': '1', 06:02:29 INFO - 'NO_EM_RESTART': '1', 06:02:29 INFO - 'PAGER': '/bin/cat', 06:02:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:29 INFO - 'PWD': '/builds/slave/test', 06:02:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:29 INFO - 'SHELL': '/bin/bash', 06:02:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dyqHzRChDi/Listeners', 06:02:29 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:02:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:29 INFO - 'USER': 'cltbld', 06:02:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:29 INFO - 'XPC_FLAGS': '0x0', 06:02:29 INFO - 'XPC_SERVICE_NAME': '0', 06:02:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:29 INFO - Downloading/unpacking psutil>=0.7.1 06:02:29 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 06:02:29 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 06:02:29 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 06:02:29 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 06:02:29 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 06:02:29 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 06:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:02:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:02:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:02:32 INFO - Installing collected packages: psutil 06:02:32 INFO - Running setup.py install for psutil 06:02:32 INFO - building 'psutil._psutil_osx' extension 06:02:32 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 06:02:33 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 06:02:33 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 06:02:33 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 06:02:33 INFO - building 'psutil._psutil_posix' extension 06:02:33 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 06:02:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:02:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:02:33 INFO - ^ 06:02:33 INFO - 1 warning generated. 06:02:33 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 06:02:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:02:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:02:33 INFO - Successfully installed psutil 06:02:33 INFO - Cleaning up... 06:02:33 INFO - Return code: 0 06:02:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:02:33 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')]} 06:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:33 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')]} 06:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:33 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 0x10544ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10545e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc36a473560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052ede00>, '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 0x105156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e8b20>, '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.Y0BkLU0YWG/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.dyqHzRChDi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:02:33 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 06:02:33 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 06:02:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0BkLU0YWG/Render', 06:02:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:33 INFO - 'HOME': '/Users/cltbld', 06:02:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:33 INFO - 'LOGNAME': 'cltbld', 06:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:33 INFO - 'MOZ_NO_REMOTE': '1', 06:02:33 INFO - 'NO_EM_RESTART': '1', 06:02:33 INFO - 'PAGER': '/bin/cat', 06:02:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:33 INFO - 'PWD': '/builds/slave/test', 06:02:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:33 INFO - 'SHELL': '/bin/bash', 06:02:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dyqHzRChDi/Listeners', 06:02:33 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:02:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:33 INFO - 'USER': 'cltbld', 06:02:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:33 INFO - 'XPC_FLAGS': '0x0', 06:02:33 INFO - 'XPC_SERVICE_NAME': '0', 06:02:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:02:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:02:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:02:36 INFO - Installing collected packages: mozsystemmonitor 06:02:36 INFO - Running setup.py install for mozsystemmonitor 06:02:36 INFO - Successfully installed mozsystemmonitor 06:02:36 INFO - Cleaning up... 06:02:36 INFO - Return code: 0 06:02:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:02:36 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')]} 06:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:36 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')]} 06:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:36 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 0x10544ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10545e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc36a473560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052ede00>, '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 0x105156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e8b20>, '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.Y0BkLU0YWG/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.dyqHzRChDi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:02:36 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 06:02:36 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 06:02:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0BkLU0YWG/Render', 06:02:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:36 INFO - 'HOME': '/Users/cltbld', 06:02:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:36 INFO - 'LOGNAME': 'cltbld', 06:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:36 INFO - 'MOZ_NO_REMOTE': '1', 06:02:36 INFO - 'NO_EM_RESTART': '1', 06:02:36 INFO - 'PAGER': '/bin/cat', 06:02:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:36 INFO - 'PWD': '/builds/slave/test', 06:02:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:36 INFO - 'SHELL': '/bin/bash', 06:02:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dyqHzRChDi/Listeners', 06:02:36 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:02:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:36 INFO - 'USER': 'cltbld', 06:02:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:36 INFO - 'XPC_FLAGS': '0x0', 06:02:36 INFO - 'XPC_SERVICE_NAME': '0', 06:02:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:36 INFO - Downloading/unpacking blobuploader==1.2.4 06:02:36 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 06:02:36 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 06:02:36 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 06:02:36 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 06:02:36 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 06:02:36 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 06:02:39 INFO - Downloading blobuploader-1.2.4.tar.gz 06:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:02:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:02:39 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 06:02:39 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 06:02:39 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 06:02:39 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 06:02:39 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 06:02:39 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 06:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:02:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:02:39 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 06:02:39 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 06:02:39 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 06:02:39 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 06:02:39 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 06:02:39 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 06:02:40 INFO - Downloading docopt-0.6.1.tar.gz 06:02:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:02:40 INFO - Installing collected packages: blobuploader, requests, docopt 06:02:40 INFO - Running setup.py install for blobuploader 06:02:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:02:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:02:40 INFO - Running setup.py install for requests 06:02:41 INFO - Running setup.py install for docopt 06:02:41 INFO - Successfully installed blobuploader requests docopt 06:02:41 INFO - Cleaning up... 06:02:41 INFO - Return code: 0 06:02:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:41 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')]} 06:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:41 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')]} 06:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:41 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 0x10544ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10545e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc36a473560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052ede00>, '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 0x105156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e8b20>, '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.Y0BkLU0YWG/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.dyqHzRChDi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:02:41 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 06:02:41 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 06:02:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0BkLU0YWG/Render', 06:02:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:41 INFO - 'HOME': '/Users/cltbld', 06:02:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:41 INFO - 'LOGNAME': 'cltbld', 06:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:41 INFO - 'MOZ_NO_REMOTE': '1', 06:02:41 INFO - 'NO_EM_RESTART': '1', 06:02:41 INFO - 'PAGER': '/bin/cat', 06:02:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:41 INFO - 'PWD': '/builds/slave/test', 06:02:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:41 INFO - 'SHELL': '/bin/bash', 06:02:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dyqHzRChDi/Listeners', 06:02:41 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:02:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:41 INFO - 'USER': 'cltbld', 06:02:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:41 INFO - 'XPC_FLAGS': '0x0', 06:02:41 INFO - 'XPC_SERVICE_NAME': '0', 06:02:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:02:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-apYuVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:02:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-XWe1_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:02:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-Ff_cxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:02:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-lxXqbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:02:42 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-YaUsoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:02:42 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-3_qE4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:02:42 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-Qmzfmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:02:42 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-lOEvvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:02:42 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-1thT92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:02:42 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-uj2cgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:02:42 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-P79Nyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:02:42 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-f4lYcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:02:42 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-DsVSDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:02:42 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-yCq8Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:43 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-3o87oP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:02:43 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-wWBYoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:02:43 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-fh1iaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:02:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:02:43 INFO - Running setup.py install for manifestparser 06:02:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:02:43 INFO - Running setup.py install for mozcrash 06:02:43 INFO - Running setup.py install for mozdebug 06:02:43 INFO - Running setup.py install for mozdevice 06:02:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:02:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:02:44 INFO - Running setup.py install for mozfile 06:02:44 INFO - Running setup.py install for mozhttpd 06:02:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:02:44 INFO - Running setup.py install for mozinfo 06:02:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:02:44 INFO - Running setup.py install for mozInstall 06:02:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:02:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:02:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:02:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:02:44 INFO - Running setup.py install for mozleak 06:02:44 INFO - Running setup.py install for mozlog 06:02:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:02:44 INFO - Running setup.py install for moznetwork 06:02:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:02:45 INFO - Running setup.py install for mozprocess 06:02:45 INFO - Running setup.py install for mozprofile 06:02:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:02:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:02:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:02:45 INFO - Running setup.py install for mozrunner 06:02:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:02:45 INFO - Running setup.py install for mozscreenshot 06:02:45 INFO - Running setup.py install for moztest 06:02:45 INFO - Running setup.py install for mozversion 06:02:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:02:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:02:45 INFO - Cleaning up... 06:02:45 INFO - Return code: 0 06:02:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02: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')]} 06:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02: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')]} 06:02:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:45 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 0x10544ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10545e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc36a473560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052ede00>, '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 0x105156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e8b20>, '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.Y0BkLU0YWG/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.dyqHzRChDi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:02:45 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 06:02:45 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 06:02:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0BkLU0YWG/Render', 06:02:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:45 INFO - 'HOME': '/Users/cltbld', 06:02:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:45 INFO - 'LOGNAME': 'cltbld', 06:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:45 INFO - 'MOZ_NO_REMOTE': '1', 06:02:45 INFO - 'NO_EM_RESTART': '1', 06:02:45 INFO - 'PAGER': '/bin/cat', 06:02:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:45 INFO - 'PWD': '/builds/slave/test', 06:02:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:45 INFO - 'SHELL': '/bin/bash', 06:02:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dyqHzRChDi/Listeners', 06:02:45 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:02:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:45 INFO - 'USER': 'cltbld', 06:02:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:45 INFO - 'XPC_FLAGS': '0x0', 06:02:45 INFO - 'XPC_SERVICE_NAME': '0', 06:02:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:02:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-AWpxqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:02:46 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)) 06:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:02:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-VtET4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:02:46 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)) 06:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:02:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-0cl2Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:02:46 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)) 06:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:02:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-lNoI1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:02:46 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)) 06:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:02:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-A1c76c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:02:46 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)) 06:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:02:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-uhkWL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:02:46 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)) 06:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:02:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-FeRzgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:02:46 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)) 06:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:02:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-F4rsnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:02:47 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)) 06:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:02:47 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-RmSVvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:02:47 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)) 06:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:02:47 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-Ds6Fcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:02:47 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)) 06:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:02:47 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-JIVciQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:02:47 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)) 06:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:02:47 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-t1aDOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:02:47 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)) 06:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:02:47 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-G0QK4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:02:47 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)) 06:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:02:47 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-PiD3ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:02:47 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)) 06:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:47 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-wDnlZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:47 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)) 06:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:02:47 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-gmfLgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:02:47 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)) 06:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:02:47 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-A3okfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:02:48 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)) 06:02:48 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)) 06:02:48 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)) 06:02:48 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)) 06:02:48 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)) 06:02:48 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)) 06:02:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:50 INFO - Downloading blessings-1.6.tar.gz 06:02:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:02:50 INFO - Installing collected packages: blessings 06:02:50 INFO - Running setup.py install for blessings 06:02:50 INFO - Successfully installed blessings 06:02:50 INFO - Cleaning up... 06:02:50 INFO - Return code: 0 06:02:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:02:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:02:51 INFO - Reading from file tmpfile_stdout 06:02:51 INFO - Current package versions: 06:02:51 INFO - blessings == 1.6 06:02:51 INFO - blobuploader == 1.2.4 06:02:51 INFO - docopt == 0.6.1 06:02:51 INFO - manifestparser == 1.1 06:02:51 INFO - mozInstall == 1.12 06:02:51 INFO - mozcrash == 0.17 06:02:51 INFO - mozdebug == 0.1 06:02:51 INFO - mozdevice == 0.48 06:02:51 INFO - mozfile == 1.2 06:02:51 INFO - mozhttpd == 0.7 06:02:51 INFO - mozinfo == 0.9 06:02:51 INFO - mozleak == 0.1 06:02:51 INFO - mozlog == 3.1 06:02:51 INFO - moznetwork == 0.27 06:02:51 INFO - mozprocess == 0.22 06:02:51 INFO - mozprofile == 0.28 06:02:51 INFO - mozrunner == 6.11 06:02:51 INFO - mozscreenshot == 0.1 06:02:51 INFO - mozsystemmonitor == 0.0 06:02:51 INFO - moztest == 0.7 06:02:51 INFO - mozversion == 1.4 06:02:51 INFO - psutil == 3.1.1 06:02:51 INFO - requests == 1.2.3 06:02:51 INFO - wsgiref == 0.1.2 06:02:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02: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')]} 06:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02: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')]} 06:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:51 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 0x10544ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10545e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc36a473560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052ede00>, '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 0x105156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e8b20>, '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.Y0BkLU0YWG/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.dyqHzRChDi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:02:51 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 06:02:51 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 06:02:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0BkLU0YWG/Render', 06:02:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:51 INFO - 'HOME': '/Users/cltbld', 06:02:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:51 INFO - 'LOGNAME': 'cltbld', 06:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:51 INFO - 'MOZ_NO_REMOTE': '1', 06:02:51 INFO - 'NO_EM_RESTART': '1', 06:02:51 INFO - 'PAGER': '/bin/cat', 06:02:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:51 INFO - 'PWD': '/builds/slave/test', 06:02:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:51 INFO - 'SHELL': '/bin/bash', 06:02:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dyqHzRChDi/Listeners', 06:02:51 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:02:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:51 INFO - 'USER': 'cltbld', 06:02:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:51 INFO - 'XPC_FLAGS': '0x0', 06:02:51 INFO - 'XPC_SERVICE_NAME': '0', 06:02:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:51 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)) 06:02:51 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)) 06:02:51 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)) 06:02:51 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)) 06:02:51 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)) 06:02:51 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)) 06:02:51 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)) 06:02:51 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)) 06:02:51 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)) 06:02:51 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)) 06:02:51 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)) 06:02:51 INFO - Cleaning up... 06:02:51 INFO - Return code: 0 06:02:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:02: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')]} 06:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02: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')]} 06:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:51 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 0x10544ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10545e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc36a473560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052ede00>, '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 0x105156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e8b20>, '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.Y0BkLU0YWG/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.dyqHzRChDi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:02:51 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 06:02:51 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 06:02:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0BkLU0YWG/Render', 06:02:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:51 INFO - 'HOME': '/Users/cltbld', 06:02:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:51 INFO - 'LOGNAME': 'cltbld', 06:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:51 INFO - 'MOZ_NO_REMOTE': '1', 06:02:51 INFO - 'NO_EM_RESTART': '1', 06:02:51 INFO - 'PAGER': '/bin/cat', 06:02:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:51 INFO - 'PWD': '/builds/slave/test', 06:02:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:51 INFO - 'SHELL': '/bin/bash', 06:02:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dyqHzRChDi/Listeners', 06:02:51 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:02:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:51 INFO - 'USER': 'cltbld', 06:02:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:51 INFO - 'XPC_FLAGS': '0x0', 06:02:51 INFO - 'XPC_SERVICE_NAME': '0', 06:02:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:51 INFO - Downloading/unpacking jsonschema 06:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:02:54 INFO - Downloading/unpacking functools32 (from jsonschema) 06:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:54 INFO - Downloading functools32-3.2.3-2.tar.gz 06:02:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:02:54 INFO - warning: no files found matching '*.txt' 06:02:54 INFO - no previously-included directories found matching 'build' 06:02:54 INFO - no previously-included directories found matching 'dist' 06:02:54 INFO - no previously-included directories found matching '.git*' 06:02:54 INFO - Installing collected packages: jsonschema, functools32 06:02:54 INFO - Running setup.py install for functools32 06:02:54 INFO - warning: no files found matching '*.txt' 06:02:54 INFO - no previously-included directories found matching 'build' 06:02:54 INFO - no previously-included directories found matching 'dist' 06:02:54 INFO - no previously-included directories found matching '.git*' 06:02:54 INFO - Successfully installed jsonschema functools32 06:02:54 INFO - Cleaning up... 06:02:54 INFO - Return code: 0 06:02:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:02:54 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')]} 06:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:54 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')]} 06:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:54 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 0x10544ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10545e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc36a473560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052ede00>, '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 0x105156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e8b20>, '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.Y0BkLU0YWG/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.dyqHzRChDi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:02:54 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 06:02:54 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 06:02:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0BkLU0YWG/Render', 06:02:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:54 INFO - 'HOME': '/Users/cltbld', 06:02:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:54 INFO - 'LOGNAME': 'cltbld', 06:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:54 INFO - 'MOZ_NO_REMOTE': '1', 06:02:54 INFO - 'NO_EM_RESTART': '1', 06:02:54 INFO - 'PAGER': '/bin/cat', 06:02:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:54 INFO - 'PWD': '/builds/slave/test', 06:02:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:54 INFO - 'SHELL': '/bin/bash', 06:02:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dyqHzRChDi/Listeners', 06:02:54 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:02:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:54 INFO - 'USER': 'cltbld', 06:02:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:54 INFO - 'XPC_FLAGS': '0x0', 06:02:54 INFO - 'XPC_SERVICE_NAME': '0', 06:02:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:55 INFO - Downloading/unpacking flake8 06:02:55 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 06:02:55 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 06:02:55 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 06:02:55 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 06:02:55 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 06:02:55 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 06:02:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:02:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:02:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:02:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:02:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:02:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:02:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:02:59 INFO - no previously-included directories found matching 'docs/_build' 06:02:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:02:59 INFO - Running setup.py install for pep8 06:02:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:02:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:02:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:02:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:02:59 INFO - no previously-included directories found matching 'docs/_build' 06:02:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:02:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:02:59 INFO - Cleaning up... 06:02:59 INFO - Return code: 0 06:02:59 INFO - Running post-action listener: _resource_record_post_action 06:02:59 INFO - Running post-action listener: _start_resource_monitoring 06:02:59 INFO - Starting resource monitoring. 06:02:59 INFO - ##### 06:02:59 INFO - ##### Running install step. 06:02:59 INFO - ##### 06:02:59 INFO - Running pre-action listener: _resource_record_pre_action 06:02:59 INFO - Running main action method: install 06:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:02:59 INFO - Reading from file tmpfile_stdout 06:02:59 INFO - Detecting whether we're running mozinstall >=1.0... 06:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:02:59 INFO - Reading from file tmpfile_stdout 06:02:59 INFO - Output received: 06:02:59 INFO - Usage: mozinstall [options] installer 06:02:59 INFO - Options: 06:02:59 INFO - -h, --help show this help message and exit 06:02:59 INFO - -d DEST, --destination=DEST 06:02:59 INFO - Directory to install application into. [default: 06:02:59 INFO - "/builds/slave/test"] 06:02:59 INFO - --app=APP Application being installed. [default: firefox] 06:02:59 INFO - mkdir: /builds/slave/test/build/application 06:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:03:33 INFO - Reading from file tmpfile_stdout 06:03:33 INFO - Output received: 06:03:33 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 06:03:33 INFO - Running post-action listener: _resource_record_post_action 06:03:33 INFO - ##### 06:03:33 INFO - ##### Running run-tests step. 06:03:33 INFO - ##### 06:03:33 INFO - Running pre-action listener: _resource_record_pre_action 06:03:33 INFO - Running main action method: run_tests 06:03:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:03:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:03:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:03:33 INFO - 2016-04-19 06:03:33.389 screenresolution[1919:13592] starting screenresolution argv=screenresolution get 06:03:33 INFO - 2016-04-19 06:03:33.392 screenresolution[1919:13592] Display 0: 1600x1200x32@60 06:03:33 INFO - 2016-04-19 06:03:33.398 screenresolution[1920:13594] starting screenresolution argv=screenresolution list 06:03:33 INFO - Available Modes on Display 0 06:03:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:03:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:03:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:03:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:03:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:03:33 INFO - Intel Iris: 06:03:33 INFO - Chipset Model: Intel Iris 06:03:33 INFO - Type: GPU 06:03:33 INFO - Bus: Built-In 06:03:33 INFO - VRAM (Dynamic, Max): 1536 MB 06:03:33 INFO - Vendor: Intel (0x8086) 06:03:33 INFO - Device ID: 0x0a2e 06:03:33 INFO - Revision ID: 0x0009 06:03:33 INFO - Displays: 06:03:33 INFO - Display: 06:03:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:03:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:03:33 INFO - Display Serial Number: 1600x1200 60 06:03:33 INFO - Main Display: Yes 06:03:33 INFO - Mirror: Off 06:03:33 INFO - Online: Yes 06:03:33 INFO - Rotation: Supported 06:03:33 INFO - Return code: 0 06:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:03:33 INFO - Python 2.7.3 06:03:33 INFO - Return code: 0 06:03:33 INFO - grabbing minidump binary from tooltool 06:03:33 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')]} 06:03:33 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 0x1052ede00>, '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 0x105156db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:03:33 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 06:03:33 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 06:03:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:03:33 INFO - Return code: 0 06:03:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:03:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:03:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:03:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:03:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:03:34 INFO - Return code: 0 06:03:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--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 06:03:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0062 --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 06:03:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y0BkLU0YWG/Render', 06:03:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:03:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:03:34 INFO - 'HOME': '/Users/cltbld', 06:03:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:03:34 INFO - 'LOGNAME': 'cltbld', 06:03:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:03:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:34 INFO - 'MOZ_NO_REMOTE': '1', 06:03:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:03:34 INFO - 'NO_EM_RESTART': '1', 06:03:34 INFO - 'PAGER': '/bin/cat', 06:03:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:34 INFO - 'PWD': '/builds/slave/test', 06:03:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:03:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:03:34 INFO - 'SHELL': '/bin/bash', 06:03:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dyqHzRChDi/Listeners', 06:03:34 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:03:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:03:34 INFO - 'USER': 'cltbld', 06:03:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:03:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:34 INFO - 'XPC_FLAGS': '0x0', 06:03:34 INFO - 'XPC_SERVICE_NAME': '0', 06:03:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--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 06:03:35 INFO - mozversion application_buildid: 20160419030312 06:03:35 INFO - mozversion application_changeset: ae7413abfa4d3954a6a4ce7c1613a7100f367f9a 06:03:35 INFO - mozversion application_display_name: Nightly 06:03:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:03:35 INFO - mozversion application_name: Firefox 06:03:35 INFO - mozversion application_remotingname: firefox 06:03:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:03:35 INFO - mozversion application_vendor: Mozilla 06:03:35 INFO - mozversion application_version: 48.0a1 06:03:35 INFO - mozversion platform_buildid: 20160419030312 06:03:35 INFO - mozversion platform_changeset: ae7413abfa4d3954a6a4ce7c1613a7100f367f9a 06:03:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:03:35 INFO - mozversion platform_version: 48.0a1 06:03:35 INFO - using testdate: 1461071015 06:03:35 INFO - actual date: 1461071015 06:03:35 INFO - starting webserver on 'localhost:51157' 06:03:35 INFO - SUITE-START | Running 2 tests 06:03:35 INFO - TEST-START | dromaeo_css 06:03:35 INFO - operating with platform_type : mac_ 06:03:35 INFO - Initialising browser for dromaeo_css test... 06:03:35 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpj8OjoA/profile http://localhost:51157/getInfo.html) 06:03:38 INFO - PROCESS | 1938 | __metrics Screen width/height:1600/1200 06:03:38 INFO - PROCESS | 1938 | colorDepth:24 06:03:38 INFO - PROCESS | 1938 | Browser inner width/height: 1024/689 06:03:38 INFO - PROCESS | 1938 | __metrics 06:03:38 ERROR - PROCESS | 1938 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:03:38 INFO - TEST-INFO | 1938: exit 0 06:03:38 INFO - Browser initialized. 06:03:38 INFO - Running cycle 1/1 for dromaeo_css test... 06:03:38 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpj8OjoA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:03:50 INFO - PROCESS | 1942 | RSS: Main: 248225792 06:03:50 INFO - PROCESS | 1942 | 06:04:40 INFO - PROCESS | 1942 | 1461071080549 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] 06:06:51 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:51157/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51157/tests/dromaeo/cssquery-ext.html) 06:06:53 INFO - PROCESS | 1942 | RSS: Main: 263491584 06:06:53 INFO - PROCESS | 1942 | 06:09:55 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:51157/tests/dromaeo/cssquery-ext.html (next: http://localhost:51157/tests/dromaeo/cssquery-jquery.html) 06:09:56 INFO - PROCESS | 1942 | RSS: Main: 275271680 06:09:56 INFO - PROCESS | 1942 | 06:12:57 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:51157/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51157/tests/dromaeo/cssquery-mootools.html) 06:12:58 INFO - PROCESS | 1942 | RSS: Main: 277790720 06:12:58 INFO - PROCESS | 1942 | 06:16:00 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:51157/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51157/tests/dromaeo/cssquery-prototype.html) 06:16:00 INFO - PROCESS | 1942 | RSS: Main: 278667264 06:16:00 INFO - PROCESS | 1942 | 06:19:03 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:51157/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51157/tests/dromaeo/cssquery-yui.html) 06:19:04 INFO - PROCESS | 1942 | RSS: Main: 281677824 06:19:04 INFO - PROCESS | 1942 | 06:22:06 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:51157/tests/dromaeo/cssquery-yui.html (next: http://localhost:51157/tests/dromaeo/cssquery-dojo.html) 06:22:06 INFO - PROCESS | 1942 | RSS: Main: 282697728 06:22:06 INFO - PROCESS | 1942 | 06:22:06 INFO - PROCESS | 1942 | __start_tp_report 06:22:06 INFO - PROCESS | 1942 | _x_x_mozilla_page_load 06:22:06 INFO - PROCESS | 1942 | _x_x_mozilla_page_load_details 06:22:06 INFO - PROCESS | 1942 | |i|pagename|runs| 06:22:06 INFO - PROCESS | 1942 | |0;dojo.html;2900.057481318571;3402.370561446133;3410.2326976430304;3429;3507.9649203507956;4343.457067866517;4852.58753005994;5261.921306132239;5638.267025286717;5682.346530149034;4847.927281090778;5610.719464026803;5704.1443783432505;5736.426357364261;5766.279215098113;5167.612429067816;5171.974140129303;5191.636585439021;5228.79084836606;5253.921191182136;5271.999999999981;5297.761600727977;5310.15037593985;5338.919916201241;5392.379876314215;5104.719240441774;5216.5305122538775;5222.216667499867;5250;5254.290670759437;5176.456472070454;5196.61025423091;5216.869578260574;5217.47825217479;5264.105102132647;5080.13637681595;5165.74171291434;5217.3999990000875;5219.530242278213;5235.947640523622;4766.975100353406;5228.477152284741;5559.916601250984;5591.580631452616;5628.634138780966;5242.528172464458;6113.296970848321;6138.539609529304;6140.907886381708;6205.255369355661;6101.328853826076;6147.047207682816;6216.533759968021;6217.253929528486;6227.937720622781;5825.15535247391;5838.970805146032;5842.357340692521;5853.999999999957;5903.49820265278;6237.157983672146;6274.843128921813;6276.686165691697;6279.96860015697;6425.678716064178;6001.339852616209;6084.209052823105;6132.722655450899;6176.413240742122;6187.16473276111;6151.692415379213;6203.8138855834395;6223.346548612421;6228.564000520011;6230.626162430178;6064.090386441981;6111.205543279434;6112.235970503687;6158.938410615837;6172.598781079216;6057.878842423215;6098.129681996382;6113.081058500009;6197.96901015492;6217.347178546278;4158.313878210122;4937.08663897173;4939.407271127416;4947.851564453073;4952.529509696573;4389.385486031958;4394.824207031683;4412.84555040572;4430.401895744098;4485.282354823278;4745.525447455296;5573.7459071708545;5640.746166422521;5758.107493338539;5775.768969241183;6184.752609895644;6214.564980451325;6218.720157592919;6219.911515484772;6231.2522497300615;5737.569682273846;5743.684097374685;5744.51171650406;5746.9425305747245;5753.971230143822;5297.682139071668;5339.466053394707;5395.244665746799;5417.539509141767;5439.456054394608;6320.494360451061;6327.4938004959495;6352.269489008823;6353;6362.236531616236;6042.1843051187525;6223.533235007302;6224.595401298901;6226.719797609027;6227.221597300338;6263.718132683949;6330.39861213184;6380.808575742735;6400.39196276353;6401.615903045832;6147.0779383092895;6179.073139029181;6182.165407669907;6188.9690551546955;6193.690315484298;5046.949530504648;6121.816345509642;6161.353057928853;6226.719797609209;6243.406876346739;5216.243644671577;6053.4551890330085;6093.866968087874;6098.91636565712;6137.508999280136;5490.588205884655;5540;6055.424734650202;6117.724702388314;6123.14276001369;5815.534757219328;5875.823725288248;5915.733791979285;5969.611975221596;5980.491658209101;6033.728482218223;6065.211522502046;6079.270487541523;6099.329073801967;6134.478569321479;5980.671063091571;5998.640081595118;6005.7297421617;6024.849378765391;6042.425969532887 06:22:06 INFO - PROCESS | 1942 | |1;ext.html;507.2214151277788;512.2239806692859;515.1577171324883;561.8848136132092;571.2003195526265;34061;39301.60698393015;39708.205835883266;39895.8031259062;40425.78722638318;33444.66221351143;40978.7951060245;41348.79325603368;41681.166376672525;41758.16483670333;8193.631286592117;9353.345265831394;9563.139317461428;9583.089606487372;9622.518874056304;8263.338932885355;9334.906650933506;9417.576209070574;9476.194523465514;9521.523923803818;9520;9564.234861211087;9567.569459374345;9591.376560523544;9620.182284505825;9479.47862867542;9495.382800118005;9549.856752148724;9568.617255309779;9571.95214023929;9421.057894210593;9491.905080949171;9552.474613896233;9553.952230238874;9569.138777509988;37963.81018094919;37985;38204.61795382039;38400.61599383999;38507.03732406684;2515.748425157488;2733.494303553849;3351.8156501392414;3690.2619476104887;3815.3323168445413;27524.58713119305;27964.440711185664;28768.856155719295;28965.855170724222;29045.41909161826;2705.147878418292;2722.8366298021983;2789.7070807565115;2815.1976686644207;2838.7728981681416;327512;409683;409818;414225;414823.999999997;36113.27773444516;36172.81913590415;36329;61764;62312.688436558434;34840.47739283913;35033.82483087568;35127.12182195415;35290.82354588211;35388.11529711778;14671.193084380247;14938.925305373403;15058.171800551076;15073.623159420882;15107.39570417171;9477.810443791086;11545.769084618261;11602.245854019462;11636;11656.941715291368;8050.396220283502;8134.633941472648;8196.713115040944;8220.095789463154;8236;3339.1652086978256;3384.2892992471366;3425.8287085646116;3425.9828700856337;3426.777259478126;989.5151375825938;996.9202463802878;1004.4023805835516;1053.1943063556384;1128.0637071230858;24729.1344802931;25034.749652503608;29923.850380747957;30003.925914514177;30162.547561786592;1018.5976539266948;1109.5118148014847;1151.6199654114123;1159.2349049627205;1159.6926814394192;15310.115096825471;15315.92342038305;15416;15523.84476155224;15675.686486270439;561508.3849161456;574201;631117;635447;635624;57862.421375786544;59683;60121;60212;60366.69816650889;1408.204364534035;1445.6602698365875;1475.3287254299269;1480.326451464581;1482.0218655687195;28983.647010243225;29269.707302926698;29531.704682953754;29993;30109.849450752605;52150.73924630353;52372.738136309075;52481.7375913118;52518.73740631272;52530.47469525256;556642;559634;561655;561810;564594;26731.599026015014;33834.83082584571;40518.1896362077;43030.35454468123;43113.78443107764;44055.559444405146;44801;44886;44928.77535612301;45315.54684453245;36677.449838251916;36782;37076.44385334276;37730.056748581505;37795;36036.639633604376;36172.792875176514;36346;36631;37032;31836.363272733954;31978.040658780275;36960.63039369572;37002.814985924895;37003.62996370002;30160.396792064475;31392.686073138975;33686;35171;35286.823565882005;24412.145574904793;24595.13917012896;24787.504249915262;24943.750562494868;25344.493110137326 06:22:06 INFO - PROCESS | 1942 | |2;jquery.html;392.7623787608497;393.1743338988125;397.08471972104286;400.3174587328605;403.5843081625926;13448.596542103727;19734.111964961576;20452.159305662488;20452.386428407153;20570.588588228227;19878.304259350927;20102;20439.386818395473;21279.57440851182;21473.355799326007;5865.061590145578;5921.644701317913;6100.877982440348;6110.602810817282;6116.327204007555;5138.5889128869785;6011.9779637461515;6027.879442411149;6087.634741915477;6093.908591371133;5844.766209351621;5976.731047102869;6107.725152368132;6115.908261376083;6124.081387791823;5779.595428320019;5920.052791553352;6031.487323577501;6035.155078289065;6075.939240607581;5197.8440646780655;5246.7638956247065;5255.264263003144;5259.710715910624;5265.578753699695;25204.73976301196;25235;25704.357391065187;26049.869750651316;26227.475450490885;2075.2217918280644;2097.381272524609;2150.666646669769;2173.6630822222583;2216.9382821458476;14395.496157634538;14432.494862679861;14569.980101392906;14842;15136.016158949633;1400.8459069502346;1712.6831536165726;1734.0116133803738;1773.1931970953185;1785.8660600455019;101931.49034254855;103961.48019259855;106727.93272067336;106848.93151068468;108091.45954270256;10811.40537270442;11319.094472442184;11350.318980861175;11367.374794386387;11445.427728613537;14201.573952781433;14251.714965700628;14263.643408914653;14273.85726142746;14294.356753946098;8615.741527754177;8749.16882896124;8763.211310982042;8767.21095101444;8770.868436973451;8676.1323867614;8685.739427817176;8687.478751274944;8813.603387847563;8828.470291782514;5591.776328946878;6779.6271205084195;6790.623281851411;6798.966005169942;6812.182538095361;1648.3900956646119;1653.7602047703015;1879.1825555883236;1915.549845786239;1917.8753381030187;830.4726498673265;863.3395452478859;912.5619702542816;946.5740416812324;973.3867663372031;17716;20413.081411336527;21091;21409.57180856374;21518;905.3436258712512;991.9206463482905;998.4109375468508;1011.5751384418562;1043.5095505112586;11098.833517497244;11480.081593472501;11489.253198542068;11565.306081635128;11632.185746997799;532945;543706;545959;548640;594779;109591.68470679922;110421.44789276003;111240;111861.44069279601;112626.43686781514;1031.118393773328;1041.3335465302212;1047.0628787235382;1108.0304733358473;1113.7549739057395;17614.823851761317;18412.907935460236;18527.166277517274;18542.83648751662;18735.718964215273;45180.87047823831;46039;48285;48561.5143848557;48824;63279.0508142369;64473;66304.6684766573;67057.32942670511;69115.3088469129;7099.858002839811;7985.6007199638625;8025.2777250047775;8196.467229630054;8489.40574159803;10103.343282686601;11003.394813285026;12283.955863751324;12625.810612840998;13029.47882084706;10058.798824023625;10828.512716927915;11031.333223409652;11044;11088.722781930517;10981.231313807957;11061.391623460788;11173.488583932562;11413.600523981953;11464.598739044093;11492.310461372344;11590.768184636428;11597.942010289895;11742.647720568397;11894.524219031142;6718.630475323904;7450.329470347695;7535.962320188364;7577.886331704918;7845.960770196112;10222.693319200436;11233.438328083726;11312.377819220023;11620.070394368262;11643.708907277047 06:22:06 INFO - PROCESS | 1942 | |3;mootools.html;1588.340838552001;1627.3409269245954;1852.972205416918;1886.1229528269353;1923.0865338963995;8074.192580741923;8645.69740059098;8665.826683466326;8916.242119419849;8957.328200384973;8635;8699.304055675546;8750.606222719976;8791.824163516741;8793.516356600385;2421.769931856475;2444.8655323957173;2445.963310550343;2446.7308596054418;2458.1519375815315;2418.733939266679;2431.2463136427764;2435.756424357568;2439.756024397555;2456.0544190486703;2044.7750747417772;2431.6352547117986;2455.2143314139485;2455.3002394317623;2460.5694003549397;2143.981608735838;2405.6511805788236;2418.8790560471994;2425.708914930211;2431.6960379952507;1862.7671541057368;1982.8611997160206;2417.347316224627;2423.5879900416794;2439.7194322652945;8832.646694132227;8928.419652722552;8931.732048038504;8949.507777072324;8956.820863582758;5221.086309895791;5420.403755586883;5475.972620136914;5501.944980550224;5518.944810551883;3592.0481072515804;3631.5279013728045;3635.073056370635;3650.3611867923273;3661.340958627446;928.5542939389063;1046.9005444482762;1049.3022140276707;1059.5285098131335;1061.0874647802884;11442.713932151679;11634.360110193937;11665.066794656406;11703.239289446245;11749.177557570887;4617.907641847144;4734.810607575659;4854.927176092361;4866.9513304867205;4879.39007624047;9930.255230857714;10056.145227655585;10059.69820905374;10068.496575171212;10072.899271007343;5341.62608617393;5349.5720342372515;5401.891962160735;5412.350517937873;5421.566274698014;4180.519240287345;4745.572898439157;4883;4889.413270407574;4920;4049.392591111298;4075.633193012584;4077.5996165021543;4088.8160032798596;4102.159057393227;1360.6122255157234;1366.7539842828187;1368.8631136886231;1378.1730961423266;1379.296558755022;794.7655441644729;908.7773495493515;929.8512238042016;933.169479163545;946.8011717539393;5639.407862174495;5753.108268218432;5772.278465191851;5885.323187833368;5939.70301484924;446.6449172907546;448.0836688971062;456.465934856219;994.2841154368842;1003.6687892995294;3871.5160604924386;3953.8418463261146;3964.1675248197625;3997.980010099931;4030.2141082488633;8889.644414223489;10674.946625266979;10812.243142979916;10967.122630189566;11029.944850275697;10722.624708135178;10855.837162442569;10913.618023369145;10964.945175274073;10976.176786741027;8106.837863242702;8152.266296033267;8194.385421093442;8195.877061844078;8291.461055031403;5790;5791.986402379483;5792.507636850914;5828.53371730269;5900.291964964232;9869.963653816247;10093.091621754078;10186.745331366776;10193.949030254802;10194.490275486047;9983.301168918397;10216.846747298649;10290;10346;10348.637797677045;7036.014957906;7234.276572342724;7579.658915348712;7600.771976840703;7621.466497345133;8329.750107496784;8341.332693384637;8384.203500667427;8389.95805020971;8487.193716596914;7290.270972902667;7470.925290747023;7474.439417043634;7593.5823529706395;7603.771886843404;7245.637718113968;7303;7334.523255988343;7341.045664063851;7341.963290183515;6759.831004224934;6778.084958530535;6824.93175068243;6827.52207345481;6857.2114206866845;3873.7094717896834;4534.183846907456;4614.423197100363;4615.769211539342;4678.929816052694;4377.409049778239;4752.693009422436;4820.4456487504385;4832.106060378841;4968.006398720198 06:22:06 INFO - PROCESS | 1942 | |4;prototype.html;321.39096412298693;321.74582080156677;329.8284891856235;331.13903849990027;332.0685477236351;5519.834404967847;5842.743810080837;6218.875622487548;6312.084747711579;6404.391582799638;4561.96629241554;5136.589072874171;5692.288463942007;5761.9135712964335;6213.34759850216;3578.946315805265;4446.333050042487;4612.3542704021465;4658.347831303603;4662.207424737802;3861.5945325740813;4054.513458384998;4140.254754144253;4629.0279041401345;4645.187092258841;3699.278640665071;4389.4952080510675;4602.516735742749;4621.907561848761;4623.976880115595;3961.445397644332;4522.68341216115;4599.701019433726;4635.46692130406;4644.512326205768;3763.717721170923;3971;3986.222686576119;3989.341758609855;4002.4996875390575;5451.691594017447;5563.666180029211;6067.635941843503;6074.301455332649;6117.541184411187;4605.401297831294;5249.606279529051;5412.83761487156;5426.75579598915;5455.509004189642;5475.370332411784;6558;6587.868242635169;6594.274629790719;6611.272759996396;4316.352547117926;4434.556544345572;4448.466184057934;4452.398926144993;4465.665075119379;6646.335366463363;6993.230744618088;6996.510244282902;7023.367896889305;7050.717971281194;3938.428927805452;4403.700908232079;4513.300438432048;4523;4554.407926969473;4375.190589740908;4598.425196850394;4609.2394754865745;4612.362611273017;4630.629549636021;5386.757595908193;5394.271773310631;5402.567794576503;5432.158015507603;5446.645968012146;6626.304238055031;6653.201615806038;6653.367930046637;6665.300143484864;6672.065910772496;1460.5180290504109;1558.602556348124;1564.4824520215373;1567.3025503650765;1594.4339759385482;932.9720108396759;977.4184360305607;991.2119864707574;1006.2855372685475;1010.6664800615779;6091.360407157274;6104.786332478342;6162.22972128484;6198.876022479525;6232.968835155795;6180.381961803873;6242.907491189115;6331.303556608769;6959.269276725972;6984.161900571964;4688.179568575486;5696.715164241854;5901.970490147608;6139.447449729546;6203.8138855834395;3558.768680035789;3622.4566315052953;3626.202235508184;3663.618647878847;3663.8534458621357;6412.543282418675;6760.459163266927;6863.622500762506;7129.536580122275;7164.641767911688;6136.6011209271255;6739.93260067393;7063.964680176567;7063.964680176567;7073.080499535027;6860.828479288058;7119.501634885612;7184.1019872515935;7185.604791736505;7194.352508274281;6158.599691020069;6697.330266973264;6872.896906546306;6883.655817209019;6915.550489218184;6285.214348206474;6418.4544313731985;6488.740450381932;6797.286284940208;6802.455803535804;6144.38556144382;7245.275472452712;7271.272872712686;7302.415806735555;7356;3724.7020238380323;4164.12553363797;4198.895027624334;4400.161895577398;4436.911261774811;6508.316626754123;6582.736690532325;6903.275156108737;6981.441484681315;6983.895241571482;6576.671166441754;6643.2360278568585;6744;6770.830729231809;6773.661316934035;5861.6189947653265;6482.546221764431;6713.227978782503;6722.353023509271;6790.8641827164165;5553.416891226363;6376.107344971801;6407.967960160169;6488.021153548213;6588.571742836701;5074.06129865976;6503.02454631809;6667.966465197902;6720.563163394364;6751.864962700817;5478.91781623284;5669.4047125051275;6264.248290205204;6632.83417914556;6645.568038077509 06:22:06 INFO - PROCESS | 1942 | |5;yui.html;572.6621293436872;607.8936186167423;651.3844417025911;729.5659082845708;774.2876553570715;14517.927410362947;14874.405023799061;15070.171140587263;15107.622309442242;15140.394384224632;13840.930795346034;13919.164850109;13954.023218374718;13976.161430314189;14004.78992815106;702.5257950883159;706.159669992707;866.1987661413199;878.5738916625431;910.8542633178693;868.6699054359335;896.9596368163416;900.3562452846213;906.5376657904483;907.2197909797569;918.857577075551;932.664240873285;960.8174446855076;964.4358050540442;965.3194497878978;925.0425809287389;941.0542404883083;953.947532885691;956.8995255498212;958.2956526952685;685.3386482044801;700.8528209076101;708.8653155900363;719.2735337309302;722.8301349182938;15071.547853564301;15099.471518496799;15242.771358429633;15282.235888205545;15334.156621385819;12023.819642705366;12242.775722427776;12434.751304973941;12900.290484023375;13055;9715.902840971641;10031.949840250825;10090.899091009143;10152.340097893688;10560.313579617301;3804.068003339172;3851;3881.107345310566;3890.202508485782;4009.4186342980106;74207.25792742112;78266.60866695688;79005;80167.5991620044;82454.58772706157;9265.166135047743;9327.906720932839;9382.437053776795;9492.95253523728;9531.760036391443;20833.374998750063;20865.478363041046;21047.78952210489;21214.893925530272;21313.573728525655;7347.63261836906;7487.1764105948305;7507.1366792818435;7522.699092036257;7669.769906902802;4066.7763273019677;4081.2449696806184;4083.224187404384;4091.2226676931286;4096.160287141129;2750.5049091163382;3523.5067090607336;3604.2611264690677;3644.325799727059;3681.9447708284397;615.2985596420085;640.4684112186874;683.111954459201;699.9860002799916;704.6934583456213;493.33646245799343;501.929729837823;533.0378666506915;566.8068715354202;583.5069366385397;7524.288774849263;7949.403794715419;8063.19368063189;8160.224778646019;8206.958965205136;543.3619775987602;560.9859753506195;568.883378907323;600.8197540737849;615.7106160104744;3643.7449378543247;3835.347990841564;3892.3188442022533;3928.823202955874;4003.559608443069;95985;96360;97627;98201;98231.50884245533;66515.33484665092;73075;82429;83507;84327;68819.08580513205;71751;74164.25835741573;74389.51220975659;75112.87330690044;7445.292697193758;7719.92280077192;7722.034745656793;7871.842563148591;8094.554799485849;40676.79661601673;41362;41555.792221038704;41875.162496750505;44095;64047.719045617894;64752.381190470616;64997;65093.67453162704;65536.67231663811;10630;10719.89280107189;10737;11126.276792008493;11288.379139147097;11432.428378580871;11547.422628868355;11567.305961642329;11685.941570292094;11849.466773995364;11353.489092991;11493.080553555528;11559.653210403701;11803.74637200249;11835.881641183478;11367.886321136682;11488.712782180512;11578.768424631291;11763.470643820878;11767.23512971654;11333.320000799979;11340.716482088013;11360.204785664924;11589.6523104307;11892.989095926943;9322.300827437834;9421.85644068721;9575.856362154434;9863.802723945624;9964;9509.524523773645;9577.23382129442;9620.326577139533;9644.75888102803;9684.70945871625 06:22:06 INFO - PROCESS | 1942 | __end_tp_report 06:22:06 INFO - PROCESS | 1942 | __start_cc_report 06:22:06 INFO - PROCESS | 1942 | _x_x_mozilla_cycle_collect,403 06:22:06 INFO - PROCESS | 1942 | __end_cc_report 06:22:06 INFO - PROCESS | 1942 | __startTimestamp1461072126864__endTimestamp 06:22:06 INFO - PROCESS | 1942 | 06:22:06 INFO - PROCESS | 1942 | ------- Summary: start ------- 06:22:06 INFO - PROCESS | 1942 | Number of tests: 6 06:22:06 INFO - PROCESS | 1942 | 06:22:06 INFO - PROCESS | 1942 | [#0] dojo.html Cycles:165 Average:5674.35 Median:5915.73 stddev:668.27 (11.3%) stddev-sans-first:633.89 06:22:06 INFO - PROCESS | 1942 | Values: 2900.1 3402.4 3410.2 3429.0 3508.0 4343.5 4852.6 5261.9 5638.3 5682.3 4847.9 5610.7 5704.1 5736.4 5766.3 5167.6 5172.0 5191.6 5228.8 5253.9 5272.0 5297.8 5310.2 5338.9 5392.4 5104.7 5216.5 5222.2 5250.0 5254.3 5176.5 5196.6 5216.9 5217.5 5264.1 5080.1 5165.7 5217.4 5219.5 5235.9 4767.0 5228.5 5559.9 5591.6 5628.6 5242.5 6113.3 6138.5 6140.9 6205.3 6101.3 6147.0 6216.5 6217.3 6227.9 5825.2 5839.0 5842.4 5854.0 5903.5 6237.2 6274.8 6276.7 6280.0 6425.7 6001.3 6084.2 6132.7 6176.4 6187.2 6151.7 6203.8 6223.3 6228.6 6230.6 6064.1 6111.2 6112.2 6158.9 6172.6 6057.9 6098.1 6113.1 6198.0 6217.3 4158.3 4937.1 4939.4 4947.9 4952.5 4389.4 4394.8 4412.8 4430.4 4485.3 4745.5 5573.7 5640.7 5758.1 5775.8 6184.8 6214.6 6218.7 6219.9 6231.3 5737.6 5743.7 5744.5 5746.9 5754.0 5297.7 5339.5 5395.2 5417.5 5439.5 6320.5 6327.5 6352.3 6353.0 6362.2 6042.2 6223.5 6224.6 6226.7 6227.2 6263.7 6330.4 6380.8 6400.4 6401.6 6147.1 6179.1 6182.2 6189.0 6193.7 5046.9 6121.8 6161.4 6226.7 6243.4 5216.2 6053.5 6093.9 6098.9 6137.5 5490.6 5540.0 6055.4 6117.7 6123.1 5815.5 5875.8 5915.7 5969.6 5980.5 6033.7 6065.2 6079.3 6099.3 6134.5 5980.7 5998.6 6005.7 6024.8 6042.4 06:22:06 INFO - PROCESS | 1942 | 06:22:06 INFO - PROCESS | 1942 | [#1] ext.html Cycles:180 Average:64426.13 Median:37054.22 stddev:141802.26 (382.7%) stddev-sans-first:142118.84 06:22:06 INFO - PROCESS | 1942 | Values: 507.2 512.2 515.2 561.9 571.2 34061.0 39301.6 39708.2 39895.8 40425.8 33444.7 40978.8 41348.8 41681.2 41758.2 8193.6 9353.3 9563.1 9583.1 9622.5 8263.3 9334.9 9417.6 9476.2 9521.5 9520.0 9564.2 9567.6 9591.4 9620.2 9479.5 9495.4 9549.9 9568.6 9572.0 9421.1 9491.9 9552.5 9554.0 9569.1 37963.8 37985.0 38204.6 38400.6 38507.0 2515.7 2733.5 3351.8 3690.3 3815.3 27524.6 27964.4 28768.9 28965.9 29045.4 2705.1 2722.8 2789.7 2815.2 2838.8 327512.0 409683.0 409818.0 414225.0 414824.0 36113.3 36172.8 36329.0 61764.0 62312.7 34840.5 35033.8 35127.1 35290.8 35388.1 14671.2 14938.9 15058.2 15073.6 15107.4 9477.8 11545.8 11602.2 11636.0 11656.9 8050.4 8134.6 8196.7 8220.1 8236.0 3339.2 3384.3 3425.8 3426.0 3426.8 989.5 996.9 1004.4 1053.2 1128.1 24729.1 25034.7 29923.9 30003.9 30162.5 1018.6 1109.5 1151.6 1159.2 1159.7 15310.1 15315.9 15416.0 15523.8 15675.7 561508.4 574201.0 631117.0 635447.0 635624.0 57862.4 59683.0 60121.0 60212.0 60366.7 1408.2 1445.7 1475.3 1480.3 1482.0 28983.6 29269.7 29531.7 29993.0 30109.8 52150.7 52372.7 52481.7 52518.7 52530.5 556642.0 559634.0 561655.0 561810.0 564594.0 26731.6 33834.8 40518.2 43030.4 43113.8 44055.6 44801.0 44886.0 44928.8 45315.5 36677.4 36782.0 37076.4 37730.1 37795.0 36036.6 36172.8 36346.0 36631.0 37032.0 31836.4 31978.0 36960.6 37002.8 37003.6 30160.4 31392.7 33686.0 35171.0 35286.8 24412.1 24595.1 24787.5 24943.8 25344.5 06:22:06 INFO - PROCESS | 1942 | 06:22:06 INFO - PROCESS | 1942 | [#2] jquery.html Cycles:180 Average:32589.75 Median:21344.57 stddev:91906.84 (430.6%) stddev-sans-first:92132.87 06:22:06 INFO - PROCESS | 1942 | Values: 392.8 393.2 397.1 400.3 403.6 13448.6 19734.1 20452.2 20452.4 20570.6 19878.3 20102.0 20439.4 21279.6 21473.4 5865.1 5921.6 6100.9 6110.6 6116.3 5138.6 6012.0 6027.9 6087.6 6093.9 5844.8 5976.7 6107.7 6115.9 6124.1 5779.6 5920.1 6031.5 6035.2 6075.9 5197.8 5246.8 5255.3 5259.7 5265.6 25204.7 25235.0 25704.4 26049.9 26227.5 2075.2 2097.4 2150.7 2173.7 2216.9 14395.5 14432.5 14570.0 14842.0 15136.0 1400.8 1712.7 1734.0 1773.2 1785.9 101931.5 103961.5 106727.9 106848.9 108091.5 10811.4 11319.1 11350.3 11367.4 11445.4 14201.6 14251.7 14263.6 14273.9 14294.4 8615.7 8749.2 8763.2 8767.2 8770.9 8676.1 8685.7 8687.5 8813.6 8828.5 5591.8 6779.6 6790.6 6799.0 6812.2 1648.4 1653.8 1879.2 1915.5 1917.9 830.5 863.3 912.6 946.6 973.4 17716.0 20413.1 21091.0 21409.6 21518.0 905.3 991.9 998.4 1011.6 1043.5 11098.8 11480.1 11489.3 11565.3 11632.2 532945.0 543706.0 545959.0 548640.0 594779.0 109591.7 110421.4 111240.0 111861.4 112626.4 1031.1 1041.3 1047.1 1108.0 1113.8 17614.8 18412.9 18527.2 18542.8 18735.7 45180.9 46039.0 48285.0 48561.5 48824.0 63279.1 64473.0 66304.7 67057.3 69115.3 7099.9 7985.6 8025.3 8196.5 8489.4 10103.3 11003.4 12284.0 12625.8 13029.5 10058.8 10828.5 11031.3 11044.0 11088.7 10981.2 11061.4 11173.5 11413.6 11464.6 11492.3 11590.8 11597.9 11742.6 11894.5 6718.6 7450.3 7536.0 7577.9 7846.0 10222.7 11233.4 11312.4 11620.1 11643.7 06:22:06 INFO - PROCESS | 1942 | 06:22:06 INFO - PROCESS | 1942 | [#3] mootools.html Cycles:180 Average:5714.18 Median:4648.42 stddev:3218.82 (69.2%) stddev-sans-first:3212.92 06:22:06 INFO - PROCESS | 1942 | Values: 1588.3 1627.3 1853.0 1886.1 1923.1 8074.2 8645.7 8665.8 8916.2 8957.3 8635.0 8699.3 8750.6 8791.8 8793.5 2421.8 2444.9 2446.0 2446.7 2458.2 2418.7 2431.2 2435.8 2439.8 2456.1 2044.8 2431.6 2455.2 2455.3 2460.6 2144.0 2405.7 2418.9 2425.7 2431.7 1862.8 1982.9 2417.3 2423.6 2439.7 8832.6 8928.4 8931.7 8949.5 8956.8 5221.1 5420.4 5476.0 5501.9 5518.9 3592.0 3631.5 3635.1 3650.4 3661.3 928.6 1046.9 1049.3 1059.5 1061.1 11442.7 11634.4 11665.1 11703.2 11749.2 4617.9 4734.8 4854.9 4867.0 4879.4 9930.3 10056.1 10059.7 10068.5 10072.9 5341.6 5349.6 5401.9 5412.4 5421.6 4180.5 4745.6 4883.0 4889.4 4920.0 4049.4 4075.6 4077.6 4088.8 4102.2 1360.6 1366.8 1368.9 1378.2 1379.3 794.8 908.8 929.9 933.2 946.8 5639.4 5753.1 5772.3 5885.3 5939.7 446.6 448.1 456.5 994.3 1003.7 3871.5 3953.8 3964.2 3998.0 4030.2 8889.6 10674.9 10812.2 10967.1 11029.9 10722.6 10855.8 10913.6 10964.9 10976.2 8106.8 8152.3 8194.4 8195.9 8291.5 5790.0 5792.0 5792.5 5828.5 5900.3 9870.0 10093.1 10186.7 10193.9 10194.5 9983.3 10216.8 10290.0 10346.0 10348.6 7036.0 7234.3 7579.7 7600.8 7621.5 8329.8 8341.3 8384.2 8390.0 8487.2 7290.3 7470.9 7474.4 7593.6 7603.8 7245.6 7303.0 7334.5 7341.0 7342.0 6759.8 6778.1 6824.9 6827.5 6857.2 3873.7 4534.2 4614.4 4615.8 4678.9 4377.4 4752.7 4820.4 4832.1 4968.0 06:22:06 INFO - PROCESS | 1942 | 06:22:06 INFO - PROCESS | 1942 | [#4] prototype.html Cycles:180 Average:5328.16 Median:6082.83 stddev:1707.60 (28.1%) stddev-sans-first:1670.53 06:22:06 INFO - PROCESS | 1942 | Values: 321.4 321.7 329.8 331.1 332.1 5519.8 5842.7 6218.9 6312.1 6404.4 4562.0 5136.6 5692.3 5761.9 6213.3 3578.9 4446.3 4612.4 4658.3 4662.2 3861.6 4054.5 4140.3 4629.0 4645.2 3699.3 4389.5 4602.5 4621.9 4624.0 3961.4 4522.7 4599.7 4635.5 4644.5 3763.7 3971.0 3986.2 3989.3 4002.5 5451.7 5563.7 6067.6 6074.3 6117.5 4605.4 5249.6 5412.8 5426.8 5455.5 5475.4 6558.0 6587.9 6594.3 6611.3 4316.4 4434.6 4448.5 4452.4 4465.7 6646.3 6993.2 6996.5 7023.4 7050.7 3938.4 4403.7 4513.3 4523.0 4554.4 4375.2 4598.4 4609.2 4612.4 4630.6 5386.8 5394.3 5402.6 5432.2 5446.6 6626.3 6653.2 6653.4 6665.3 6672.1 1460.5 1558.6 1564.5 1567.3 1594.4 933.0 977.4 991.2 1006.3 1010.7 6091.4 6104.8 6162.2 6198.9 6233.0 6180.4 6242.9 6331.3 6959.3 6984.2 4688.2 5696.7 5902.0 6139.4 6203.8 3558.8 3622.5 3626.2 3663.6 3663.9 6412.5 6760.5 6863.6 7129.5 7164.6 6136.6 6739.9 7064.0 7064.0 7073.1 6860.8 7119.5 7184.1 7185.6 7194.4 6158.6 6697.3 6872.9 6883.7 6915.6 6285.2 6418.5 6488.7 6797.3 6802.5 6144.4 7245.3 7271.3 7302.4 7356.0 3724.7 4164.1 4198.9 4400.2 4436.9 6508.3 6582.7 6903.3 6981.4 6983.9 6576.7 6643.2 6744.0 6770.8 6773.7 5861.6 6482.5 6713.2 6722.4 6790.9 5553.4 6376.1 6408.0 6488.0 6588.6 5074.1 6503.0 6668.0 6720.6 6751.9 5478.9 5669.4 6264.2 6632.8 6645.6 06:22:06 INFO - PROCESS | 1942 | 06:22:06 INFO - PROCESS | 1942 | [#5] yui.html Cycles:180 Average:18129.25 Median:615.50 stddev:25776.51 (4187.9%) stddev-sans-first:25815.11 06:22:06 INFO - PROCESS | 1942 | Values: 572.7 607.9 651.4 729.6 774.3 14517.9 14874.4 15070.2 15107.6 15140.4 13840.9 13919.2 13954.0 13976.2 14004.8 702.5 706.2 866.2 878.6 910.9 868.7 897.0 900.4 906.5 907.2 918.9 932.7 960.8 964.4 965.3 925.0 941.1 953.9 956.9 958.3 685.3 700.9 708.9 719.3 722.8 15071.5 15099.5 15242.8 15282.2 15334.2 12023.8 12242.8 12434.8 12900.3 13055.0 9715.9 10031.9 10090.9 10152.3 10560.3 3804.1 3851.0 3881.1 3890.2 4009.4 74207.3 78266.6 79005.0 80167.6 82454.6 9265.2 9327.9 9382.4 9493.0 9531.8 20833.4 20865.5 21047.8 21214.9 21313.6 7347.6 7487.2 7507.1 7522.7 7669.8 4066.8 4081.2 4083.2 4091.2 4096.2 2750.5 3523.5 3604.3 3644.3 3681.9 615.3 640.5 683.1 700.0 704.7 493.3 501.9 533.0 566.8 583.5 7524.3 7949.4 8063.2 8160.2 8207.0 543.4 561.0 568.9 600.8 615.7 3643.7 3835.3 3892.3 3928.8 4003.6 95985.0 96360.0 97627.0 98201.0 98231.5 66515.3 73075.0 82429.0 83507.0 84327.0 68819.1 71751.0 74164.3 74389.5 75112.9 7445.3 7719.9 7722.0 7871.8 8094.6 40676.8 41362.0 41555.8 41875.2 44095.0 64047.7 64752.4 64997.0 65093.7 65536.7 10630.0 10719.9 10737.0 11126.3 11288.4 11432.4 11547.4 11567.3 11685.9 11849.5 11353.5 11493.1 11559.7 11803.7 11835.9 11367.9 11488.7 11578.8 11763.5 11767.2 11333.3 11340.7 11360.2 11589.7 11893.0 9322.3 9421.9 9575.9 9863.8 9964.0 9509.5 9577.2 9620.3 9644.8 9684.7 06:22:06 INFO - PROCESS | 1942 | -------- Summary: end -------- 06:22:06 INFO - PROCESS | 1942 | 06:22:07 INFO - TEST-INFO | 1942: exit 0 06:22:07 INFO - TEST-OK | dromaeo_css | took 1112287ms 06:22:07 INFO - TEST-START | kraken 06:22:07 INFO - operating with platform_type : mac_ 06:22:07 INFO - Initialising browser for kraken test... 06:22:07 INFO - TEST-INFO | started process 1946 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpqivyPz/profile http://localhost:51157/getInfo.html) 06:22:10 INFO - PROCESS | 1946 | __metrics Screen width/height:1600/1200 06:22:10 INFO - PROCESS | 1946 | colorDepth:24 06:22:10 INFO - PROCESS | 1946 | Browser inner width/height: 1024/689 06:22:10 INFO - PROCESS | 1946 | __metrics 06:22:10 ERROR - PROCESS | 1946 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:22:10 INFO - TEST-INFO | 1946: exit 0 06:22:10 INFO - Browser initialized. 06:22:10 INFO - Running cycle 1/1 for kraken test... 06:22:10 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpqivyPz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:22:22 INFO - PROCESS | 1950 | RSS: Main: 248221696 06:22:22 INFO - PROCESS | 1950 | 06:22:25 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51157/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51157/tests/kraken/driver.html?testName=audio-beat-detection) 06:22:26 INFO - PROCESS | 1950 | RSS: Main: 260091904 06:22:26 INFO - PROCESS | 1950 | 06:22:29 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51157/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51157/tests/kraken/driver.html?testName=audio-dft) 06:22:29 INFO - PROCESS | 1950 | RSS: Main: 269017088 06:22:29 INFO - PROCESS | 1950 | 06:22:33 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51157/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51157/tests/kraken/driver.html?testName=audio-fft) 06:22:33 INFO - PROCESS | 1950 | RSS: Main: 272162816 06:22:33 INFO - PROCESS | 1950 | 06:22:35 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51157/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51157/tests/kraken/driver.html?testName=audio-oscillator) 06:22:36 INFO - PROCESS | 1950 | RSS: Main: 273137664 06:22:36 INFO - PROCESS | 1950 | 06:22:38 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51157/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51157/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:22:39 INFO - PROCESS | 1950 | RSS: Main: 273674240 06:22:39 INFO - PROCESS | 1950 | 06:22:42 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51157/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51157/tests/kraken/driver.html?testName=imaging-darkroom) 06:22:42 INFO - PROCESS | 1950 | RSS: Main: 273842176 06:22:42 INFO - PROCESS | 1950 | 06:22:45 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51157/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51157/tests/kraken/driver.html?testName=imaging-desaturate) 06:22:46 INFO - PROCESS | 1950 | RSS: Main: 275218432 06:22:46 INFO - PROCESS | 1950 | 06:22:49 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51157/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51157/tests/kraken/driver.html?testName=json-parse-financial) 06:22:50 INFO - PROCESS | 1950 | RSS: Main: 275574784 06:22:50 INFO - PROCESS | 1950 | 06:22:51 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51157/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51157/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:22:52 INFO - PROCESS | 1950 | RSS: Main: 275189760 06:22:52 INFO - PROCESS | 1950 | 06:22:54 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51157/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51157/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:22:55 INFO - PROCESS | 1950 | RSS: Main: 275230720 06:22:55 INFO - PROCESS | 1950 | 06:22:57 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51157/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51157/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:22:57 INFO - PROCESS | 1950 | RSS: Main: 275636224 06:22:57 INFO - PROCESS | 1950 | 06:23:00 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51157/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51157/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:23:01 INFO - PROCESS | 1950 | RSS: Main: 275652608 06:23:01 INFO - PROCESS | 1950 | 06:23:04 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51157/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51157/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:23:05 INFO - PROCESS | 1950 | RSS: Main: 275972096 06:23:05 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51157/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51157/tests/kraken/driver.html?testName=ai-astar) 06:23:07 INFO - PROCESS | 1950 | RSS: Main: 277028864 06:23:07 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | __start_tp_report 06:23:07 INFO - PROCESS | 1950 | _x_x_mozilla_page_load 06:23:07 INFO - PROCESS | 1950 | _x_x_mozilla_page_load_details 06:23:07 INFO - PROCESS | 1950 | |i|pagename|runs| 06:23:07 INFO - PROCESS | 1950 | |0;ai-astar;116;112;115;113;112;129;115;116;116;115 06:23:07 INFO - PROCESS | 1950 | |1;audio-beat-detection;159;122;146;168;121;141;141;120;169;158 06:23:07 INFO - PROCESS | 1950 | |2;audio-dft;195;200;200;212;214;195;198;196;202;228 06:23:07 INFO - PROCESS | 1950 | |3;audio-fft;67;76;80;125;57;58;57;60;121;60 06:23:07 INFO - PROCESS | 1950 | |4;audio-oscillator;98;125;175;113;80;89;162;79;82;122 06:23:07 INFO - PROCESS | 1950 | |5;imaging-gaussian-blur;101;133;135;132;88;107;114;73;81;114 06:23:07 INFO - PROCESS | 1950 | |6;imaging-darkroom;94;128;152;97;103;148;152;94;95;94 06:23:07 INFO - PROCESS | 1950 | |7;imaging-desaturate;92;91;91;93;95;126;90;148;75;149 06:23:07 INFO - PROCESS | 1950 | |8;json-parse-financial;62;63;61;61;62;60;61;77;62;55 06:23:07 INFO - PROCESS | 1950 | |9;json-stringify-tinderbox;55;87;100;61;75;100;103;100;99;95 06:23:07 INFO - PROCESS | 1950 | |10;stanford-crypto-aes;83;88;84;82;84;82;83;84;84;83 06:23:07 INFO - PROCESS | 1950 | |11;stanford-crypto-ccm;149;154;135;144;141;159;163;165;175;196 06:23:07 INFO - PROCESS | 1950 | |12;stanford-crypto-pbkdf2;173;188;226;236;176;173;165;173;194;230 06:23:07 INFO - PROCESS | 1950 | |13;stanford-crypto-sha256-iterative;61;76;98;95;77;66;68;66;70;74 06:23:07 INFO - PROCESS | 1950 | __end_tp_report 06:23:07 INFO - PROCESS | 1950 | __start_cc_report 06:23:07 INFO - PROCESS | 1950 | _x_x_mozilla_cycle_collect,1018 06:23:07 INFO - PROCESS | 1950 | __end_cc_report 06:23:07 INFO - PROCESS | 1950 | __startTimestamp1461072187285__endTimestamp 06:23:07 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | ------- Summary: start ------- 06:23:07 INFO - PROCESS | 1950 | Number of tests: 14 06:23:07 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | [#0] ai-astar Cycles:10 Average:115.90 Median:115.50 stddev:4.86 (4.2%) stddev-sans-first:5.16 06:23:07 INFO - PROCESS | 1950 | Values: 116.0 112.0 115.0 113.0 112.0 129.0 115.0 116.0 116.0 115.0 06:23:07 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:152.00 stddev:18.95 (12.5%) stddev-sans-first:19.35 06:23:07 INFO - PROCESS | 1950 | Values: 159.0 122.0 146.0 168.0 121.0 141.0 141.0 120.0 169.0 158.0 06:23:07 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | [#2] audio-dft Cycles:10 Average:204.00 Median:201.00 stddev:10.74 (5.3%) stddev-sans-first:10.89 06:23:07 INFO - PROCESS | 1950 | Values: 195.0 200.0 200.0 212.0 214.0 195.0 198.0 196.0 202.0 228.0 06:23:07 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | [#3] audio-fft Cycles:10 Average:76.10 Median:60.00 stddev:25.99 (43.3%) stddev-sans-first:27.36 06:23:07 INFO - PROCESS | 1950 | Values: 67.0 76.0 80.0 125.0 57.0 58.0 57.0 60.0 121.0 60.0 06:23:07 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | [#4] audio-oscillator Cycles:10 Average:112.50 Median:79.50 stddev:34.12 (42.9%) stddev-sans-first:35.78 06:23:07 INFO - PROCESS | 1950 | Values: 98.0 125.0 175.0 113.0 80.0 89.0 162.0 79.0 82.0 122.0 06:23:07 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | [#5] imaging-gaussian-blur Cycles:10 Average:107.80 Median:134.00 stddev:22.12 (16.5%) stddev-sans-first:23.33 06:23:07 INFO - PROCESS | 1950 | Values: 101.0 133.0 135.0 132.0 88.0 107.0 114.0 73.0 81.0 114.0 06:23:07 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | [#6] imaging-darkroom Cycles:10 Average:115.70 Median:94.00 stddev:26.21 (27.9%) stddev-sans-first:26.60 06:23:07 INFO - PROCESS | 1950 | Values: 94.0 128.0 152.0 97.0 103.0 148.0 152.0 94.0 95.0 94.0 06:23:07 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | [#7] imaging-desaturate Cycles:10 Average:105.00 Median:91.00 stddev:26.15 (28.7%) stddev-sans-first:27.31 06:23:07 INFO - PROCESS | 1950 | Values: 92.0 91.0 91.0 93.0 95.0 126.0 90.0 148.0 75.0 149.0 06:23:07 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:62.00 stddev:5.58 (9.0%) stddev-sans-first:5.92 06:23:07 INFO - PROCESS | 1950 | Values: 62.0 63.0 61.0 61.0 62.0 60.0 61.0 77.0 62.0 55.0 06:23:07 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | [#9] json-stringify-tinderbox Cycles:10 Average:87.50 Median:68.00 stddev:17.68 (26.0%) stddev-sans-first:14.31 06:23:07 INFO - PROCESS | 1950 | Values: 55.0 87.0 100.0 61.0 75.0 100.0 103.0 100.0 99.0 95.0 06:23:07 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:1.70 (2.0%) stddev-sans-first:1.79 06:23:07 INFO - PROCESS | 1950 | Values: 83.0 88.0 84.0 82.0 84.0 82.0 83.0 84.0 84.0 83.0 06:23:07 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | [#11] stanford-crypto-ccm Cycles:10 Average:158.10 Median:161.00 stddev:18.01 (11.2%) stddev-sans-first:18.80 06:23:07 INFO - PROCESS | 1950 | Values: 149.0 154.0 135.0 144.0 141.0 159.0 163.0 165.0 175.0 196.0 06:23:07 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.40 Median:191.00 stddev:27.09 (14.2%) stddev-sans-first:27.71 06:23:07 INFO - PROCESS | 1950 | Values: 173.0 188.0 226.0 236.0 176.0 173.0 165.0 173.0 194.0 230.0 06:23:07 INFO - PROCESS | 1950 | 06:23:07 INFO - PROCESS | 1950 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:75.00 stddev:12.32 (16.4%) stddev-sans-first:11.97 06:23:07 INFO - PROCESS | 1950 | Values: 61.0 76.0 98.0 95.0 77.0 66.0 68.0 66.0 70.0 74.0 06:23:07 INFO - PROCESS | 1950 | -------- Summary: end -------- 06:23:07 INFO - PROCESS | 1950 | 06:23:08 INFO - TEST-INFO | 1950: exit 0 06:23:08 INFO - TEST-OK | kraken | took 60688ms 06:23:08 INFO - SUITE-END | took 1172s 06:23:08 INFO - Completed test suite (00:19:33) 06:23:08 INFO - javascript benchmark 06:23:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2900.057481318571, 3402.370561446133, 3410.2326976430304, 3429.0, 3507.9649203507956, 4343.457067866517, 4852.58753005994, 5261.921306132239, 5638.267025286717, 5682.346530149034, 4847.927281090778, 5610.719464026803, 5704.1443783432505, 5736.426357364261, 5766.279215098113, 5167.612429067816, 5171.974140129303, 5191.636585439021, 5228.79084836606, 5253.921191182136, 5271.999999999981, 5297.761600727977, 5310.15037593985, 5338.919916201241, 5392.379876314215, 5104.719240441774, 5216.5305122538775, 5222.216667499867, 5250.0, 5254.290670759437, 5176.456472070454, 5196.61025423091, 5216.869578260574, 5217.47825217479, 5264.105102132647, 5080.13637681595, 5165.74171291434, 5217.3999990000875, 5219.530242278213, 5235.947640523622, 4766.975100353406, 5228.477152284741, 5559.916601250984, 5591.580631452616, 5628.634138780966, 5242.528172464458, 6113.296970848321, 6138.539609529304, 6140.907886381708, 6205.255369355661, 6101.328853826076, 6147.047207682816, 6216.533759968021, 6217.253929528486, 6227.937720622781, 5825.15535247391, 5838.970805146032, 5842.357340692521, 5853.999999999957, 5903.49820265278, 6237.157983672146, 6274.843128921813, 6276.686165691697, 6279.96860015697, 6425.678716064178, 6001.339852616209, 6084.209052823105, 6132.722655450899, 6176.413240742122, 6187.16473276111, 6151.692415379213, 6203.8138855834395, 6223.346548612421, 6228.564000520011, 6230.626162430178, 6064.090386441981, 6111.205543279434, 6112.235970503687, 6158.938410615837, 6172.598781079216, 6057.878842423215, 6098.129681996382, 6113.081058500009, 6197.96901015492, 6217.347178546278, 4158.313878210122, 4937.08663897173, 4939.407271127416, 4947.851564453073, 4952.529509696573, 4389.385486031958, 4394.824207031683, 4412.84555040572, 4430.401895744098, 4485.282354823278, 4745.525447455296, 5573.7459071708545, 5640.746166422521, 5758.107493338539, 5775.768969241183, 6184.752609895644, 6214.564980451325, 6218.720157592919, 6219.911515484772, 6231.2522497300615, 5737.569682273846, 5743.684097374685, 5744.51171650406, 5746.9425305747245, 5753.971230143822, 5297.682139071668, 5339.466053394707, 5395.244665746799, 5417.539509141767, 5439.456054394608, 6320.494360451061, 6327.4938004959495, 6352.269489008823, 6353.0, 6362.236531616236, 6042.1843051187525, 6223.533235007302, 6224.595401298901, 6226.719797609027, 6227.221597300338, 6263.718132683949, 6330.39861213184, 6380.808575742735, 6400.39196276353, 6401.615903045832, 6147.0779383092895, 6179.073139029181, 6182.165407669907, 6188.9690551546955, 6193.690315484298, 5046.949530504648, 6121.816345509642, 6161.353057928853, 6226.719797609209, 6243.406876346739, 5216.243644671577, 6053.4551890330085, 6093.866968087874, 6098.91636565712, 6137.508999280136, 5490.588205884655, 5540.0, 6055.424734650202, 6117.724702388314, 6123.14276001369, 5815.534757219328, 5875.823725288248, 5915.733791979285, 5969.611975221596, 5980.491658209101, 6033.728482218223, 6065.211522502046, 6079.270487541523, 6099.329073801967, 6134.478569321479, 5980.671063091571, 5998.640081595118, 6005.7297421617, 6024.849378765391, 6042.425969532887], "value": 5632.518498925884, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.2214151277788, 512.2239806692859, 515.1577171324883, 561.8848136132092, 571.2003195526265, 34061.0, 39301.60698393015, 39708.205835883266, 39895.8031259062, 40425.78722638318, 33444.66221351143, 40978.7951060245, 41348.79325603368, 41681.166376672525, 41758.16483670333, 8193.631286592117, 9353.345265831394, 9563.139317461428, 9583.089606487372, 9622.518874056304, 8263.338932885355, 9334.906650933506, 9417.576209070574, 9476.194523465514, 9521.523923803818, 9520.0, 9564.234861211087, 9567.569459374345, 9591.376560523544, 9620.182284505825, 9479.47862867542, 9495.382800118005, 9549.856752148724, 9568.617255309779, 9571.95214023929, 9421.057894210593, 9491.905080949171, 9552.474613896233, 9553.952230238874, 9569.138777509988, 37963.81018094919, 37985.0, 38204.61795382039, 38400.61599383999, 38507.03732406684, 2515.748425157488, 2733.494303553849, 3351.8156501392414, 3690.2619476104887, 3815.3323168445413, 27524.58713119305, 27964.440711185664, 28768.856155719295, 28965.855170724222, 29045.41909161826, 2705.147878418292, 2722.8366298021983, 2789.7070807565115, 2815.1976686644207, 2838.7728981681416, 327512.0, 409683.0, 409818.0, 414225.0, 414823.999999997, 36113.27773444516, 36172.81913590415, 36329.0, 61764.0, 62312.688436558434, 34840.47739283913, 35033.82483087568, 35127.12182195415, 35290.82354588211, 35388.11529711778, 14671.193084380247, 14938.925305373403, 15058.171800551076, 15073.623159420882, 15107.39570417171, 9477.810443791086, 11545.769084618261, 11602.245854019462, 11636.0, 11656.941715291368, 8050.396220283502, 8134.633941472648, 8196.713115040944, 8220.095789463154, 8236.0, 3339.1652086978256, 3384.2892992471366, 3425.8287085646116, 3425.9828700856337, 3426.777259478126, 989.5151375825938, 996.9202463802878, 1004.4023805835516, 1053.1943063556384, 1128.0637071230858, 24729.1344802931, 25034.749652503608, 29923.850380747957, 30003.925914514177, 30162.547561786592, 1018.5976539266948, 1109.5118148014847, 1151.6199654114123, 1159.2349049627205, 1159.6926814394192, 15310.115096825471, 15315.92342038305, 15416.0, 15523.84476155224, 15675.686486270439, 561508.3849161456, 574201.0, 631117.0, 635447.0, 635624.0, 57862.421375786544, 59683.0, 60121.0, 60212.0, 60366.69816650889, 1408.204364534035, 1445.6602698365875, 1475.3287254299269, 1480.326451464581, 1482.0218655687195, 28983.647010243225, 29269.707302926698, 29531.704682953754, 29993.0, 30109.849450752605, 52150.73924630353, 52372.738136309075, 52481.7375913118, 52518.73740631272, 52530.47469525256, 556642.0, 559634.0, 561655.0, 561810.0, 564594.0, 26731.599026015014, 33834.83082584571, 40518.1896362077, 43030.35454468123, 43113.78443107764, 44055.559444405146, 44801.0, 44886.0, 44928.77535612301, 45315.54684453245, 36677.449838251916, 36782.0, 37076.44385334276, 37730.056748581505, 37795.0, 36036.639633604376, 36172.792875176514, 36346.0, 36631.0, 37032.0, 31836.363272733954, 31978.040658780275, 36960.63039369572, 37002.814985924895, 37003.62996370002, 30160.396792064475, 31392.686073138975, 33686.0, 35171.0, 35286.823565882005, 24412.145574904793, 24595.13917012896, 24787.504249915262, 24943.750562494868, 25344.493110137326], "value": 18277.672142043928, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.7623787608497, 393.1743338988125, 397.08471972104286, 400.3174587328605, 403.5843081625926, 13448.596542103727, 19734.111964961576, 20452.159305662488, 20452.386428407153, 20570.588588228227, 19878.304259350927, 20102.0, 20439.386818395473, 21279.57440851182, 21473.355799326007, 5865.061590145578, 5921.644701317913, 6100.877982440348, 6110.602810817282, 6116.327204007555, 5138.5889128869785, 6011.9779637461515, 6027.879442411149, 6087.634741915477, 6093.908591371133, 5844.766209351621, 5976.731047102869, 6107.725152368132, 6115.908261376083, 6124.081387791823, 5779.595428320019, 5920.052791553352, 6031.487323577501, 6035.155078289065, 6075.939240607581, 5197.8440646780655, 5246.7638956247065, 5255.264263003144, 5259.710715910624, 5265.578753699695, 25204.73976301196, 25235.0, 25704.357391065187, 26049.869750651316, 26227.475450490885, 2075.2217918280644, 2097.381272524609, 2150.666646669769, 2173.6630822222583, 2216.9382821458476, 14395.496157634538, 14432.494862679861, 14569.980101392906, 14842.0, 15136.016158949633, 1400.8459069502346, 1712.6831536165726, 1734.0116133803738, 1773.1931970953185, 1785.8660600455019, 101931.49034254855, 103961.48019259855, 106727.93272067336, 106848.93151068468, 108091.45954270256, 10811.40537270442, 11319.094472442184, 11350.318980861175, 11367.374794386387, 11445.427728613537, 14201.573952781433, 14251.714965700628, 14263.643408914653, 14273.85726142746, 14294.356753946098, 8615.741527754177, 8749.16882896124, 8763.211310982042, 8767.21095101444, 8770.868436973451, 8676.1323867614, 8685.739427817176, 8687.478751274944, 8813.603387847563, 8828.470291782514, 5591.776328946878, 6779.6271205084195, 6790.623281851411, 6798.966005169942, 6812.182538095361, 1648.3900956646119, 1653.7602047703015, 1879.1825555883236, 1915.549845786239, 1917.8753381030187, 830.4726498673265, 863.3395452478859, 912.5619702542816, 946.5740416812324, 973.3867663372031, 17716.0, 20413.081411336527, 21091.0, 21409.57180856374, 21518.0, 905.3436258712512, 991.9206463482905, 998.4109375468508, 1011.5751384418562, 1043.5095505112586, 11098.833517497244, 11480.081593472501, 11489.253198542068, 11565.306081635128, 11632.185746997799, 532945.0, 543706.0, 545959.0, 548640.0, 594779.0, 109591.68470679922, 110421.44789276003, 111240.0, 111861.44069279601, 112626.43686781514, 1031.118393773328, 1041.3335465302212, 1047.0628787235382, 1108.0304733358473, 1113.7549739057395, 17614.823851761317, 18412.907935460236, 18527.166277517274, 18542.83648751662, 18735.718964215273, 45180.87047823831, 46039.0, 48285.0, 48561.5143848557, 48824.0, 63279.0508142369, 64473.0, 66304.6684766573, 67057.32942670511, 69115.3088469129, 7099.858002839811, 7985.6007199638625, 8025.2777250047775, 8196.467229630054, 8489.40574159803, 10103.343282686601, 11003.394813285026, 12283.955863751324, 12625.810612840998, 13029.47882084706, 10058.798824023625, 10828.512716927915, 11031.333223409652, 11044.0, 11088.722781930517, 10981.231313807957, 11061.391623460788, 11173.488583932562, 11413.600523981953, 11464.598739044093, 11492.310461372344, 11590.768184636428, 11597.942010289895, 11742.647720568397, 11894.524219031142, 6718.630475323904, 7450.329470347695, 7535.962320188364, 7577.886331704918, 7845.960770196112, 10222.693319200436, 11233.438328083726, 11312.377819220023, 11620.070394368262, 11643.708907277047], "value": 9548.532128234709, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1588.340838552001, 1627.3409269245954, 1852.972205416918, 1886.1229528269353, 1923.0865338963995, 8074.192580741923, 8645.69740059098, 8665.826683466326, 8916.242119419849, 8957.328200384973, 8635.0, 8699.304055675546, 8750.606222719976, 8791.824163516741, 8793.516356600385, 2421.769931856475, 2444.8655323957173, 2445.963310550343, 2446.7308596054418, 2458.1519375815315, 2418.733939266679, 2431.2463136427764, 2435.756424357568, 2439.756024397555, 2456.0544190486703, 2044.7750747417772, 2431.6352547117986, 2455.2143314139485, 2455.3002394317623, 2460.5694003549397, 2143.981608735838, 2405.6511805788236, 2418.8790560471994, 2425.708914930211, 2431.6960379952507, 1862.7671541057368, 1982.8611997160206, 2417.347316224627, 2423.5879900416794, 2439.7194322652945, 8832.646694132227, 8928.419652722552, 8931.732048038504, 8949.507777072324, 8956.820863582758, 5221.086309895791, 5420.403755586883, 5475.972620136914, 5501.944980550224, 5518.944810551883, 3592.0481072515804, 3631.5279013728045, 3635.073056370635, 3650.3611867923273, 3661.340958627446, 928.5542939389063, 1046.9005444482762, 1049.3022140276707, 1059.5285098131335, 1061.0874647802884, 11442.713932151679, 11634.360110193937, 11665.066794656406, 11703.239289446245, 11749.177557570887, 4617.907641847144, 4734.810607575659, 4854.927176092361, 4866.9513304867205, 4879.39007624047, 9930.255230857714, 10056.145227655585, 10059.69820905374, 10068.496575171212, 10072.899271007343, 5341.62608617393, 5349.5720342372515, 5401.891962160735, 5412.350517937873, 5421.566274698014, 4180.519240287345, 4745.572898439157, 4883.0, 4889.413270407574, 4920.0, 4049.392591111298, 4075.633193012584, 4077.5996165021543, 4088.8160032798596, 4102.159057393227, 1360.6122255157234, 1366.7539842828187, 1368.8631136886231, 1378.1730961423266, 1379.296558755022, 794.7655441644729, 908.7773495493515, 929.8512238042016, 933.169479163545, 946.8011717539393, 5639.407862174495, 5753.108268218432, 5772.278465191851, 5885.323187833368, 5939.70301484924, 446.6449172907546, 448.0836688971062, 456.465934856219, 994.2841154368842, 1003.6687892995294, 3871.5160604924386, 3953.8418463261146, 3964.1675248197625, 3997.980010099931, 4030.2141082488633, 8889.644414223489, 10674.946625266979, 10812.243142979916, 10967.122630189566, 11029.944850275697, 10722.624708135178, 10855.837162442569, 10913.618023369145, 10964.945175274073, 10976.176786741027, 8106.837863242702, 8152.266296033267, 8194.385421093442, 8195.877061844078, 8291.461055031403, 5790.0, 5791.986402379483, 5792.507636850914, 5828.53371730269, 5900.291964964232, 9869.963653816247, 10093.091621754078, 10186.745331366776, 10193.949030254802, 10194.490275486047, 9983.301168918397, 10216.846747298649, 10290.0, 10346.0, 10348.637797677045, 7036.014957906, 7234.276572342724, 7579.658915348712, 7600.771976840703, 7621.466497345133, 8329.750107496784, 8341.332693384637, 8384.203500667427, 8389.95805020971, 8487.193716596914, 7290.270972902667, 7470.925290747023, 7474.439417043634, 7593.5823529706395, 7603.771886843404, 7245.637718113968, 7303.0, 7334.523255988343, 7341.045664063851, 7341.963290183515, 6759.831004224934, 6778.084958530535, 6824.93175068243, 6827.52207345481, 6857.2114206866845, 3873.7094717896834, 4534.183846907456, 4614.423197100363, 4615.769211539342, 4678.929816052694, 4377.409049778239, 4752.693009422436, 4820.4456487504385, 4832.106060378841, 4968.006398720198], "value": 4565.8621241723995, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.39096412298693, 321.74582080156677, 329.8284891856235, 331.13903849990027, 332.0685477236351, 5519.834404967847, 5842.743810080837, 6218.875622487548, 6312.084747711579, 6404.391582799638, 4561.96629241554, 5136.589072874171, 5692.288463942007, 5761.9135712964335, 6213.34759850216, 3578.946315805265, 4446.333050042487, 4612.3542704021465, 4658.347831303603, 4662.207424737802, 3861.5945325740813, 4054.513458384998, 4140.254754144253, 4629.0279041401345, 4645.187092258841, 3699.278640665071, 4389.4952080510675, 4602.516735742749, 4621.907561848761, 4623.976880115595, 3961.445397644332, 4522.68341216115, 4599.701019433726, 4635.46692130406, 4644.512326205768, 3763.717721170923, 3971.0, 3986.222686576119, 3989.341758609855, 4002.4996875390575, 5451.691594017447, 5563.666180029211, 6067.635941843503, 6074.301455332649, 6117.541184411187, 4605.401297831294, 5249.606279529051, 5412.83761487156, 5426.75579598915, 5455.509004189642, 5475.370332411784, 6558.0, 6587.868242635169, 6594.274629790719, 6611.272759996396, 4316.352547117926, 4434.556544345572, 4448.466184057934, 4452.398926144993, 4465.665075119379, 6646.335366463363, 6993.230744618088, 6996.510244282902, 7023.367896889305, 7050.717971281194, 3938.428927805452, 4403.700908232079, 4513.300438432048, 4523.0, 4554.407926969473, 4375.190589740908, 4598.425196850394, 4609.2394754865745, 4612.362611273017, 4630.629549636021, 5386.757595908193, 5394.271773310631, 5402.567794576503, 5432.158015507603, 5446.645968012146, 6626.304238055031, 6653.201615806038, 6653.367930046637, 6665.300143484864, 6672.065910772496, 1460.5180290504109, 1558.602556348124, 1564.4824520215373, 1567.3025503650765, 1594.4339759385482, 932.9720108396759, 977.4184360305607, 991.2119864707574, 1006.2855372685475, 1010.6664800615779, 6091.360407157274, 6104.786332478342, 6162.22972128484, 6198.876022479525, 6232.968835155795, 6180.381961803873, 6242.907491189115, 6331.303556608769, 6959.269276725972, 6984.161900571964, 4688.179568575486, 5696.715164241854, 5901.970490147608, 6139.447449729546, 6203.8138855834395, 3558.768680035789, 3622.4566315052953, 3626.202235508184, 3663.618647878847, 3663.8534458621357, 6412.543282418675, 6760.459163266927, 6863.622500762506, 7129.536580122275, 7164.641767911688, 6136.6011209271255, 6739.93260067393, 7063.964680176567, 7063.964680176567, 7073.080499535027, 6860.828479288058, 7119.501634885612, 7184.1019872515935, 7185.604791736505, 7194.352508274281, 6158.599691020069, 6697.330266973264, 6872.896906546306, 6883.655817209019, 6915.550489218184, 6285.214348206474, 6418.4544313731985, 6488.740450381932, 6797.286284940208, 6802.455803535804, 6144.38556144382, 7245.275472452712, 7271.272872712686, 7302.415806735555, 7356.0, 3724.7020238380323, 4164.12553363797, 4198.895027624334, 4400.161895577398, 4436.911261774811, 6508.316626754123, 6582.736690532325, 6903.275156108737, 6981.441484681315, 6983.895241571482, 6576.671166441754, 6643.2360278568585, 6744.0, 6770.830729231809, 6773.661316934035, 5861.6189947653265, 6482.546221764431, 6713.227978782503, 6722.353023509271, 6790.8641827164165, 5553.416891226363, 6376.107344971801, 6407.967960160169, 6488.021153548213, 6588.571742836701, 5074.06129865976, 6503.02454631809, 6667.966465197902, 6720.563163394364, 6751.864962700817, 5478.91781623284, 5669.4047125051275, 6264.248290205204, 6632.83417914556, 6645.568038077509], "value": 4772.600399613525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.6621293436872, 607.8936186167423, 651.3844417025911, 729.5659082845708, 774.2876553570715, 14517.927410362947, 14874.405023799061, 15070.171140587263, 15107.622309442242, 15140.394384224632, 13840.930795346034, 13919.164850109, 13954.023218374718, 13976.161430314189, 14004.78992815106, 702.5257950883159, 706.159669992707, 866.1987661413199, 878.5738916625431, 910.8542633178693, 868.6699054359335, 896.9596368163416, 900.3562452846213, 906.5376657904483, 907.2197909797569, 918.857577075551, 932.664240873285, 960.8174446855076, 964.4358050540442, 965.3194497878978, 925.0425809287389, 941.0542404883083, 953.947532885691, 956.8995255498212, 958.2956526952685, 685.3386482044801, 700.8528209076101, 708.8653155900363, 719.2735337309302, 722.8301349182938, 15071.547853564301, 15099.471518496799, 15242.771358429633, 15282.235888205545, 15334.156621385819, 12023.819642705366, 12242.775722427776, 12434.751304973941, 12900.290484023375, 13055.0, 9715.902840971641, 10031.949840250825, 10090.899091009143, 10152.340097893688, 10560.313579617301, 3804.068003339172, 3851.0, 3881.107345310566, 3890.202508485782, 4009.4186342980106, 74207.25792742112, 78266.60866695688, 79005.0, 80167.5991620044, 82454.58772706157, 9265.166135047743, 9327.906720932839, 9382.437053776795, 9492.95253523728, 9531.760036391443, 20833.374998750063, 20865.478363041046, 21047.78952210489, 21214.893925530272, 21313.573728525655, 7347.63261836906, 7487.1764105948305, 7507.1366792818435, 7522.699092036257, 7669.769906902802, 4066.7763273019677, 4081.2449696806184, 4083.224187404384, 4091.2226676931286, 4096.160287141129, 2750.5049091163382, 3523.5067090607336, 3604.2611264690677, 3644.325799727059, 3681.9447708284397, 615.2985596420085, 640.4684112186874, 683.111954459201, 699.9860002799916, 704.6934583456213, 493.33646245799343, 501.929729837823, 533.0378666506915, 566.8068715354202, 583.5069366385397, 7524.288774849263, 7949.403794715419, 8063.19368063189, 8160.224778646019, 8206.958965205136, 543.3619775987602, 560.9859753506195, 568.883378907323, 600.8197540737849, 615.7106160104744, 3643.7449378543247, 3835.347990841564, 3892.3188442022533, 3928.823202955874, 4003.559608443069, 95985.0, 96360.0, 97627.0, 98201.0, 98231.50884245533, 66515.33484665092, 73075.0, 82429.0, 83507.0, 84327.0, 68819.08580513205, 71751.0, 74164.25835741573, 74389.51220975659, 75112.87330690044, 7445.292697193758, 7719.92280077192, 7722.034745656793, 7871.842563148591, 8094.554799485849, 40676.79661601673, 41362.0, 41555.792221038704, 41875.162496750505, 44095.0, 64047.719045617894, 64752.381190470616, 64997.0, 65093.67453162704, 65536.67231663811, 10630.0, 10719.89280107189, 10737.0, 11126.276792008493, 11288.379139147097, 11432.428378580871, 11547.422628868355, 11567.305961642329, 11685.941570292094, 11849.466773995364, 11353.489092991, 11493.080553555528, 11559.653210403701, 11803.74637200249, 11835.881641183478, 11367.886321136682, 11488.712782180512, 11578.768424631291, 11763.470643820878, 11767.23512971654, 11333.320000799979, 11340.716482088013, 11360.204785664924, 11589.6523104307, 11892.989095926943, 9322.300827437834, 9421.85644068721, 9575.856362154434, 9863.802723945624, 9964.0, 9509.524523773645, 9577.23382129442, 9620.326577139533, 9644.75888102803, 9684.70945871625], "value": 6827.718394856077, "unit": "score"}], "name": "dromaeo_css", "value": 7258.693261612544, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 115.0, 113.0, 112.0, 129.0, 115.0, 116.0, 116.0, 115.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 122.0, 146.0, 168.0, 121.0, 141.0, 141.0, 120.0, 169.0, 158.0], "value": 144.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 200.0, 200.0, 212.0, 214.0, 195.0, 198.0, 196.0, 202.0, 228.0], "value": 204.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 76.0, 80.0, 125.0, 57.0, 58.0, 57.0, 60.0, 121.0, 60.0], "value": 76.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 125.0, 175.0, 113.0, 80.0, 89.0, 162.0, 79.0, 82.0, 122.0], "value": 112.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 133.0, 135.0, 132.0, 88.0, 107.0, 114.0, 73.0, 81.0, 114.0], "value": 107.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 128.0, 152.0, 97.0, 103.0, 148.0, 152.0, 94.0, 95.0, 94.0], "value": 115.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 91.0, 93.0, 95.0, 126.0, 90.0, 148.0, 75.0, 149.0], "value": 105.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 61.0, 62.0, 60.0, 61.0, 77.0, 62.0, 55.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 87.0, 100.0, 61.0, 75.0, 100.0, 103.0, 100.0, 99.0, 95.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 84.0, 82.0, 84.0, 82.0, 83.0, 84.0, 84.0, 83.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 154.0, 135.0, 144.0, 141.0, 159.0, 163.0, 165.0, 175.0, 196.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 188.0, 226.0, 236.0, 176.0, 173.0, 165.0, 173.0, 194.0, 230.0], "value": 193.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 76.0, 98.0, 95.0, 77.0, 66.0, 68.0, 66.0, 70.0, 74.0], "value": 75.1, "unit": "score"}], "name": "kraken", "value": 1641.7, "alertThreshold": 2.0}]} 06:23:08 INFO - Return code: 0 06:23:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:23:08 ERROR - # TBPL SUCCESS # 06:23:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:23:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:23:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:23:08 INFO - 2016-04-19 06:23:08.579 screenresolution[1955:16057] starting screenresolution argv=screenresolution get 06:23:08 INFO - 2016-04-19 06:23:08.582 screenresolution[1955:16057] Display 0: 1600x1200x32@60 06:23:08 INFO - 2016-04-19 06:23:08.588 screenresolution[1956:16060] starting screenresolution argv=screenresolution list 06:23:08 INFO - Available Modes on Display 0 06:23:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:23:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:23:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:23:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:23:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:23:08 INFO - Intel Iris: 06:23:08 INFO - Chipset Model: Intel Iris 06:23:08 INFO - Type: GPU 06:23:08 INFO - Bus: Built-In 06:23:08 INFO - VRAM (Dynamic, Max): 1536 MB 06:23:08 INFO - Vendor: Intel (0x8086) 06:23:08 INFO - Device ID: 0x0a2e 06:23:08 INFO - Revision ID: 0x0009 06:23:08 INFO - Displays: 06:23:08 INFO - Display: 06:23:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:23:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:23:08 INFO - Display Serial Number: 1600x1200 60 06:23:08 INFO - Main Display: Yes 06:23:08 INFO - Mirror: Off 06:23:08 INFO - Online: Yes 06:23:08 INFO - Rotation: Supported 06:23:08 INFO - Return code: 0 06:23:08 INFO - Running post-action listener: _resource_record_post_action 06:23:08 INFO - Running post-run listener: _resource_record_post_run 06:23:09 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 1372160; Write bytes: 694597120; Read time: 13; Write time: 1962 06:23:09 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 373107200; Write bytes: 368509952; Read time: 28255; Write time: 719 06:23:09 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 1372160; Write bytes: 296722944; Read time: 13; Write time: 1191 06:23:09 INFO - Running post-run listener: _upload_blobber_files 06:23:09 INFO - Blob upload gear active. 06:23:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:23:09 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 06:23:09 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:23:09 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:23:10 INFO - (blobuploader) - INFO - Open directory for files ... 06:23:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:23:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:23:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:11 INFO - (blobuploader) - INFO - Done attempting. 06:23:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:23:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:23:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:12 INFO - (blobuploader) - INFO - Done attempting. 06:23:12 INFO - (blobuploader) - INFO - Iteration through files over. 06:23:12 INFO - Return code: 0 06:23:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:23:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:23:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ebdf8ad3cd44be3024091fae6a55cd7148453cce37544ce717edb6a7661a7972401d39d9e30f3fd41ec1255787dd021e496aae6408a2aafd7961b20eeff6a94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc0ac12dc632583caaf307f2cb631d740d0d6f48be9e1ddbc8412065eb1c173eaa622617d9ea9f6b3492d6531d3ee649d34d17357b5dd45840dc02b827bc324f"} 06:23:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:23:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:23:12 INFO - Contents: 06:23:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ebdf8ad3cd44be3024091fae6a55cd7148453cce37544ce717edb6a7661a7972401d39d9e30f3fd41ec1255787dd021e496aae6408a2aafd7961b20eeff6a94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc0ac12dc632583caaf307f2cb631d740d0d6f48be9e1ddbc8412065eb1c173eaa622617d9ea9f6b3492d6531d3ee649d34d17357b5dd45840dc02b827bc324f"} 06:23:12 INFO - Running post-run listener: copy_logs_to_upload_dir 06:23:12 INFO - Copying logs to upload dir... 06:23:12 INFO - mkdir: /builds/slave/test/build/upload/logs 06:23:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.614414 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-19 06:23:12.183738) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 06:23:12.187059) ========= 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.Y0BkLU0YWG/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.dyqHzRChDi/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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/Firefox/sha512/3ebdf8ad3cd44be3024091fae6a55cd7148453cce37544ce717edb6a7661a7972401d39d9e30f3fd41ec1255787dd021e496aae6408a2aafd7961b20eeff6a94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc0ac12dc632583caaf307f2cb631d740d0d6f48be9e1ddbc8412065eb1c173eaa622617d9ea9f6b3492d6531d3ee649d34d17357b5dd45840dc02b827bc324f"} build_url:https://queue.taskcluster.net/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011055 build_url: 'https://queue.taskcluster.net/v1/task/PGB-OqwdRJWNMlDElas3Dg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ebdf8ad3cd44be3024091fae6a55cd7148453cce37544ce717edb6a7661a7972401d39d9e30f3fd41ec1255787dd021e496aae6408a2aafd7961b20eeff6a94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc0ac12dc632583caaf307f2cb631d740d0d6f48be9e1ddbc8412065eb1c173eaa622617d9ea9f6b3492d6531d3ee649d34d17357b5dd45840dc02b827bc324f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 06:23:12.218213) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 06:23:12.218540) ========= 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.Y0BkLU0YWG/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.dyqHzRChDi/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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.005284 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 06:23:12.268538) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 06:23:12.268865) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 06:23:12.269241) ========= ========= Total master_lag: 0.16 =========