builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0196 starttime: 1461836132.9 results: success (0) buildid: 20160428014150 builduid: 832137680db24ea4ba0292eb7b426138 revision: 9d71a501fd32617206049dbef2d4a7bb7802c781 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 02:35:32.904897) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 02:35:32.905384) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 02:35:32.905663) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 02:35:33.019467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 02:35:33.019763) ========= 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.6Ns0W3VikQ/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.o6h1BlX4P0/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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-28 02:35:33-- 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% 9.45M=0.001s 2016-04-28 02:35:33 (9.45 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080293 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 02:35:33.121783) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 02:35:33.122103) ========= 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.6Ns0W3VikQ/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.o6h1BlX4P0/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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.027312 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 02:35:33.249296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-28 02:35:33.249651) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9d71a501fd32617206049dbef2d4a7bb7802c781 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 9d71a501fd32617206049dbef2d4a7bb7802c781 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6Ns0W3VikQ/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.o6h1BlX4P0/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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-28 02:35:33,331 truncating revision to first 12 chars 2016-04-28 02:35:33,331 Setting DEBUG logging. 2016-04-28 02:35:33,331 attempt 1/10 2016-04-28 02:35:33,331 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9d71a501fd32?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 02:35:35,315 unpacking tar archive at: fx-team-9d71a501fd32/testing/mozharness/ program finished with exit code 0 elapsedTime=2.222399 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-28 02:35:35.489641) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 02:35:35.490024) ========= script_repo_revision: 9d71a501fd32617206049dbef2d4a7bb7802c781 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 02:35:35.490433) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 02:35:35.490960) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 02:35:35.505202) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-28 02:35:35.505586) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6Ns0W3VikQ/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.o6h1BlX4P0/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 02:35:35 INFO - MultiFileLogger online at 20160428 02:35:35 in /builds/slave/test 02:35:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:35:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:35:35 INFO - {'append_to_log': False, 02:35:35 INFO - 'base_work_dir': '/builds/slave/test', 02:35:35 INFO - 'blob_upload_branch': 'Fx-Team', 02:35:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:35:35 INFO - 'branch': 'Fx-Team', 02:35:35 INFO - 'buildbot_json_path': 'buildprops.json', 02:35:35 INFO - 'config_files': ('talos/mac_config.py',), 02:35:35 INFO - 'default_actions': ('clobber', 02:35:35 INFO - 'read-buildbot-config', 02:35:35 INFO - 'download-and-extract', 02:35:35 INFO - 'populate-webroot', 02:35:35 INFO - 'create-virtualenv', 02:35:35 INFO - 'install', 02:35:35 INFO - 'run-tests'), 02:35:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:35:35 INFO - 'download_minidump_stackwalk': True, 02:35:35 INFO - 'download_symbols': 'ondemand', 02:35:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:35:35 INFO - 'tooltool.py': '/tools/tooltool.py', 02:35:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:35:35 INFO - '/tools/misc-python/virtualenv.py')}, 02:35:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:35:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:35:35 INFO - 'installer_path': 'installer.exe', 02:35:35 INFO - 'log_level': 'info', 02:35:35 INFO - 'log_name': 'talos', 02:35:35 INFO - 'log_to_console': True, 02:35:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:35:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:35:35 INFO - 'opt_config_files': (), 02:35:35 INFO - 'pip_index': False, 02:35:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:35:35 INFO - 'cmd': ('bash', 02:35:35 INFO - '-c', 02:35:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:35:35 INFO - 'enabled': True, 02:35:35 INFO - 'halt_on_failure': False, 02:35:35 INFO - 'name': 'check_screen_resolution'},), 02:35:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:35:35 INFO - 'cmd': ('bash', 02:35:35 INFO - '-c', 02:35:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:35:35 INFO - 'enabled': True, 02:35:35 INFO - 'halt_on_failure': False, 02:35:35 INFO - 'name': 'check_screen_resolution'},), 02:35:35 INFO - 'run_cmd_checks_enabled': True, 02:35:35 INFO - 'sps_profile': False, 02:35:35 INFO - 'sps_profile_interval': 0, 02:35:35 INFO - 'suite': 'dromaeojs', 02:35:35 INFO - 'system_bits': '32', 02:35:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:35:35 INFO - 'title': 't-yosemite-r7-0196', 02:35:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:35:35 INFO - 'use_talos_json': True, 02:35:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:35:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:35:35 INFO - 'work_dir': 'build'} 02:35:35 INFO - ##### 02:35:35 INFO - ##### Running clobber step. 02:35:35 INFO - ##### 02:35:35 INFO - Running pre-action listener: _resource_record_pre_action 02:35:35 INFO - Running main action method: clobber 02:35:35 INFO - rmtree: /builds/slave/test/build 02:35:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:35:37 INFO - Running post-action listener: _resource_record_post_action 02:35:37 INFO - ##### 02:35:37 INFO - ##### Running read-buildbot-config step. 02:35:37 INFO - ##### 02:35:37 INFO - Running pre-action listener: _resource_record_pre_action 02:35:37 INFO - Running main action method: read_buildbot_config 02:35:37 INFO - Using buildbot properties: 02:35:37 INFO - { 02:35:37 INFO - "project": "", 02:35:37 INFO - "product": "firefox", 02:35:37 INFO - "script_repo_revision": "production", 02:35:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 02:35:37 INFO - "repository": "", 02:35:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 02:35:37 INFO - "buildid": "20160428014150", 02:35:37 INFO - "pgo_build": "False", 02:35:37 INFO - "basedir": "/builds/slave/test", 02:35:37 INFO - "buildnumber": 738, 02:35:37 INFO - "slavename": "t-yosemite-r7-0196", 02:35:37 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:35:37 INFO - "platform": "yosemite_r7", 02:35:37 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:35:37 INFO - "branch": "fx-team", 02:35:37 INFO - "repo_path": "integration/fx-team", 02:35:37 INFO - "revision": "9d71a501fd32617206049dbef2d4a7bb7802c781", 02:35:37 INFO - "stage_platform": "macosx64", 02:35:37 INFO - "builduid": "832137680db24ea4ba0292eb7b426138", 02:35:37 INFO - "slavebuilddir": "test" 02:35:37 INFO - } 02:35:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 02:35:37 INFO - Running post-action listener: _resource_record_post_action 02:35:37 INFO - ##### 02:35:37 INFO - ##### Running download-and-extract step. 02:35:37 INFO - ##### 02:35:37 INFO - Running pre-action listener: _resource_record_pre_action 02:35:37 INFO - Running main action method: download_and_extract 02:35:37 INFO - mkdir: /builds/slave/test/build/tests 02:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:37 INFO - https://queue.taskcluster.net/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:35:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 02:35:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 02:35:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 02:35:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 02:35:38 INFO - Downloaded 1199 bytes. 02:35:38 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 02:35:38 INFO - Using the following test package requirements: 02:35:38 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 02:35:38 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:35:38 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 02:35:38 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:35:38 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 02:35:38 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:35:38 INFO - u'jsshell-mac.zip'], 02:35:38 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:35:38 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 02:35:38 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 02:35:38 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:35:38 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 02:35:38 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:35:38 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 02:35:38 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:35:38 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 02:35:38 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:35:38 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 02:35:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:35:38 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')]} 02:35:38 INFO - https://queue.taskcluster.net/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:35:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:35:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:35:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:35:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:35:40 INFO - Downloaded 18116505 bytes. 02:35:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:35:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:35:43 INFO - Return code: 0 02:35:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:35:43 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')]} 02:35:43 INFO - https://queue.taskcluster.net/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:35:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:35:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:35:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:35:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:35:45 INFO - Downloaded 18116505 bytes. 02:35:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:35:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:35:48 INFO - Return code: 0 02:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:48 INFO - https://queue.taskcluster.net/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:35:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 02:35:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 02:35:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 02:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:35:50 INFO - Downloaded 10840145 bytes. 02:35:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:35:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:35:51 INFO - Return code: 0 02:35: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')]} 02:35:51 INFO - https://queue.taskcluster.net/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:35:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 02:35:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 02:35:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 02:35:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 02:35:56 INFO - Downloaded 110189080 bytes. 02:35:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 02:35:56 INFO - mkdir: /builds/slave/test/properties 02:35:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:35:56 INFO - Writing to file /builds/slave/test/properties/build_url 02:35:56 INFO - Contents: 02:35:56 INFO - build_url:https://queue.taskcluster.net/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 02:35:57 INFO - Running post-action listener: _resource_record_post_action 02:35:57 INFO - Running post-action listener: set_extra_try_arguments 02:35:57 INFO - ##### 02:35:57 INFO - ##### Running populate-webroot step. 02:35:57 INFO - ##### 02:35:57 INFO - Running pre-action listener: _resource_record_pre_action 02:35:57 INFO - Running main action method: populate_webroot 02:35:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:35:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:35:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:35:57 INFO - '--tppagecycles', 02:35:57 INFO - '7'], 02:35:57 INFO - 'tests': ['tsvgm']}}, 02:35:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:35:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:35:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:35:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:35:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:35:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:35:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:57 INFO - 'talos_options': ['--disable-e10s'], 02:35:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:35:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:35:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:57 INFO - 'talos_options': ['--disable-e10s'], 02:35:57 INFO - 'tests': ['damp', 'tps']}, 02:35:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:57 INFO - 'tests': ['damp', 'tps']}, 02:35:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:35:57 INFO - 'tests': ['dromaeo_dom']}, 02:35:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:35:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:35:57 INFO - 'tests': ['a11yr', 02:35:57 INFO - 'ts_paint', 02:35:57 INFO - 'tpaint', 02:35:57 INFO - 'sessionrestore', 02:35:57 INFO - 'sessionrestore_no_auto_restore', 02:35:57 INFO - 'tabpaint']}, 02:35:57 INFO - 'other-e10s': {'tests': ['a11yr', 02:35:57 INFO - 'ts_paint', 02:35:57 INFO - 'tpaint', 02:35:57 INFO - 'sessionrestore', 02:35:57 INFO - 'sessionrestore_no_auto_restore', 02:35:57 INFO - 'tabpaint']}, 02:35:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:35:57 INFO - 'ts_paint', 02:35:57 INFO - 'tpaint', 02:35:57 INFO - 'sessionrestore', 02:35:57 INFO - 'sessionrestore_no_auto_restore', 02:35:57 INFO - 'tabpaint']}, 02:35:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:35:57 INFO - 'ts_paint', 02:35:57 INFO - 'tpaint', 02:35:57 INFO - 'sessionrestore', 02:35:57 INFO - 'sessionrestore_no_auto_restore', 02:35:57 INFO - 'tabpaint']}, 02:35:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:35:57 INFO - 'tests': ['a11yr', 02:35:57 INFO - 'ts_paint', 02:35:57 INFO - 'tpaint', 02:35:57 INFO - 'sessionrestore', 02:35:57 INFO - 'sessionrestore_no_auto_restore', 02:35:57 INFO - 'tabpaint']}, 02:35:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:35:57 INFO - 'tests': ['a11yr', 02:35:57 INFO - 'ts_paint', 02:35:57 INFO - 'tpaint', 02:35:57 INFO - 'sessionrestore', 02:35:57 INFO - 'sessionrestore_no_auto_restore', 02:35:57 INFO - 'tabpaint']}, 02:35:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:35:57 INFO - 'tests': ['tsvgx', 02:35:57 INFO - 'tsvgr_opacity', 02:35:57 INFO - 'tart', 02:35:57 INFO - 'tscrollx', 02:35:57 INFO - 'cart']}, 02:35:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:35:57 INFO - 'tsvgr_opacity', 02:35:57 INFO - 'tart', 02:35:57 INFO - 'tscrollx', 02:35:57 INFO - 'cart']}, 02:35:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:57 INFO - 'talos_options': ['--disable-e10s'], 02:35:57 INFO - 'tests': ['tp5o']}, 02:35:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:57 INFO - 'tests': ['tp5o']}, 02:35:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:57 INFO - 'talos_options': ['--disable-e10s', 02:35:57 INFO - '--xperf_path', 02:35:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:35:57 INFO - 'tests': ['tp5n']}, 02:35:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:57 INFO - 'talos_options': ['--xperf_path', 02:35:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:35:57 INFO - 'tests': ['tp5n']}}, 02:35:57 INFO - 'talos.zip': {'path': '', 02:35:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:35:57 INFO - Running post-action listener: _resource_record_post_action 02:35:57 INFO - ##### 02:35:57 INFO - ##### Running create-virtualenv step. 02:35:57 INFO - ##### 02:35:57 INFO - Running pre-action listener: _resource_record_pre_action 02:35:57 INFO - Running main action method: create_virtualenv 02:35:57 INFO - Creating virtualenv /builds/slave/test/build/venv 02:35:57 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 02:35:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:35:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:35:57 INFO - Using real prefix '/tools/python27' 02:35:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:35:58 INFO - Installing distribute.............................................................................................................................................................................................done. 02:36:00 INFO - Installing pip.................done. 02:36:00 INFO - Return code: 0 02:36:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:36:00 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')]} 02:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:00 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')]} 02:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:00 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 0x101536a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101546420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6024d2150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013d5e00>, '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 0x1011fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013d0b20>, '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.6Ns0W3VikQ/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.o6h1BlX4P0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 02:36:00 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 02:36:00 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 02:36:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Ns0W3VikQ/Render', 02:36:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:00 INFO - 'HOME': '/Users/cltbld', 02:36:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:00 INFO - 'LOGNAME': 'cltbld', 02:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:00 INFO - 'MOZ_NO_REMOTE': '1', 02:36:00 INFO - 'NO_EM_RESTART': '1', 02:36:00 INFO - 'PAGER': '/bin/cat', 02:36:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:00 INFO - 'PWD': '/builds/slave/test', 02:36:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:00 INFO - 'SHELL': '/bin/bash', 02:36:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6h1BlX4P0/Listeners', 02:36:00 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:36:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:00 INFO - 'USER': 'cltbld', 02:36:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:00 INFO - 'XPC_FLAGS': '0x0', 02:36:00 INFO - 'XPC_SERVICE_NAME': '0', 02:36:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:01 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 02:36:01 INFO - Cleaning up... 02:36:01 INFO - Return code: 0 02:36:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101536a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101546420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6024d2150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013d5e00>, '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 0x1011fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013d0b20>, '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.6Ns0W3VikQ/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.o6h1BlX4P0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 02:36:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:36:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:36:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Ns0W3VikQ/Render', 02:36:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:01 INFO - 'HOME': '/Users/cltbld', 02:36:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:01 INFO - 'LOGNAME': 'cltbld', 02:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:01 INFO - 'MOZ_NO_REMOTE': '1', 02:36:01 INFO - 'NO_EM_RESTART': '1', 02:36:01 INFO - 'PAGER': '/bin/cat', 02:36:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:01 INFO - 'PWD': '/builds/slave/test', 02:36:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:01 INFO - 'SHELL': '/bin/bash', 02:36:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6h1BlX4P0/Listeners', 02:36:01 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:36:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:01 INFO - 'USER': 'cltbld', 02:36:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:01 INFO - 'XPC_FLAGS': '0x0', 02:36:01 INFO - 'XPC_SERVICE_NAME': '0', 02:36:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:01 INFO - Downloading/unpacking psutil>=0.7.1 02:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:36:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:04 INFO - Installing collected packages: psutil 02:36:04 INFO - Running setup.py install for psutil 02:36:04 INFO - building 'psutil._psutil_osx' extension 02:36:04 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 02:36:05 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 02:36:05 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 02:36:05 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 02:36:05 INFO - building 'psutil._psutil_posix' extension 02:36:05 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 02:36:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:36:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:36:05 INFO - ^ 02:36:05 INFO - 1 warning generated. 02:36:05 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 02:36:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:05 INFO - Successfully installed psutil 02:36:05 INFO - Cleaning up... 02:36:05 INFO - Return code: 0 02:36:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:36: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')]} 02:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36: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')]} 02:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101536a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101546420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6024d2150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013d5e00>, '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 0x1011fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013d0b20>, '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.6Ns0W3VikQ/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.o6h1BlX4P0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 02:36:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:36:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:36:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Ns0W3VikQ/Render', 02:36:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:05 INFO - 'HOME': '/Users/cltbld', 02:36:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:05 INFO - 'LOGNAME': 'cltbld', 02:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:05 INFO - 'MOZ_NO_REMOTE': '1', 02:36:05 INFO - 'NO_EM_RESTART': '1', 02:36:05 INFO - 'PAGER': '/bin/cat', 02:36:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:05 INFO - 'PWD': '/builds/slave/test', 02:36:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:05 INFO - 'SHELL': '/bin/bash', 02:36:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6h1BlX4P0/Listeners', 02:36:05 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:36:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:05 INFO - 'USER': 'cltbld', 02:36:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:05 INFO - 'XPC_FLAGS': '0x0', 02:36:05 INFO - 'XPC_SERVICE_NAME': '0', 02:36:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:36:05 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 02:36:05 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 02:36:05 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 02:36:05 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 02:36:05 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 02:36:05 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 02:36:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:36:08 INFO - Installing collected packages: mozsystemmonitor 02:36:08 INFO - Running setup.py install for mozsystemmonitor 02:36:08 INFO - Successfully installed mozsystemmonitor 02:36:08 INFO - Cleaning up... 02:36:08 INFO - Return code: 0 02:36:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:36:08 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')]} 02:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:08 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')]} 02:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:08 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 0x101536a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101546420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6024d2150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013d5e00>, '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 0x1011fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013d0b20>, '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.6Ns0W3VikQ/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.o6h1BlX4P0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 02:36:08 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 02:36:08 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 02:36:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Ns0W3VikQ/Render', 02:36:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:08 INFO - 'HOME': '/Users/cltbld', 02:36:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:08 INFO - 'LOGNAME': 'cltbld', 02:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:08 INFO - 'MOZ_NO_REMOTE': '1', 02:36:08 INFO - 'NO_EM_RESTART': '1', 02:36:08 INFO - 'PAGER': '/bin/cat', 02:36:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:08 INFO - 'PWD': '/builds/slave/test', 02:36:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:08 INFO - 'SHELL': '/bin/bash', 02:36:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6h1BlX4P0/Listeners', 02:36:08 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:36:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:08 INFO - 'USER': 'cltbld', 02:36:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:08 INFO - 'XPC_FLAGS': '0x0', 02:36:08 INFO - 'XPC_SERVICE_NAME': '0', 02:36:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:08 INFO - Downloading/unpacking blobuploader==1.2.4 02:36:08 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 02:36:08 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 02:36:08 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 02:36:08 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 02:36:08 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 02:36:08 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 02:36:11 INFO - Downloading blobuploader-1.2.4.tar.gz 02:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:36:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:36:11 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 02:36:11 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 02:36:11 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 02:36:11 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 02:36:11 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 02:36:11 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 02:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:36:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:12 INFO - Downloading docopt-0.6.1.tar.gz 02:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:36:12 INFO - Installing collected packages: blobuploader, requests, docopt 02:36:12 INFO - Running setup.py install for blobuploader 02:36:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:36:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:36:12 INFO - Running setup.py install for requests 02:36:13 INFO - Running setup.py install for docopt 02:36:13 INFO - Successfully installed blobuploader requests docopt 02:36:13 INFO - Cleaning up... 02:36:13 INFO - Return code: 0 02:36:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:13 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 0x101536a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101546420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6024d2150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013d5e00>, '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 0x1011fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013d0b20>, '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.6Ns0W3VikQ/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.o6h1BlX4P0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 02:36:13 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 02:36:13 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 02:36:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Ns0W3VikQ/Render', 02:36:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:13 INFO - 'HOME': '/Users/cltbld', 02:36:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:13 INFO - 'LOGNAME': 'cltbld', 02:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:13 INFO - 'MOZ_NO_REMOTE': '1', 02:36:13 INFO - 'NO_EM_RESTART': '1', 02:36:13 INFO - 'PAGER': '/bin/cat', 02:36:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:13 INFO - 'PWD': '/builds/slave/test', 02:36:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:13 INFO - 'SHELL': '/bin/bash', 02:36:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6h1BlX4P0/Listeners', 02:36:13 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:36:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:13 INFO - 'USER': 'cltbld', 02:36:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:13 INFO - 'XPC_FLAGS': '0x0', 02:36:13 INFO - 'XPC_SERVICE_NAME': '0', 02:36:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:13 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-5UVwMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:13 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-lwj6fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:13 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-HjolTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-ZVXKTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-GZZ9Vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-0reQpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-Hf2mgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-QUgo_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-xmNJw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-RUsXoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-GUvDwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-NQO7Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-UCAWa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:15 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-dx9ivc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:15 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-zc3tSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:15 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-W3krWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:15 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-JrXcD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:36:15 INFO - Running setup.py install for manifestparser 02:36:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:36:15 INFO - Running setup.py install for mozcrash 02:36:15 INFO - Running setup.py install for mozdebug 02:36:15 INFO - Running setup.py install for mozdevice 02:36:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:36:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:36:16 INFO - Running setup.py install for mozfile 02:36:16 INFO - Running setup.py install for mozhttpd 02:36:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:36:16 INFO - Running setup.py install for mozinfo 02:36:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:36:16 INFO - Running setup.py install for mozInstall 02:36:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:36:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:36:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:36:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:36:16 INFO - Running setup.py install for mozleak 02:36:16 INFO - Running setup.py install for mozlog 02:36:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:36:16 INFO - Running setup.py install for moznetwork 02:36:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:36:17 INFO - Running setup.py install for mozprocess 02:36:17 INFO - Running setup.py install for mozprofile 02:36:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:36:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:36:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:36:17 INFO - Running setup.py install for mozrunner 02:36:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:36:17 INFO - Running setup.py install for mozscreenshot 02:36:17 INFO - Running setup.py install for moztest 02:36:17 INFO - Running setup.py install for mozversion 02:36:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:36:18 INFO - Cleaning up... 02:36:18 INFO - Return code: 0 02:36:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:18 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')]} 02:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:18 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')]} 02:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:18 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 0x101536a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101546420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6024d2150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013d5e00>, '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 0x1011fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013d0b20>, '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.6Ns0W3VikQ/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.o6h1BlX4P0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 02:36:18 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 02:36:18 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 02:36:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Ns0W3VikQ/Render', 02:36:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:18 INFO - 'HOME': '/Users/cltbld', 02:36:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:18 INFO - 'LOGNAME': 'cltbld', 02:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:18 INFO - 'MOZ_NO_REMOTE': '1', 02:36:18 INFO - 'NO_EM_RESTART': '1', 02:36:18 INFO - 'PAGER': '/bin/cat', 02:36:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:18 INFO - 'PWD': '/builds/slave/test', 02:36:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:18 INFO - 'SHELL': '/bin/bash', 02:36:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6h1BlX4P0/Listeners', 02:36:18 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:36:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:18 INFO - 'USER': 'cltbld', 02:36:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:18 INFO - 'XPC_FLAGS': '0x0', 02:36:18 INFO - 'XPC_SERVICE_NAME': '0', 02:36:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-ywzC8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:18 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)) 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-421nJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:18 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)) 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-NcLpbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:18 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)) 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-VPRcp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:18 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)) 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-4oIxEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:18 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)) 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-rWHzcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:18 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)) 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-Qlq80t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-FZtq4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-j47Ca_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-QBUTAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-9mGwCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-Y4_0u3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-0JIDuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-kBoyMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-QqRyAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-77_w4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-HgztaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:20 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)) 02:36:20 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)) 02:36:20 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)) 02:36:20 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)) 02:36:20 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)) 02:36:20 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)) 02:36:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:36:20 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 02:36:20 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 02:36:20 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 02:36:20 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 02:36:20 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 02:36:20 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 02:36:22 INFO - Downloading blessings-1.6.tar.gz 02:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:36:22 INFO - Installing collected packages: blessings 02:36:22 INFO - Running setup.py install for blessings 02:36:22 INFO - Successfully installed blessings 02:36:22 INFO - Cleaning up... 02:36:22 INFO - Return code: 0 02:36:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:36:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:36:23 INFO - Reading from file tmpfile_stdout 02:36:23 INFO - Current package versions: 02:36:23 INFO - blessings == 1.6 02:36:23 INFO - blobuploader == 1.2.4 02:36:23 INFO - docopt == 0.6.1 02:36:23 INFO - manifestparser == 1.1 02:36:23 INFO - mozInstall == 1.12 02:36:23 INFO - mozcrash == 0.17 02:36:23 INFO - mozdebug == 0.1 02:36:23 INFO - mozdevice == 0.48 02:36:23 INFO - mozfile == 1.2 02:36:23 INFO - mozhttpd == 0.7 02:36:23 INFO - mozinfo == 0.9 02:36:23 INFO - mozleak == 0.1 02:36:23 INFO - mozlog == 3.1 02:36:23 INFO - moznetwork == 0.27 02:36:23 INFO - mozprocess == 0.22 02:36:23 INFO - mozprofile == 0.28 02:36:23 INFO - mozrunner == 6.11 02:36:23 INFO - mozscreenshot == 0.1 02:36:23 INFO - mozsystemmonitor == 0.0 02:36:23 INFO - moztest == 0.7 02:36:23 INFO - mozversion == 1.4 02:36:23 INFO - psutil == 3.1.1 02:36:23 INFO - requests == 1.2.3 02:36:23 INFO - wsgiref == 0.1.2 02:36:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:23 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 0x101536a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101546420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6024d2150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013d5e00>, '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 0x1011fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013d0b20>, '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.6Ns0W3VikQ/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.o6h1BlX4P0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 02:36:23 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 02:36:23 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 02:36:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Ns0W3VikQ/Render', 02:36:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:23 INFO - 'HOME': '/Users/cltbld', 02:36:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:23 INFO - 'LOGNAME': 'cltbld', 02:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:23 INFO - 'MOZ_NO_REMOTE': '1', 02:36:23 INFO - 'NO_EM_RESTART': '1', 02:36:23 INFO - 'PAGER': '/bin/cat', 02:36:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:23 INFO - 'PWD': '/builds/slave/test', 02:36:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:23 INFO - 'SHELL': '/bin/bash', 02:36:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6h1BlX4P0/Listeners', 02:36:23 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:36:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:23 INFO - 'USER': 'cltbld', 02:36:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:23 INFO - 'XPC_FLAGS': '0x0', 02:36:23 INFO - 'XPC_SERVICE_NAME': '0', 02:36:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 INFO - Cleaning up... 02:36:23 INFO - Return code: 0 02:36:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101536a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101546420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6024d2150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013d5e00>, '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 0x1011fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013d0b20>, '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.6Ns0W3VikQ/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.o6h1BlX4P0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 02:36:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:36:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Ns0W3VikQ/Render', 02:36:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:23 INFO - 'HOME': '/Users/cltbld', 02:36:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:23 INFO - 'LOGNAME': 'cltbld', 02:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:23 INFO - 'MOZ_NO_REMOTE': '1', 02:36:23 INFO - 'NO_EM_RESTART': '1', 02:36:23 INFO - 'PAGER': '/bin/cat', 02:36:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:23 INFO - 'PWD': '/builds/slave/test', 02:36:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:23 INFO - 'SHELL': '/bin/bash', 02:36:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6h1BlX4P0/Listeners', 02:36:23 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:36:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:23 INFO - 'USER': 'cltbld', 02:36:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:23 INFO - 'XPC_FLAGS': '0x0', 02:36:23 INFO - 'XPC_SERVICE_NAME': '0', 02:36:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:23 INFO - Downloading/unpacking jsonschema 02:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:36:26 INFO - Downloading/unpacking functools32 (from jsonschema) 02:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:26 INFO - Downloading functools32-3.2.3-2.tar.gz 02:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:36:26 INFO - warning: no files found matching '*.txt' 02:36:26 INFO - no previously-included directories found matching 'build' 02:36:26 INFO - no previously-included directories found matching 'dist' 02:36:26 INFO - no previously-included directories found matching '.git*' 02:36:26 INFO - Installing collected packages: jsonschema, functools32 02:36:26 INFO - Running setup.py install for functools32 02:36:26 INFO - warning: no files found matching '*.txt' 02:36:26 INFO - no previously-included directories found matching 'build' 02:36:26 INFO - no previously-included directories found matching 'dist' 02:36:26 INFO - no previously-included directories found matching '.git*' 02:36:26 INFO - Successfully installed jsonschema functools32 02:36:26 INFO - Cleaning up... 02:36:26 INFO - Return code: 0 02:36:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101536a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101546420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6024d2150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013d5e00>, '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 0x1011fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013d0b20>, '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.6Ns0W3VikQ/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.o6h1BlX4P0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 02:36:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:36:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Ns0W3VikQ/Render', 02:36:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:27 INFO - 'HOME': '/Users/cltbld', 02:36:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:27 INFO - 'LOGNAME': 'cltbld', 02:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:27 INFO - 'MOZ_NO_REMOTE': '1', 02:36:27 INFO - 'NO_EM_RESTART': '1', 02:36:27 INFO - 'PAGER': '/bin/cat', 02:36:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:27 INFO - 'PWD': '/builds/slave/test', 02:36:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:27 INFO - 'SHELL': '/bin/bash', 02:36:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6h1BlX4P0/Listeners', 02:36:27 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:36:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:27 INFO - 'USER': 'cltbld', 02:36:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:27 INFO - 'XPC_FLAGS': '0x0', 02:36:27 INFO - 'XPC_SERVICE_NAME': '0', 02:36:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:27 INFO - Downloading/unpacking flake8 02:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:36:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:36: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 02:36: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 02:36: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 02:36: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 02:36: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 02:36: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 02:36:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:36:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:36:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:36:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:36:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:36:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:36:30 INFO - no previously-included directories found matching 'docs/_build' 02:36:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:36:31 INFO - Running setup.py install for pep8 02:36:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:36:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:36:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:36:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:36:31 INFO - no previously-included directories found matching 'docs/_build' 02:36:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:36:31 INFO - Cleaning up... 02:36:31 INFO - Return code: 0 02:36:31 INFO - Running post-action listener: _resource_record_post_action 02:36:31 INFO - Running post-action listener: _start_resource_monitoring 02:36:31 INFO - Starting resource monitoring. 02:36:31 INFO - ##### 02:36:31 INFO - ##### Running install step. 02:36:31 INFO - ##### 02:36:31 INFO - Running pre-action listener: _resource_record_pre_action 02:36:31 INFO - Running main action method: install 02:36:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:36:31 INFO - Reading from file tmpfile_stdout 02:36:31 INFO - Detecting whether we're running mozinstall >=1.0... 02:36:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:36:31 INFO - Reading from file tmpfile_stdout 02:36:31 INFO - Output received: 02:36:31 INFO - Usage: mozinstall [options] installer 02:36:31 INFO - Options: 02:36:31 INFO - -h, --help show this help message and exit 02:36:31 INFO - -d DEST, --destination=DEST 02:36:31 INFO - Directory to install application into. [default: 02:36:31 INFO - "/builds/slave/test"] 02:36:31 INFO - --app=APP Application being installed. [default: firefox] 02:36:31 INFO - mkdir: /builds/slave/test/build/application 02:36:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:37:05 INFO - Reading from file tmpfile_stdout 02:37:05 INFO - Output received: 02:37:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:37:05 INFO - Running post-action listener: _resource_record_post_action 02:37:05 INFO - ##### 02:37:05 INFO - ##### Running run-tests step. 02:37:05 INFO - ##### 02:37:05 INFO - Running pre-action listener: _resource_record_pre_action 02:37:05 INFO - Running main action method: run_tests 02:37:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:37:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:37:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:37:05 INFO - 2016-04-28 02:37:05.629 screenresolution[1633:7491] starting screenresolution argv=screenresolution get 02:37:05 INFO - 2016-04-28 02:37:05.632 screenresolution[1633:7491] Display 0: 1600x1200x32@60 02:37:05 INFO - 2016-04-28 02:37:05.638 screenresolution[1634:7493] starting screenresolution argv=screenresolution list 02:37:05 INFO - Available Modes on Display 0 02:37:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:37:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:37:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:37:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:37:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:37:05 INFO - Intel Iris: 02:37:05 INFO - Chipset Model: Intel Iris 02:37:05 INFO - Type: GPU 02:37:05 INFO - Bus: Built-In 02:37:05 INFO - VRAM (Dynamic, Max): 1536 MB 02:37:05 INFO - Vendor: Intel (0x8086) 02:37:05 INFO - Device ID: 0x0a2e 02:37:05 INFO - Revision ID: 0x0009 02:37:05 INFO - Displays: 02:37:05 INFO - Display: 02:37:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:37:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:37:05 INFO - Display Serial Number: 1600x1200 60 02:37:05 INFO - Main Display: Yes 02:37:05 INFO - Mirror: Off 02:37:05 INFO - Online: Yes 02:37:05 INFO - Rotation: Supported 02:37:05 INFO - Return code: 0 02:37:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:37:05 INFO - Python 2.7.3 02:37:05 INFO - Return code: 0 02:37:05 INFO - grabbing minidump binary from tooltool 02:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:37:05 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 0x1013d5e00>, '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 0x1011fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013d0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:37:05 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 02:37:05 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 02:37:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:37:05 INFO - Return code: 0 02:37:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:37:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:37:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:37:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:37:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:37:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:37:07 INFO - Return code: 0 02:37:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0196', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:37:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0196 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:37:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Ns0W3VikQ/Render', 02:37:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:37:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:37:07 INFO - 'HOME': '/Users/cltbld', 02:37:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:37:07 INFO - 'LOGNAME': 'cltbld', 02:37:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:37:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:07 INFO - 'MOZ_NO_REMOTE': '1', 02:37:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:37:07 INFO - 'NO_EM_RESTART': '1', 02:37:07 INFO - 'PAGER': '/bin/cat', 02:37:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:07 INFO - 'PWD': '/builds/slave/test', 02:37:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:37:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:37:07 INFO - 'SHELL': '/bin/bash', 02:37:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6h1BlX4P0/Listeners', 02:37:07 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 02:37:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:37:07 INFO - 'USER': 'cltbld', 02:37:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:37:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:07 INFO - 'XPC_FLAGS': '0x0', 02:37:07 INFO - 'XPC_SERVICE_NAME': '0', 02:37:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:37:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0196', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:37:07 INFO - mozversion application_buildid: 20160428014150 02:37:07 INFO - mozversion application_changeset: 9d71a501fd32617206049dbef2d4a7bb7802c781 02:37:07 INFO - mozversion application_display_name: Nightly 02:37:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:37:07 INFO - mozversion application_name: Firefox 02:37:07 INFO - mozversion application_remotingname: firefox 02:37:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:37:07 INFO - mozversion application_vendor: Mozilla 02:37:07 INFO - mozversion application_version: 49.0a1 02:37:07 INFO - mozversion platform_buildid: 20160428014150 02:37:07 INFO - mozversion platform_changeset: 9d71a501fd32617206049dbef2d4a7bb7802c781 02:37:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:37:07 INFO - mozversion platform_version: 49.0a1 02:37:07 INFO - using testdate: 1461836227 02:37:07 INFO - actual date: 1461836227 02:37:07 INFO - starting webserver on 'localhost:49278' 02:37:07 INFO - SUITE-START | Running 2 tests 02:37:07 INFO - TEST-START | dromaeo_css 02:37:07 INFO - operating with platform_type : mac_ 02:37:07 INFO - Initialising browser for dromaeo_css test... 02:37:07 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmpDMx9hg/profile http://localhost:49278/getInfo.html) 02:37:09 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 02:37:09 INFO - PROCESS | 1652 | colorDepth:24 02:37:09 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 02:37:09 INFO - PROCESS | 1652 | __metrics 02:37:09 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:37:09 ERROR - PROCESS | 1652 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:37:10 INFO - TEST-INFO | 1652: exit 0 02:37:10 INFO - Browser initialized. 02:37:10 INFO - Running cycle 1/1 for dromaeo_css test... 02:37:10 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmpDMx9hg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:37:22 INFO - PROCESS | 1654 | RSS: Main: 239296512 02:37:22 INFO - PROCESS | 1654 | 02:38:13 INFO - PROCESS | 1654 | 1461836293752 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] 02:40:23 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 02:40:25 INFO - PROCESS | 1654 | RSS: Main: 355020800 02:40:25 INFO - PROCESS | 1654 | 02:43:28 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 02:43:28 INFO - PROCESS | 1654 | RSS: Main: 369102848 02:43:28 INFO - PROCESS | 1654 | 02:46:30 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 02:46:31 INFO - PROCESS | 1654 | RSS: Main: 375427072 02:46:31 INFO - PROCESS | 1654 | 02:49:33 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 02:49:34 INFO - PROCESS | 1654 | RSS: Main: 376954880 02:49:34 INFO - PROCESS | 1654 | 02:52:37 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 02:52:38 INFO - PROCESS | 1654 | RSS: Main: 345284608 02:52:38 INFO - PROCESS | 1654 | 02:55:41 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 02:55:41 INFO - PROCESS | 1654 | RSS: Main: 384409600 02:55:41 INFO - PROCESS | 1654 | 02:55:41 INFO - PROCESS | 1654 | __start_tp_report 02:55:41 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 02:55:41 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 02:55:41 INFO - PROCESS | 1654 | |i|pagename|runs| 02:55:41 INFO - PROCESS | 1654 | |0;dojo.html;2747.4917140329035;3422.982885085575;3425.0409885232143;3463.4458486642143;3488.9476657850123;5583.357913839899;5604.467575580318;5642.238297829792;5645.435456454353;5647.181158731982;5627.493525582697;5657.773689052433;5735.627184233022;5757;5793.217915581396;5063;5080.872978175556;5107.923381149267;5114.1050316194705;5138.177891537355;5117;5166.457521960197;5180.6373553851245;5182.2226666000215;5235.6596821206695;5007.7496125193775;5074.4925507449325;5098.719570423626;5116.027954688616;5147.382314122292;5010.69935803853;5029.572486338666;5038.7984480620735;5051.913838524698;5054.7472626368535;5059.4434612193;5111.08000559899;5115.2071428928575;5117.948820511821;5124;5465.808696695636;5472.50747432729;5555.777768889239;5590.413006634286;5599.300087489064;6100.877982440371;6109.541784366146;6128.172696685935;6136.7852125175405;6137.815865523997;6154.753809847601;6180.049631748377;6190.5976111553055;6224.751009959597;6231.158793562857;5622.971885140589;5726.9713651431475;5770.365259821417;5825.300963884361;5848.941510584925;5296.894062118736;6189.566730328924;6198.659073750987;6206.410391012847;6211.720472578745;5958.433948774859;6084.543659225487;6085.482733967662;6086.6652334122045;6087.1173679816175;6109.799438327889;6124.730495887588;6193.659348735772;6194.0708893665405;6201.906971395432;6073.99886523128;6098;6128.571000030044;6138.664296166128;6149.938500615026;6086.908696369558;6097.706879361915;6175.876482470326;6200.596961197598;6216.720247588869;4835.782389792468;4864.270359446112;4923.187674033744;4935.333729946483;4937.876553086202;4361.214981303396;4366.607005369532;4371.715838470489;4380.233459144637;4402;5611.915821262684;5612.102063669793;5615.887682246333;5616.634918730269;5674.77300907959;5237.266782650432;6134.723937422827;6161.938380616137;6177.135201071854;6256.217972753406;5608.298962629671;5650.491455769001;5654.6324488908085;5669.121286200645;5679.659220446786;5140.485951404829;5355.143177091647;5357.357117145967;5357.571394288448;5400.0819860623005;6236.688165591702;6258.937410625836;6296.087067375296;6300.432961033529;6305.527085468517;6060.606060606046;6111.287884814297;6128.228138398679;6132.78385080153;6144.832481828438;6270.843228919131;6277.497800176066;6290.716917738804;6296.842578935563;6303.432691057827;4855.830045948375;5970.758923011746;6001.36985616504;6018.969905150446;6065.120557519223;6135.508280839814;6178.320384757583;6247.781327653511;6258.249010118633;6268.623882567061;5883.852903677443;5905.763769449174;5921.61509501881;5942.7920022799;5981.252343457068;4546.659000574904;5870.26621672291;5901.232839730807;5954.821355359346;5964.731587078679;5897.321807992136;5900.734466949083;5942.346341902301;5942.851428714143;5990.34106248321;6092.45167934888;6106.847328816815;6107.480864126599;6108.389161084034;6114.2357205349335;5749.798757043483;5830.76676932918;5833.7666493341485;5897.469227769521;5940.079287710412 02:55:41 INFO - PROCESS | 1654 | |1;ext.html;496.78886473248883;529.9629025968181;532.5366930770231;570.0281020859433;577.4369989260472;29051.418971620555;35825.64174358256;36764.080897977496;36860.81569592155;36876.99999999996;39314.41028384576;39888.60111398885;40043.599564004355;40119.79341136236;40313.59686403135;9389;9633.95183024084;9641.180499657537;9646.469444180568;9647.75880602987;9478.66824661137;9605.615775368977;9634.47010414427;9641.517924103802;9659.710208693716;9561.808763824754;9637.807243855119;9639.277054220927;9644.517774111302;9645.03549645037;9557.996410376914;9614.903850961471;9621.278404119648;9625.759356016086;9633.759156021086;9391.154796068387;9468.479233642147;9486.857697134548;9491.477968711719;9513.619455221851;30780.8460957696;37754.244915101546;37775.8111209445;37875.43186852199;37924;3187.8884239051754;3224.4357237483346;3226.7095961363357;3391.491276308549;3560.893173204808;26773.464530709472;26862.194134176007;27167.728322716914;27180.320491987663;27317.043903463484;2728.181545536351;2735.2204621682727;2753.5318995770567;2761.282066662662;2840.5313123334627;349973;353200;353602;354335;354479;44137;51964;52055;52259.73870130701;52469.7376513115;51441.485585144415;52596.948061038565;52665;52694;52721.7363913178;15370.923145384202;15483;15608.609784755472;15615.921920390325;15616.141112238709;11078.778424431466;12177.878221217852;12306.200096993845;12394.566190183301;12410;14000.579982600539;14036.157830530201;14078.225697586731;14184.219867907364;14218.431262749582;5170.482951704799;6015.488683461955;6178;6191.473724733448;6238.563300568917;883.5979629268668;887.7647423432795;888.0675290944482;1058.4178701714027;1101.4437708956925;22640.773592264195;23147;28137.57793633097;28484.145475635763;28531.57202641962;1082.8917108289265;1139.174098778379;1161.268400907423;1166.3002198680892;1256.7109564800148;14294.428222870969;14536.927315363355;14717.779233311509;14819.333130009176;14897;359483;366836;369285;369759;465052;50910;51177;51292.48707512952;51422.48577514177;51522.484775152516;1358.6671265540006;1363.9318034098058;1455.1560095144791;1460.4815290571908;1481.9184944828137;22784.544309114055;22950.655740164246;23441.648375274042;23782.405439864142;26555.672216388717;47029.529704703884;47154.764226178646;47572;47643.76178119087;47671.76164119157;315730;316605.8339416669;317062.41468793433;317219;319046;15358.769618455955;20944.68582971287;21254.574908502054;23744.52510949806;24046.797660117274;39015.21969560536;40037;40831;41234.175316494104;41329.58670413258;32413.35173296568;33861.830690846386;34047.65952340445;34645.48031779475;34843.30313393768;33732.49401259032;34847.47728784121;35074.64925350714;35369.82315088408;35720.821395893894;34054.48918266278;34375;34654.653453465144;35018.474722878665;35318;26535;30241.546376803926;30821;30853.537196942514;30856;23337.619078349788;23464.066313011077;23486.530269394858;23780.76219237855;23882.880585596962 02:55:41 INFO - PROCESS | 1654 | |2;jquery.html;394.3296396126585;394.88153553933813;399.5145897734256;399.59840360437755;411.2084237842153;11734.643176559108;19413;19448.319308824193;20091.497712557193;20108.09513571889;15409.768853467207;17243.74134387985;18471.076446177703;19430.708539371884;19621.411357659257;5769.16347129666;6076;6100.23747031621;6104;6108.908366374508;5709.71451427429;6017.097435384683;6069.878602427949;6094.390560943914;6094.664793436359;3907.882763517099;4137.358709400048;5728.598998070137;6056.818295451144;6062.120992456091;5972.313183983854;5978.133170690226;6033.245844269466;6037.154798328237;6037.849053773669;5600.635958662715;5766.0774276116035;5802.071668533056;5812.534997200214;5837.532997360201;12996.415161317764;13270.601881943558;18901.527461813428;24246.757532424803;25136;2077.4079387374527;2158.5790770799545;2199.516106456577;2280.144945645383;2718.5378485657484;9160.587773550205;9689.806203875884;10089.344192627455;10168.745781355452;10216.846747298796;1692.306154476671;1737.7132773092424;1746;1759.7096479080935;1759.8416142547105;63966.68016659933;106182;107609;109460;110909.89090109077;11483;11498.712532186762;11622.825657615143;11788.115891308014;12025.158238923192;14804.777928331083;14879.03286286388;14913.3289001993;14947.626309342137;14954.327055282538;7464.664090115849;8209.71266005687;8334.62494187763;8519.829603408021;8623.137686231452;7035.437165026786;8106.837863242702;8306.127856575093;8314.875276870851;8427.030891447439;4471.105778844244;4558.680892337505;4577.176108300471;4632.953670463319;4635.215442054833;1702.7956645202407;1888.3579582941866;1900.097453709477;1952.4435535872492;1961.7253584498183;747.4580928826557;897.9730608081768;902.4720538484928;991.5141580625586;1007.9244056695777;16550.42073527445;18481.353152639593;19610.72530285527;19624.70562941557;19752;937.3625934364561;979.0356498848629;1019.8929112443235;1021.4177918586483;1039.3192458939407;7777.805554861174;10406.375290798307;10684.946575267073;10761.408122553335;10766.30019048775;587123;596653;622334.666746272;639645;639921;116739;117910;119002.53407027597;121311;124232;982.9262805289632;1004.7036124343336;1018.8166130096654;1018.9337693049928;1020.1583693452931;17222.483325500256;17660.823391765916;17728.13925402475;17743.645127097127;17858.285668573113;45613.315800263685;47946.5205347942;48529.514704853915;48586;49107.75446122889;63600.409989748776;67854.66072669605;67886.66056669685;68544.6572767133;72488;7785.493942893694;7794.649240784292;7929.643166057426;8190.590470476572;8270.090290067967;12002.21985570935;12157.878421215675;12241.0819188563;12470.127091103535;12506.499740010662;10058.245631577514;10663.733406664895;10697.946510267398;10721.946390267998;10732.73168170802;8802;10368.844467333147;10541.209409294486;10636.680899573024;10912.508937097691;10525.263231573716;11101.389423581457;11159.665210043711;11369.829452558384;11541.538338466367;8174.509529428254;8331.875021874797;8337;8413.831723365622;8424.725324162564;10136.695899122744;10650.57397704083;10768.62309819184;11035.455036295085;11325.773484530428 02:55:41 INFO - PROCESS | 1654 | |3;mootools.html;1417.7802440621708;1578.0531680991403;1589.300707688617;1863.9906800465997;2003.6393449179152;7813.4139939504485;8414.663413463462;8665;8665.480071195732;8665.566721663907;8378.874316885252;8594.269487093605;8605.91394086059;8611.956940215307;8626;2378.15575470708;2416.3355077353694;2418.22616762636;2420.9831870614385;2423.8424502407374;2064.2362325939425;2351.729551101628;2369.2536850891915;2417.2385698505004;2424.636304554322;2389.844660097097;2419.3104965084954;2432.0636554926305;2436.2082323244927;2441.011390386896;2363.645453182019;2375.6317770745477;2387.164492427645;2389.1399096325395;2417.347316224627;2366.6450032495263;2391.1033362489065;2394.1381102802975;2394.2099107294553;2395.652630368604;8395.664173433055;8555.973283205993;8557.614907329124;8644.394892357537;8656.09111043344;5089.389273287229;5296.788128474856;5299.125644268691;5304.92042619361;5335.146376579767;3321;3394.4908263760385;3460.1003739027783;3478.095695119262;3488.494168345576;959.6785076999214;966.8888077870994;975.7121649113528;977.1226075157931;979.8187335342913;11497.942510287396;11628.825567616492;11634.127440442;11678.065754739686;11713.945744882916;4562.9771851141195;4613.700109492872;4903.803847846118;4907.730074845917;4911.705297682079;8964.551772411354;8974.371793974358;9055.864162037575;9065.954670226607;9066.50134242623;5240.764165612557;5242.7378631068295;5243.397009343898;5249.737513124329;5256.816011439658;4101.118259574206;4101.425800387889;4381.605655491021;4833;4899.485554016848;3726.888193354204;3762.830672619739;3800.771953682788;3825.101101241206;3843.673287770571;1028.3315844701003;1187.1689817128045;1210.116614871149;1223.3944197622234;1232.6979889927024;667.4693618573245;725.3073314984283;792.3502727763295;802.8996375453069;980.6959842448864;5567.916481252784;5723.170140329629;5861.794837180763;6000.939990600125;6033.607815491979;963.9469829159464;973.9415635061919;994.2543092680489;997.1474389397106;1005.0201053972319;3857.40210267409;3963.504561929759;4028.113814960704;4047.2714911316248;4047.3119569673227;9742.75643108928;10647.520861561248;10694.304870183412;10721.571137154582;10746.892531074589;10390.896091039143;10415.16678665705;10667.786644267226;10684;10693.19801014927;7937;8172.959135204404;8228.136045715233;8276.379271554657;8277.04813946392;5655.547556195576;5838.912416313674;5841;5852.824415267549;5961.731722072431;9556.665516706882;9799.804003919739;9871.50642467888;9890.901090988998;9964.900350996688;9698;9730.95134524323;9862.161716254199;10056.849147262943;10074.14369778577;6787;6829.521933464808;6918.654067296716;6938.479614029069;6942.340477654615;7851.646675899484;7903.209679032051;7918.129005809472;7926.722564710208;8027.759167224993;7161.928380716126;7183.425325973805;7243.20324764286;7274.945132955798;7341.522801017917;6087.269527656709;6813.250542440229;7118.359347658736;7271.563706177435;7281.2718728126765;6769.052332673331;6845.0759147514445;6846.657667116724;6849.520533562602;6853.348931851466;4694.366260554782;4890.046440943982;4979.626528010342;4982.950170498394;5000.324956130876;4908.63185261114;4968.527989840959;4999.750012499433;5009.624278179224;5163.432022477599 02:55:41 INFO - PROCESS | 1654 | |4;prototype.html;319.7489970373256;320.7097576693093;328.1369996908131;329.6736231131181;332.0304710246081;4517.299818528133;5200.921986170206;5240.397354304256;5249.711265880375;5340.91988620171;5274.868128296795;5295.655782374152;5304.443033481487;5315.0432922074015;5328.280682107914;3394.524766532675;3715.6098609645937;3999.340108882031;4051.6961227907877;4088.693347998897;4006.61937115975;4042.9191416171657;4046.433499310099;4078.938815917764;4112.218678451085;3334.7665663403573;4027.5972402759635;4053.736507127042;4056.8580099696514;4058.4115303281005;3828.559715632682;3859.9421008684894;3893.1824316893626;4042.130941847517;4051.331530297527;3092.9381412371627;3519.964800351989;3522.489239060322;3539.50446937429;3548.30807992439;4634.721916684976;4738.0337160078525;5063.518965698253;5145.716985565792;5152.562032227265;3817.48463957365;4288.678349123797;4597.103564804865;4615.330777037344;4651.767411629405;5550.389457159709;5570.554355651539;5599.720013999284;5610.887782244373;5616.9157462638095;3867.3038853006447;3870.651641352292;3874.302625527404;3884.6698030667426;3889.9611003890163;5223.764930578133;5645.052456902362;5801.361850196475;5961.195238642771;5967.224260846106;3534.964650353515;3861.8069096545623;3873.283442563135;3903.316919539069;3904.90237744053;3487.75585709003;3860.0542866997203;3955.499383046025;3956.485656864647;3965.2862484753023;3867.7485963412287;4430.667699922518;4616.492185859553;4618.099470603267;4621.653375996813;5324.281222035053;5369.677819330853;5668.858278543069;5691;5709.3434255060365;1412.81633387661;1440.2654646130338;1442.6826098258366;1443.5813614052017;1451.528253317676;891.3760367742606;907.4029707714338;946.7822400847843;965.3194497878978;977.4965892565334;5597.132444471114;5621.072523033736;5644.322681278273;5656.717164141776;5692.402297758676;5716.657000579979;5979.820605381846;6169.352218017044;6258.780942666985;6279.905801412982;4835.830745923876;5010.995601759326;5333.57331413486;5372.274742909657;5642.887142257132;2538.0609174605515;3071.1093782802736;3351.966480335165;3361.2941282330494;3365.192353835062;5912.526997840162;6369.331220221903;6609.206895172514;6671.39957403836;6723.294054124344;5874.412558744091;6196.411340922605;6444.645544495004;6568.310327415648;6596.340365963461;5864.530837533072;6457.773977910939;6615.834604134935;6653.434458071021;6687.29164688302;5344.518993290622;5888.823335299948;6331.2085989251345;6338.176037115146;6366;5252.711100889488;5414.972925135507;6008.789692360747;6076.635401875901;6139.986902161093;5397.920415916754;5755.53955683536;5837.270341207349;6073.540216212441;6318.199313195717;3485.424904890766;3615.313090512794;3731.92877952728;3842.7310088293552;3877.8061096945603;5895.29256489224;5896.262967129109;5915.911261330997;5918.348981611933;5925.496332811759;5329.866753331198;5743.396943320891;5746.310442746897;5765.347939947504;5805.680687562056;4919.696280485746;5258.553022992935;5709.800156994485;5733.39799321082;5737.254156959569;5267.657602255841;5270.288511050959;5470.589705772162;5568.387477377404;5630.95827271956;5623.2408624835125;5647.322321321468;5715.657060576379;5732.3121225453215;5732.398098199629;5567.916481252865;5595.972020139873;5596.272484576979;5599.468050535193;5626.774929002794 02:55:41 INFO - PROCESS | 1654 | |5;yui.html;664.292528457193;716.2694052066892;738.5900825042099;768.4620765464176;805.5851236613141;12785.041121915847;12986.54547090852;12996.740065198703;13089.541866034691;13438.328083595818;14680.926595367035;15352.385904563833;15382.923085384557;15409.537713868574;15485;726.1685370251059;749.5952185819651;916.2624087609488;929.530587053537;943.2878176976374;900.7703035725881;932.7528205025674;934.1685899549373;936.4287784451479;939.2063706168277;940.7836197674538;954.885413750351;956.9521523923811;958.5590628310986;958.8034452937165;770.7071312901062;945.7919257763281;958.4919992404002;959.3236768078488;976.1556253840376;728.5992704012772;733.4938892164389;735.9153697324823;736.628002858553;739.2238149942539;14553.927230363886;14559.199244041574;14563;14665;14715;11816.645500634995;11916.225445346025;12072.783477575953;12134.211276267015;12230.327331996737;9867.40795552269;9957.253206009505;9995.750106247402;10322.483875806254;10414.739631509197;3393.915152121192;3443.1220038890174;3453.240287136851;3467.6358982306747;3554.626764189749;75970.62014689947;76583.23416765817;76754.61622691852;77453.83819242715;77591;9176.95411522938;9239.260859131253;9275.90724092764;9497;9527.714168574954;20417.387478375673;20757.377278681663;20823.58352832965;20847.583048339253;20865.37403877886;7113.039739635186;7287.890681639779;7331.74338898136;7428.480006399608;7481;3828.5979972102527;3886.689064874803;3894.824732887027;3903.843846246175;3978.4430179774854;3435.1068722131927;3498.6151523332414;3500.9124771880906;3503;3512.964870351315;620.3176505843536;623.3423737956499;628.1457218183358;648.678903942542;651.5081113759081;564.6809552602848;607.6080927801631;611.1382950040422;615.7690865925279;627.157709390547;7879.606019699107;8034.959825200836;8214.671413143407;8220.753377398687;8274.213949674771;574.2104606166521;587.4198406287074;601.0323379359228;605.0052241405062;609.5489337889929;3809.8666546670734;3836.558795738526;3867.013911452618;3876.1084950460986;4069.084455997436;95887.52056239675;96752.51623741836;96939;96957;97303.02696973081;75302;75419;75923.62038189884;78247.60876195582;79663;54867;69694.65152674305;70816;71000.64499677469;71112;7654.15804261542;7710.4602677814255;7786.649600768093;7858.292753652198;7894.605269736605;35806.462903057;41847;42275;42278.788606056776;44138.55861441473;57656.42343576511;57711.1343329842;59739.40260597512;61294.080588792094;62351;8629.784255393413;10187.388756674623;10187.949060254652;10226.846597300897;10420.739481513023;9371.81256374855;11119.27724697892;11344.602938897098;11454.94272528632;11840.822387664364;10373.377597344184;10560.577576896838;10681.626143084955;10727.839082413613;10858.185636077167;10487.26589138753;10499.212559058255;10502.82653972014;10550.788984220426;10852.023317901427;10083.596656133672;10294;10486.947565262124;10559.683209503728;10594.205434592282;8409.327253819558;8592.49376471684;8641.95679021626;8643.092475290005;8653.61058752345;7116.822079448055;8510.957445212734;8695.608697608497;8958.462492250486;8983.865242021506 02:55:41 INFO - PROCESS | 1654 | __end_tp_report 02:55:41 INFO - PROCESS | 1654 | __start_cc_report 02:55:41 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1152 02:55:41 INFO - PROCESS | 1654 | __end_cc_report 02:55:41 INFO - PROCESS | 1654 | __startTimestamp1461837341370__endTimestamp 02:55:41 INFO - PROCESS | 1654 | 02:55:41 INFO - PROCESS | 1654 | ------- Summary: start ------- 02:55:41 INFO - PROCESS | 1654 | Number of tests: 6 02:55:41 INFO - PROCESS | 1654 | 02:55:41 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5645.74 Median:5870.27 stddev:646.03 (11.0%) stddev-sans-first:606.69 02:55:41 INFO - PROCESS | 1654 | Values: 2747.5 3423.0 3425.0 3463.4 3488.9 5583.4 5604.5 5642.2 5645.4 5647.2 5627.5 5657.8 5735.6 5757.0 5793.2 5063.0 5080.9 5107.9 5114.1 5138.2 5117.0 5166.5 5180.6 5182.2 5235.7 5007.7 5074.5 5098.7 5116.0 5147.4 5010.7 5029.6 5038.8 5051.9 5054.7 5059.4 5111.1 5115.2 5117.9 5124.0 5465.8 5472.5 5555.8 5590.4 5599.3 6100.9 6109.5 6128.2 6136.8 6137.8 6154.8 6180.0 6190.6 6224.8 6231.2 5623.0 5727.0 5770.4 5825.3 5848.9 5296.9 6189.6 6198.7 6206.4 6211.7 5958.4 6084.5 6085.5 6086.7 6087.1 6109.8 6124.7 6193.7 6194.1 6201.9 6074.0 6098.0 6128.6 6138.7 6149.9 6086.9 6097.7 6175.9 6200.6 6216.7 4835.8 4864.3 4923.2 4935.3 4937.9 4361.2 4366.6 4371.7 4380.2 4402.0 5611.9 5612.1 5615.9 5616.6 5674.8 5237.3 6134.7 6161.9 6177.1 6256.2 5608.3 5650.5 5654.6 5669.1 5679.7 5140.5 5355.1 5357.4 5357.6 5400.1 6236.7 6258.9 6296.1 6300.4 6305.5 6060.6 6111.3 6128.2 6132.8 6144.8 6270.8 6277.5 6290.7 6296.8 6303.4 4855.8 5970.8 6001.4 6019.0 6065.1 6135.5 6178.3 6247.8 6258.2 6268.6 5883.9 5905.8 5921.6 5942.8 5981.3 4546.7 5870.3 5901.2 5954.8 5964.7 5897.3 5900.7 5942.3 5942.9 5990.3 6092.5 6106.8 6107.5 6108.4 6114.2 5749.8 5830.8 5833.8 5897.5 5940.1 02:55:41 INFO - PROCESS | 1654 | 02:55:41 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:49600.23 Median:35196.32 stddev:93375.47 (265.3%) stddev-sans-first:93564.63 02:55:41 INFO - PROCESS | 1654 | Values: 496.8 530.0 532.5 570.0 577.4 29051.4 35825.6 36764.1 36860.8 36877.0 39314.4 39888.6 40043.6 40119.8 40313.6 9389.0 9634.0 9641.2 9646.5 9647.8 9478.7 9605.6 9634.5 9641.5 9659.7 9561.8 9637.8 9639.3 9644.5 9645.0 9558.0 9614.9 9621.3 9625.8 9633.8 9391.2 9468.5 9486.9 9491.5 9513.6 30780.8 37754.2 37775.8 37875.4 37924.0 3187.9 3224.4 3226.7 3391.5 3560.9 26773.5 26862.2 27167.7 27180.3 27317.0 2728.2 2735.2 2753.5 2761.3 2840.5 349973.0 353200.0 353602.0 354335.0 354479.0 44137.0 51964.0 52055.0 52259.7 52469.7 51441.5 52596.9 52665.0 52694.0 52721.7 15370.9 15483.0 15608.6 15615.9 15616.1 11078.8 12177.9 12306.2 12394.6 12410.0 14000.6 14036.2 14078.2 14184.2 14218.4 5170.5 6015.5 6178.0 6191.5 6238.6 883.6 887.8 888.1 1058.4 1101.4 22640.8 23147.0 28137.6 28484.1 28531.6 1082.9 1139.2 1161.3 1166.3 1256.7 14294.4 14536.9 14717.8 14819.3 14897.0 359483.0 366836.0 369285.0 369759.0 465052.0 50910.0 51177.0 51292.5 51422.5 51522.5 1358.7 1363.9 1455.2 1460.5 1481.9 22784.5 22950.7 23441.6 23782.4 26555.7 47029.5 47154.8 47572.0 47643.8 47671.8 315730.0 316605.8 317062.4 317219.0 319046.0 15358.8 20944.7 21254.6 23744.5 24046.8 39015.2 40037.0 40831.0 41234.2 41329.6 32413.4 33861.8 34047.7 34645.5 34843.3 33732.5 34847.5 35074.6 35369.8 35720.8 34054.5 34375.0 34654.7 35018.5 35318.0 26535.0 30241.5 30821.0 30853.5 30856.0 23337.6 23464.1 23486.5 23780.8 23882.9 02:55:41 INFO - PROCESS | 1654 | 02:55:41 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:33919.94 Median:11092.75 stddev:102323.04 (922.4%) stddev-sans-first:102579.11 02:55:41 INFO - PROCESS | 1654 | Values: 394.3 394.9 399.5 399.6 411.2 11734.6 19413.0 19448.3 20091.5 20108.1 15409.8 17243.7 18471.1 19430.7 19621.4 5769.2 6076.0 6100.2 6104.0 6108.9 5709.7 6017.1 6069.9 6094.4 6094.7 3907.9 4137.4 5728.6 6056.8 6062.1 5972.3 5978.1 6033.2 6037.2 6037.8 5600.6 5766.1 5802.1 5812.5 5837.5 12996.4 13270.6 18901.5 24246.8 25136.0 2077.4 2158.6 2199.5 2280.1 2718.5 9160.6 9689.8 10089.3 10168.7 10216.8 1692.3 1737.7 1746.0 1759.7 1759.8 63966.7 106182.0 107609.0 109460.0 110909.9 11483.0 11498.7 11622.8 11788.1 12025.2 14804.8 14879.0 14913.3 14947.6 14954.3 7464.7 8209.7 8334.6 8519.8 8623.1 7035.4 8106.8 8306.1 8314.9 8427.0 4471.1 4558.7 4577.2 4633.0 4635.2 1702.8 1888.4 1900.1 1952.4 1961.7 747.5 898.0 902.5 991.5 1007.9 16550.4 18481.4 19610.7 19624.7 19752.0 937.4 979.0 1019.9 1021.4 1039.3 7777.8 10406.4 10684.9 10761.4 10766.3 587123.0 596653.0 622334.7 639645.0 639921.0 116739.0 117910.0 119002.5 121311.0 124232.0 982.9 1004.7 1018.8 1018.9 1020.2 17222.5 17660.8 17728.1 17743.6 17858.3 45613.3 47946.5 48529.5 48586.0 49107.8 63600.4 67854.7 67886.7 68544.7 72488.0 7785.5 7794.6 7929.6 8190.6 8270.1 12002.2 12157.9 12241.1 12470.1 12506.5 10058.2 10663.7 10697.9 10721.9 10732.7 8802.0 10368.8 10541.2 10636.7 10912.5 10525.3 11101.4 11159.7 11369.8 11541.5 8174.5 8331.9 8337.0 8413.8 8424.7 10136.7 10650.6 10768.6 11035.5 11325.8 02:55:41 INFO - PROCESS | 1654 | 02:55:41 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5585.81 Median:5246.57 stddev:3105.26 (59.2%) stddev-sans-first:3098.17 02:55:41 INFO - PROCESS | 1654 | Values: 1417.8 1578.1 1589.3 1864.0 2003.6 7813.4 8414.7 8665.0 8665.5 8665.6 8378.9 8594.3 8605.9 8612.0 8626.0 2378.2 2416.3 2418.2 2421.0 2423.8 2064.2 2351.7 2369.3 2417.2 2424.6 2389.8 2419.3 2432.1 2436.2 2441.0 2363.6 2375.6 2387.2 2389.1 2417.3 2366.6 2391.1 2394.1 2394.2 2395.7 8395.7 8556.0 8557.6 8644.4 8656.1 5089.4 5296.8 5299.1 5304.9 5335.1 3321.0 3394.5 3460.1 3478.1 3488.5 959.7 966.9 975.7 977.1 979.8 11497.9 11628.8 11634.1 11678.1 11713.9 4563.0 4613.7 4903.8 4907.7 4911.7 8964.6 8974.4 9055.9 9066.0 9066.5 5240.8 5242.7 5243.4 5249.7 5256.8 4101.1 4101.4 4381.6 4833.0 4899.5 3726.9 3762.8 3800.8 3825.1 3843.7 1028.3 1187.2 1210.1 1223.4 1232.7 667.5 725.3 792.4 802.9 980.7 5567.9 5723.2 5861.8 6000.9 6033.6 963.9 973.9 994.3 997.1 1005.0 3857.4 3963.5 4028.1 4047.3 4047.3 9742.8 10647.5 10694.3 10721.6 10746.9 10390.9 10415.2 10667.8 10684.0 10693.2 7937.0 8173.0 8228.1 8276.4 8277.0 5655.5 5838.9 5841.0 5852.8 5961.7 9556.7 9799.8 9871.5 9890.9 9964.9 9698.0 9731.0 9862.2 10056.8 10074.1 6787.0 6829.5 6918.7 6938.5 6942.3 7851.6 7903.2 7918.1 7926.7 8027.8 7161.9 7183.4 7243.2 7274.9 7341.5 6087.3 6813.3 7118.4 7271.6 7281.3 6769.1 6845.1 6846.7 6849.5 6853.3 4694.4 4890.0 4979.6 4983.0 5000.3 4908.6 4968.5 4999.8 5009.6 5163.4 02:55:41 INFO - PROCESS | 1654 | 02:55:41 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4695.51 Median:5319.66 stddev:1496.53 (28.1%) stddev-sans-first:1464.25 02:55:41 INFO - PROCESS | 1654 | Values: 319.7 320.7 328.1 329.7 332.0 4517.3 5200.9 5240.4 5249.7 5340.9 5274.9 5295.7 5304.4 5315.0 5328.3 3394.5 3715.6 3999.3 4051.7 4088.7 4006.6 4042.9 4046.4 4078.9 4112.2 3334.8 4027.6 4053.7 4056.9 4058.4 3828.6 3859.9 3893.2 4042.1 4051.3 3092.9 3520.0 3522.5 3539.5 3548.3 4634.7 4738.0 5063.5 5145.7 5152.6 3817.5 4288.7 4597.1 4615.3 4651.8 5550.4 5570.6 5599.7 5610.9 5616.9 3867.3 3870.7 3874.3 3884.7 3890.0 5223.8 5645.1 5801.4 5961.2 5967.2 3535.0 3861.8 3873.3 3903.3 3904.9 3487.8 3860.1 3955.5 3956.5 3965.3 3867.7 4430.7 4616.5 4618.1 4621.7 5324.3 5369.7 5668.9 5691.0 5709.3 1412.8 1440.3 1442.7 1443.6 1451.5 891.4 907.4 946.8 965.3 977.5 5597.1 5621.1 5644.3 5656.7 5692.4 5716.7 5979.8 6169.4 6258.8 6279.9 4835.8 5011.0 5333.6 5372.3 5642.9 2538.1 3071.1 3352.0 3361.3 3365.2 5912.5 6369.3 6609.2 6671.4 6723.3 5874.4 6196.4 6444.6 6568.3 6596.3 5864.5 6457.8 6615.8 6653.4 6687.3 5344.5 5888.8 6331.2 6338.2 6366.0 5252.7 5415.0 6008.8 6076.6 6140.0 5397.9 5755.5 5837.3 6073.5 6318.2 3485.4 3615.3 3731.9 3842.7 3877.8 5895.3 5896.3 5915.9 5918.3 5925.5 5329.9 5743.4 5746.3 5765.3 5805.7 4919.7 5258.6 5709.8 5733.4 5737.3 5267.7 5270.3 5470.6 5568.4 5631.0 5623.2 5647.3 5715.7 5732.3 5732.4 5567.9 5596.0 5596.3 5599.5 5626.8 02:55:41 INFO - PROCESS | 1654 | 02:55:41 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:17466.52 Median:31487.17 stddev:25021.17 (79.5%) stddev-sans-first:25059.55 02:55:41 INFO - PROCESS | 1654 | Values: 664.3 716.3 738.6 768.5 805.6 12785.0 12986.5 12996.7 13089.5 13438.3 14680.9 15352.4 15382.9 15409.5 15485.0 726.2 749.6 916.3 929.5 943.3 900.8 932.8 934.2 936.4 939.2 940.8 954.9 957.0 958.6 958.8 770.7 945.8 958.5 959.3 976.2 728.6 733.5 735.9 736.6 739.2 14553.9 14559.2 14563.0 14665.0 14715.0 11816.6 11916.2 12072.8 12134.2 12230.3 9867.4 9957.3 9995.8 10322.5 10414.7 3393.9 3443.1 3453.2 3467.6 3554.6 75970.6 76583.2 76754.6 77453.8 77591.0 9177.0 9239.3 9275.9 9497.0 9527.7 20417.4 20757.4 20823.6 20847.6 20865.4 7113.0 7287.9 7331.7 7428.5 7481.0 3828.6 3886.7 3894.8 3903.8 3978.4 3435.1 3498.6 3500.9 3503.0 3513.0 620.3 623.3 628.1 648.7 651.5 564.7 607.6 611.1 615.8 627.2 7879.6 8035.0 8214.7 8220.8 8274.2 574.2 587.4 601.0 605.0 609.5 3809.9 3836.6 3867.0 3876.1 4069.1 95887.5 96752.5 96939.0 96957.0 97303.0 75302.0 75419.0 75923.6 78247.6 79663.0 54867.0 69694.7 70816.0 71000.6 71112.0 7654.2 7710.5 7786.6 7858.3 7894.6 35806.5 41847.0 42275.0 42278.8 44138.6 57656.4 57711.1 59739.4 61294.1 62351.0 8629.8 10187.4 10187.9 10226.8 10420.7 9371.8 11119.3 11344.6 11454.9 11840.8 10373.4 10560.6 10681.6 10727.8 10858.2 10487.3 10499.2 10502.8 10550.8 10852.0 10083.6 10294.0 10486.9 10559.7 10594.2 8409.3 8592.5 8642.0 8643.1 8653.6 7116.8 8511.0 8695.6 8958.5 8983.9 02:55:41 INFO - PROCESS | 1654 | -------- Summary: end -------- 02:55:41 INFO - PROCESS | 1654 | 02:55:41 INFO - TEST-INFO | 1654: exit 0 02:55:41 INFO - TEST-OK | dromaeo_css | took 1114659ms 02:55:41 INFO - TEST-START | kraken 02:55:41 INFO - operating with platform_type : mac_ 02:55:41 INFO - Initialising browser for kraken test... 02:55:41 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmp2I4Ffh/profile http://localhost:49278/getInfo.html) 02:55:44 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 02:55:44 INFO - PROCESS | 1664 | colorDepth:24 02:55:44 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 02:55:44 INFO - PROCESS | 1664 | __metrics 02:55:44 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:55:44 ERROR - PROCESS | 1664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:55:44 INFO - TEST-INFO | 1664: exit 0 02:55:44 INFO - Browser initialized. 02:55:44 INFO - Running cycle 1/1 for kraken test... 02:55:44 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmp2I4Ffh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:55:56 INFO - PROCESS | 1666 | RSS: Main: 239198208 02:55:56 INFO - PROCESS | 1666 | 02:55:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 02:56:00 INFO - PROCESS | 1666 | RSS: Main: 286314496 02:56:00 INFO - PROCESS | 1666 | 02:56:03 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 02:56:03 INFO - PROCESS | 1666 | RSS: Main: 299507712 02:56:03 INFO - PROCESS | 1666 | 02:56:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 02:56:07 INFO - PROCESS | 1666 | RSS: Main: 389185536 02:56:07 INFO - PROCESS | 1666 | 02:56:09 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 02:56:10 INFO - PROCESS | 1666 | RSS: Main: 288808960 02:56:10 INFO - PROCESS | 1666 | 02:56:12 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:56:13 INFO - PROCESS | 1666 | RSS: Main: 294445056 02:56:13 INFO - PROCESS | 1666 | 02:56:15 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 02:56:16 INFO - PROCESS | 1666 | RSS: Main: 329666560 02:56:16 INFO - PROCESS | 1666 | 02:56:19 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 02:56:20 INFO - PROCESS | 1666 | RSS: Main: 331632640 02:56:20 INFO - PROCESS | 1666 | 02:56:22 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 02:56:23 INFO - PROCESS | 1666 | RSS: Main: 329609216 02:56:23 INFO - PROCESS | 1666 | 02:56:25 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:56:25 INFO - PROCESS | 1666 | RSS: Main: 321462272 02:56:25 INFO - PROCESS | 1666 | 02:56:27 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:56:28 INFO - PROCESS | 1666 | RSS: Main: 329326592 02:56:28 INFO - PROCESS | 1666 | 02:56:30 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:56:31 INFO - PROCESS | 1666 | RSS: Main: 329916416 02:56:31 INFO - PROCESS | 1666 | 02:56:33 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:56:34 INFO - PROCESS | 1666 | RSS: Main: 334790656 02:56:34 INFO - PROCESS | 1666 | 02:56:37 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:56:38 INFO - PROCESS | 1666 | RSS: Main: 332447744 02:56:38 INFO - PROCESS | 1666 | 02:56:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 02:56:40 INFO - PROCESS | 1666 | RSS: Main: 397950976 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - PROCESS | 1666 | __start_tp_report 02:56:40 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 02:56:40 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 02:56:40 INFO - PROCESS | 1666 | |i|pagename|runs| 02:56:40 INFO - PROCESS | 1666 | |0;ai-astar;113;113;107;112;113;115;111;112;104;113 02:56:40 INFO - PROCESS | 1666 | |1;audio-beat-detection;180;151;143;185;149;174;141;121;171;120 02:56:40 INFO - PROCESS | 1666 | |2;audio-dft;186;184;185;184;184;182;179;185;183;217 02:56:40 INFO - PROCESS | 1666 | |3;audio-fft;77;76;86;88;53;60;56;84;84;56 02:56:40 INFO - PROCESS | 1666 | |4;audio-oscillator;92;96;137;80;78;78;125;80;78;126 02:56:40 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;87;85;87;85;86;84;86;84;92;85 02:56:40 INFO - PROCESS | 1666 | |6;imaging-darkroom;142;106;94;94;93;94;94;94;92;95 02:56:40 INFO - PROCESS | 1666 | |7;imaging-desaturate;114;130;136;85;85;86;86;86;87;83 02:56:40 INFO - PROCESS | 1666 | |8;json-parse-financial;62;60;59;59;59;58;60;80;60;58 02:56:40 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;65;74;76;74;71;66;66;67;68;67 02:56:40 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;81;81;83;82;82;81;81;82;82;81 02:56:40 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;141;140;139;137;137;139;135;141;197;141 02:56:40 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;196;196;195;195;195;198;208;202;192;195 02:56:40 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;71;70;71;70;70;70;70;70;69;70 02:56:40 INFO - PROCESS | 1666 | __end_tp_report 02:56:40 INFO - PROCESS | 1666 | __start_cc_report 02:56:40 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1973 02:56:40 INFO - PROCESS | 1666 | __end_cc_report 02:56:40 INFO - PROCESS | 1666 | __startTimestamp1461837400216__endTimestamp 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - PROCESS | 1666 | ------- Summary: start ------- 02:56:40 INFO - PROCESS | 1666 | Number of tests: 14 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.30 (2.9%) stddev-sans-first:3.44 02:56:40 INFO - PROCESS | 1666 | Values: 113.0 113.0 107.0 112.0 113.0 115.0 111.0 112.0 104.0 113.0 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:161.00 stddev:23.32 (14.5%) stddev-sans-first:22.67 02:56:40 INFO - PROCESS | 1666 | Values: 180.0 151.0 143.0 185.0 149.0 174.0 141.0 121.0 171.0 120.0 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:186.90 Median:184.50 stddev:10.75 (5.8%) stddev-sans-first:11.40 02:56:40 INFO - PROCESS | 1666 | Values: 186.0 184.0 185.0 184.0 184.0 182.0 179.0 185.0 183.0 217.0 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:72.00 Median:80.50 stddev:14.13 (17.6%) stddev-sans-first:14.88 02:56:40 INFO - PROCESS | 1666 | Values: 77.0 76.0 86.0 88.0 53.0 60.0 56.0 84.0 84.0 56.0 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:79.00 stddev:23.36 (29.6%) stddev-sans-first:24.71 02:56:40 INFO - PROCESS | 1666 | Values: 92.0 96.0 137.0 80.0 78.0 78.0 125.0 80.0 78.0 126.0 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:86.00 stddev:2.33 (2.7%) stddev-sans-first:2.45 02:56:40 INFO - PROCESS | 1666 | Values: 87.0 85.0 87.0 85.0 86.0 84.0 86.0 84.0 92.0 85.0 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:99.80 Median:94.00 stddev:15.34 (16.3%) stddev-sans-first:4.17 02:56:40 INFO - PROCESS | 1666 | Values: 142.0 106.0 94.0 94.0 93.0 94.0 94.0 94.0 92.0 95.0 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:97.80 Median:85.50 stddev:20.65 (24.2%) stddev-sans-first:21.06 02:56:40 INFO - PROCESS | 1666 | Values: 114.0 130.0 136.0 85.0 85.0 86.0 86.0 86.0 87.0 83.0 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:60.00 stddev:6.60 (11.0%) stddev-sans-first:7.00 02:56:40 INFO - PROCESS | 1666 | Values: 62.0 60.0 59.0 59.0 59.0 58.0 60.0 80.0 60.0 58.0 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:4.01 (5.8%) stddev-sans-first:3.92 02:56:40 INFO - PROCESS | 1666 | Values: 65.0 74.0 76.0 74.0 71.0 66.0 66.0 67.0 68.0 67.0 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 02:56:40 INFO - PROCESS | 1666 | Values: 81.0 81.0 83.0 82.0 82.0 81.0 81.0 82.0 82.0 81.0 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:140.50 stddev:18.49 (13.2%) stddev-sans-first:19.56 02:56:40 INFO - PROCESS | 1666 | Values: 141.0 140.0 139.0 137.0 137.0 139.0 135.0 141.0 197.0 141.0 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.20 Median:196.00 stddev:4.59 (2.3%) stddev-sans-first:4.85 02:56:40 INFO - PROCESS | 1666 | Values: 196.0 196.0 195.0 195.0 195.0 198.0 208.0 202.0 192.0 195.0 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 02:56:40 INFO - PROCESS | 1666 | Values: 71.0 70.0 71.0 70.0 70.0 70.0 70.0 70.0 69.0 70.0 02:56:40 INFO - PROCESS | 1666 | -------- Summary: end -------- 02:56:40 INFO - PROCESS | 1666 | 02:56:40 INFO - TEST-INFO | 1666: exit 0 02:56:40 INFO - TEST-OK | kraken | took 59041ms 02:56:40 INFO - SUITE-END | took 1173s 02:56:41 INFO - Completed test suite (00:19:34) 02:56:41 INFO - javascript benchmark 02:56:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2747.4917140329035, 3422.982885085575, 3425.0409885232143, 3463.4458486642143, 3488.9476657850123, 5583.357913839899, 5604.467575580318, 5642.238297829792, 5645.435456454353, 5647.181158731982, 5627.493525582697, 5657.773689052433, 5735.627184233022, 5757.0, 5793.217915581396, 5063.0, 5080.872978175556, 5107.923381149267, 5114.1050316194705, 5138.177891537355, 5117.0, 5166.457521960197, 5180.6373553851245, 5182.2226666000215, 5235.6596821206695, 5007.7496125193775, 5074.4925507449325, 5098.719570423626, 5116.027954688616, 5147.382314122292, 5010.69935803853, 5029.572486338666, 5038.7984480620735, 5051.913838524698, 5054.7472626368535, 5059.4434612193, 5111.08000559899, 5115.2071428928575, 5117.948820511821, 5124.0, 5465.808696695636, 5472.50747432729, 5555.777768889239, 5590.413006634286, 5599.300087489064, 6100.877982440371, 6109.541784366146, 6128.172696685935, 6136.7852125175405, 6137.815865523997, 6154.753809847601, 6180.049631748377, 6190.5976111553055, 6224.751009959597, 6231.158793562857, 5622.971885140589, 5726.9713651431475, 5770.365259821417, 5825.300963884361, 5848.941510584925, 5296.894062118736, 6189.566730328924, 6198.659073750987, 6206.410391012847, 6211.720472578745, 5958.433948774859, 6084.543659225487, 6085.482733967662, 6086.6652334122045, 6087.1173679816175, 6109.799438327889, 6124.730495887588, 6193.659348735772, 6194.0708893665405, 6201.906971395432, 6073.99886523128, 6098.0, 6128.571000030044, 6138.664296166128, 6149.938500615026, 6086.908696369558, 6097.706879361915, 6175.876482470326, 6200.596961197598, 6216.720247588869, 4835.782389792468, 4864.270359446112, 4923.187674033744, 4935.333729946483, 4937.876553086202, 4361.214981303396, 4366.607005369532, 4371.715838470489, 4380.233459144637, 4402.0, 5611.915821262684, 5612.102063669793, 5615.887682246333, 5616.634918730269, 5674.77300907959, 5237.266782650432, 6134.723937422827, 6161.938380616137, 6177.135201071854, 6256.217972753406, 5608.298962629671, 5650.491455769001, 5654.6324488908085, 5669.121286200645, 5679.659220446786, 5140.485951404829, 5355.143177091647, 5357.357117145967, 5357.571394288448, 5400.0819860623005, 6236.688165591702, 6258.937410625836, 6296.087067375296, 6300.432961033529, 6305.527085468517, 6060.606060606046, 6111.287884814297, 6128.228138398679, 6132.78385080153, 6144.832481828438, 6270.843228919131, 6277.497800176066, 6290.716917738804, 6296.842578935563, 6303.432691057827, 4855.830045948375, 5970.758923011746, 6001.36985616504, 6018.969905150446, 6065.120557519223, 6135.508280839814, 6178.320384757583, 6247.781327653511, 6258.249010118633, 6268.623882567061, 5883.852903677443, 5905.763769449174, 5921.61509501881, 5942.7920022799, 5981.252343457068, 4546.659000574904, 5870.26621672291, 5901.232839730807, 5954.821355359346, 5964.731587078679, 5897.321807992136, 5900.734466949083, 5942.346341902301, 5942.851428714143, 5990.34106248321, 6092.45167934888, 6106.847328816815, 6107.480864126599, 6108.389161084034, 6114.2357205349335, 5749.798757043483, 5830.76676932918, 5833.7666493341485, 5897.469227769521, 5940.079287710412], "value": 5605.022712575499, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.78886473248883, 529.9629025968181, 532.5366930770231, 570.0281020859433, 577.4369989260472, 29051.418971620555, 35825.64174358256, 36764.080897977496, 36860.81569592155, 36876.99999999996, 39314.41028384576, 39888.60111398885, 40043.599564004355, 40119.79341136236, 40313.59686403135, 9389.0, 9633.95183024084, 9641.180499657537, 9646.469444180568, 9647.75880602987, 9478.66824661137, 9605.615775368977, 9634.47010414427, 9641.517924103802, 9659.710208693716, 9561.808763824754, 9637.807243855119, 9639.277054220927, 9644.517774111302, 9645.03549645037, 9557.996410376914, 9614.903850961471, 9621.278404119648, 9625.759356016086, 9633.759156021086, 9391.154796068387, 9468.479233642147, 9486.857697134548, 9491.477968711719, 9513.619455221851, 30780.8460957696, 37754.244915101546, 37775.8111209445, 37875.43186852199, 37924.0, 3187.8884239051754, 3224.4357237483346, 3226.7095961363357, 3391.491276308549, 3560.893173204808, 26773.464530709472, 26862.194134176007, 27167.728322716914, 27180.320491987663, 27317.043903463484, 2728.181545536351, 2735.2204621682727, 2753.5318995770567, 2761.282066662662, 2840.5313123334627, 349973.0, 353200.0, 353602.0, 354335.0, 354479.0, 44137.0, 51964.0, 52055.0, 52259.73870130701, 52469.7376513115, 51441.485585144415, 52596.948061038565, 52665.0, 52694.0, 52721.7363913178, 15370.923145384202, 15483.0, 15608.609784755472, 15615.921920390325, 15616.141112238709, 11078.778424431466, 12177.878221217852, 12306.200096993845, 12394.566190183301, 12410.0, 14000.579982600539, 14036.157830530201, 14078.225697586731, 14184.219867907364, 14218.431262749582, 5170.482951704799, 6015.488683461955, 6178.0, 6191.473724733448, 6238.563300568917, 883.5979629268668, 887.7647423432795, 888.0675290944482, 1058.4178701714027, 1101.4437708956925, 22640.773592264195, 23147.0, 28137.57793633097, 28484.145475635763, 28531.57202641962, 1082.8917108289265, 1139.174098778379, 1161.268400907423, 1166.3002198680892, 1256.7109564800148, 14294.428222870969, 14536.927315363355, 14717.779233311509, 14819.333130009176, 14897.0, 359483.0, 366836.0, 369285.0, 369759.0, 465052.0, 50910.0, 51177.0, 51292.48707512952, 51422.48577514177, 51522.484775152516, 1358.6671265540006, 1363.9318034098058, 1455.1560095144791, 1460.4815290571908, 1481.9184944828137, 22784.544309114055, 22950.655740164246, 23441.648375274042, 23782.405439864142, 26555.672216388717, 47029.529704703884, 47154.764226178646, 47572.0, 47643.76178119087, 47671.76164119157, 315730.0, 316605.8339416669, 317062.41468793433, 317219.0, 319046.0, 15358.769618455955, 20944.68582971287, 21254.574908502054, 23744.52510949806, 24046.797660117274, 39015.21969560536, 40037.0, 40831.0, 41234.175316494104, 41329.58670413258, 32413.35173296568, 33861.830690846386, 34047.65952340445, 34645.48031779475, 34843.30313393768, 33732.49401259032, 34847.47728784121, 35074.64925350714, 35369.82315088408, 35720.821395893894, 34054.48918266278, 34375.0, 34654.653453465144, 35018.474722878665, 35318.0, 26535.0, 30241.546376803926, 30821.0, 30853.537196942514, 30856.0, 23337.619078349788, 23464.066313011077, 23486.530269394858, 23780.76219237855, 23882.880585596962], "value": 17721.48303920832, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.3296396126585, 394.88153553933813, 399.5145897734256, 399.59840360437755, 411.2084237842153, 11734.643176559108, 19413.0, 19448.319308824193, 20091.497712557193, 20108.09513571889, 15409.768853467207, 17243.74134387985, 18471.076446177703, 19430.708539371884, 19621.411357659257, 5769.16347129666, 6076.0, 6100.23747031621, 6104.0, 6108.908366374508, 5709.71451427429, 6017.097435384683, 6069.878602427949, 6094.390560943914, 6094.664793436359, 3907.882763517099, 4137.358709400048, 5728.598998070137, 6056.818295451144, 6062.120992456091, 5972.313183983854, 5978.133170690226, 6033.245844269466, 6037.154798328237, 6037.849053773669, 5600.635958662715, 5766.0774276116035, 5802.071668533056, 5812.534997200214, 5837.532997360201, 12996.415161317764, 13270.601881943558, 18901.527461813428, 24246.757532424803, 25136.0, 2077.4079387374527, 2158.5790770799545, 2199.516106456577, 2280.144945645383, 2718.5378485657484, 9160.587773550205, 9689.806203875884, 10089.344192627455, 10168.745781355452, 10216.846747298796, 1692.306154476671, 1737.7132773092424, 1746.0, 1759.7096479080935, 1759.8416142547105, 63966.68016659933, 106182.0, 107609.0, 109460.0, 110909.89090109077, 11483.0, 11498.712532186762, 11622.825657615143, 11788.115891308014, 12025.158238923192, 14804.777928331083, 14879.03286286388, 14913.3289001993, 14947.626309342137, 14954.327055282538, 7464.664090115849, 8209.71266005687, 8334.62494187763, 8519.829603408021, 8623.137686231452, 7035.437165026786, 8106.837863242702, 8306.127856575093, 8314.875276870851, 8427.030891447439, 4471.105778844244, 4558.680892337505, 4577.176108300471, 4632.953670463319, 4635.215442054833, 1702.7956645202407, 1888.3579582941866, 1900.097453709477, 1952.4435535872492, 1961.7253584498183, 747.4580928826557, 897.9730608081768, 902.4720538484928, 991.5141580625586, 1007.9244056695777, 16550.42073527445, 18481.353152639593, 19610.72530285527, 19624.70562941557, 19752.0, 937.3625934364561, 979.0356498848629, 1019.8929112443235, 1021.4177918586483, 1039.3192458939407, 7777.805554861174, 10406.375290798307, 10684.946575267073, 10761.408122553335, 10766.30019048775, 587123.0, 596653.0, 622334.666746272, 639645.0, 639921.0, 116739.0, 117910.0, 119002.53407027597, 121311.0, 124232.0, 982.9262805289632, 1004.7036124343336, 1018.8166130096654, 1018.9337693049928, 1020.1583693452931, 17222.483325500256, 17660.823391765916, 17728.13925402475, 17743.645127097127, 17858.285668573113, 45613.315800263685, 47946.5205347942, 48529.514704853915, 48586.0, 49107.75446122889, 63600.409989748776, 67854.66072669605, 67886.66056669685, 68544.6572767133, 72488.0, 7785.493942893694, 7794.649240784292, 7929.643166057426, 8190.590470476572, 8270.090290067967, 12002.21985570935, 12157.878421215675, 12241.0819188563, 12470.127091103535, 12506.499740010662, 10058.245631577514, 10663.733406664895, 10697.946510267398, 10721.946390267998, 10732.73168170802, 8802.0, 10368.844467333147, 10541.209409294486, 10636.680899573024, 10912.508937097691, 10525.263231573716, 11101.389423581457, 11159.665210043711, 11369.829452558384, 11541.538338466367, 8174.509529428254, 8331.875021874797, 8337.0, 8413.831723365622, 8424.725324162564, 10136.695899122744, 10650.57397704083, 10768.62309819184, 11035.455036295085, 11325.773484530428], "value": 9198.57803401702, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.7802440621708, 1578.0531680991403, 1589.300707688617, 1863.9906800465997, 2003.6393449179152, 7813.4139939504485, 8414.663413463462, 8665.0, 8665.480071195732, 8665.566721663907, 8378.874316885252, 8594.269487093605, 8605.91394086059, 8611.956940215307, 8626.0, 2378.15575470708, 2416.3355077353694, 2418.22616762636, 2420.9831870614385, 2423.8424502407374, 2064.2362325939425, 2351.729551101628, 2369.2536850891915, 2417.2385698505004, 2424.636304554322, 2389.844660097097, 2419.3104965084954, 2432.0636554926305, 2436.2082323244927, 2441.011390386896, 2363.645453182019, 2375.6317770745477, 2387.164492427645, 2389.1399096325395, 2417.347316224627, 2366.6450032495263, 2391.1033362489065, 2394.1381102802975, 2394.2099107294553, 2395.652630368604, 8395.664173433055, 8555.973283205993, 8557.614907329124, 8644.394892357537, 8656.09111043344, 5089.389273287229, 5296.788128474856, 5299.125644268691, 5304.92042619361, 5335.146376579767, 3321.0, 3394.4908263760385, 3460.1003739027783, 3478.095695119262, 3488.494168345576, 959.6785076999214, 966.8888077870994, 975.7121649113528, 977.1226075157931, 979.8187335342913, 11497.942510287396, 11628.825567616492, 11634.127440442, 11678.065754739686, 11713.945744882916, 4562.9771851141195, 4613.700109492872, 4903.803847846118, 4907.730074845917, 4911.705297682079, 8964.551772411354, 8974.371793974358, 9055.864162037575, 9065.954670226607, 9066.50134242623, 5240.764165612557, 5242.7378631068295, 5243.397009343898, 5249.737513124329, 5256.816011439658, 4101.118259574206, 4101.425800387889, 4381.605655491021, 4833.0, 4899.485554016848, 3726.888193354204, 3762.830672619739, 3800.771953682788, 3825.101101241206, 3843.673287770571, 1028.3315844701003, 1187.1689817128045, 1210.116614871149, 1223.3944197622234, 1232.6979889927024, 667.4693618573245, 725.3073314984283, 792.3502727763295, 802.8996375453069, 980.6959842448864, 5567.916481252784, 5723.170140329629, 5861.794837180763, 6000.939990600125, 6033.607815491979, 963.9469829159464, 973.9415635061919, 994.2543092680489, 997.1474389397106, 1005.0201053972319, 3857.40210267409, 3963.504561929759, 4028.113814960704, 4047.2714911316248, 4047.3119569673227, 9742.75643108928, 10647.520861561248, 10694.304870183412, 10721.571137154582, 10746.892531074589, 10390.896091039143, 10415.16678665705, 10667.786644267226, 10684.0, 10693.19801014927, 7937.0, 8172.959135204404, 8228.136045715233, 8276.379271554657, 8277.04813946392, 5655.547556195576, 5838.912416313674, 5841.0, 5852.824415267549, 5961.731722072431, 9556.665516706882, 9799.804003919739, 9871.50642467888, 9890.901090988998, 9964.900350996688, 9698.0, 9730.95134524323, 9862.161716254199, 10056.849147262943, 10074.14369778577, 6787.0, 6829.521933464808, 6918.654067296716, 6938.479614029069, 6942.340477654615, 7851.646675899484, 7903.209679032051, 7918.129005809472, 7926.722564710208, 8027.759167224993, 7161.928380716126, 7183.425325973805, 7243.20324764286, 7274.945132955798, 7341.522801017917, 6087.269527656709, 6813.250542440229, 7118.359347658736, 7271.563706177435, 7281.2718728126765, 6769.052332673331, 6845.0759147514445, 6846.657667116724, 6849.520533562602, 6853.348931851466, 4694.366260554782, 4890.046440943982, 4979.626528010342, 4982.950170498394, 5000.324956130876, 4908.63185261114, 4968.527989840959, 4999.750012499433, 5009.624278179224, 5163.432022477599], "value": 4497.678015868055, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.7489970373256, 320.7097576693093, 328.1369996908131, 329.6736231131181, 332.0304710246081, 4517.299818528133, 5200.921986170206, 5240.397354304256, 5249.711265880375, 5340.91988620171, 5274.868128296795, 5295.655782374152, 5304.443033481487, 5315.0432922074015, 5328.280682107914, 3394.524766532675, 3715.6098609645937, 3999.340108882031, 4051.6961227907877, 4088.693347998897, 4006.61937115975, 4042.9191416171657, 4046.433499310099, 4078.938815917764, 4112.218678451085, 3334.7665663403573, 4027.5972402759635, 4053.736507127042, 4056.8580099696514, 4058.4115303281005, 3828.559715632682, 3859.9421008684894, 3893.1824316893626, 4042.130941847517, 4051.331530297527, 3092.9381412371627, 3519.964800351989, 3522.489239060322, 3539.50446937429, 3548.30807992439, 4634.721916684976, 4738.0337160078525, 5063.518965698253, 5145.716985565792, 5152.562032227265, 3817.48463957365, 4288.678349123797, 4597.103564804865, 4615.330777037344, 4651.767411629405, 5550.389457159709, 5570.554355651539, 5599.720013999284, 5610.887782244373, 5616.9157462638095, 3867.3038853006447, 3870.651641352292, 3874.302625527404, 3884.6698030667426, 3889.9611003890163, 5223.764930578133, 5645.052456902362, 5801.361850196475, 5961.195238642771, 5967.224260846106, 3534.964650353515, 3861.8069096545623, 3873.283442563135, 3903.316919539069, 3904.90237744053, 3487.75585709003, 3860.0542866997203, 3955.499383046025, 3956.485656864647, 3965.2862484753023, 3867.7485963412287, 4430.667699922518, 4616.492185859553, 4618.099470603267, 4621.653375996813, 5324.281222035053, 5369.677819330853, 5668.858278543069, 5691.0, 5709.3434255060365, 1412.81633387661, 1440.2654646130338, 1442.6826098258366, 1443.5813614052017, 1451.528253317676, 891.3760367742606, 907.4029707714338, 946.7822400847843, 965.3194497878978, 977.4965892565334, 5597.132444471114, 5621.072523033736, 5644.322681278273, 5656.717164141776, 5692.402297758676, 5716.657000579979, 5979.820605381846, 6169.352218017044, 6258.780942666985, 6279.905801412982, 4835.830745923876, 5010.995601759326, 5333.57331413486, 5372.274742909657, 5642.887142257132, 2538.0609174605515, 3071.1093782802736, 3351.966480335165, 3361.2941282330494, 3365.192353835062, 5912.526997840162, 6369.331220221903, 6609.206895172514, 6671.39957403836, 6723.294054124344, 5874.412558744091, 6196.411340922605, 6444.645544495004, 6568.310327415648, 6596.340365963461, 5864.530837533072, 6457.773977910939, 6615.834604134935, 6653.434458071021, 6687.29164688302, 5344.518993290622, 5888.823335299948, 6331.2085989251345, 6338.176037115146, 6366.0, 5252.711100889488, 5414.972925135507, 6008.789692360747, 6076.635401875901, 6139.986902161093, 5397.920415916754, 5755.53955683536, 5837.270341207349, 6073.540216212441, 6318.199313195717, 3485.424904890766, 3615.313090512794, 3731.92877952728, 3842.7310088293552, 3877.8061096945603, 5895.29256489224, 5896.262967129109, 5915.911261330997, 5918.348981611933, 5925.496332811759, 5329.866753331198, 5743.396943320891, 5746.310442746897, 5765.347939947504, 5805.680687562056, 4919.696280485746, 5258.553022992935, 5709.800156994485, 5733.39799321082, 5737.254156959569, 5267.657602255841, 5270.288511050959, 5470.589705772162, 5568.387477377404, 5630.95827271956, 5623.2408624835125, 5647.322321321468, 5715.657060576379, 5732.3121225453215, 5732.398098199629, 5567.916481252865, 5595.972020139873, 5596.272484576979, 5599.468050535193, 5626.774929002794], "value": 4228.11652628297, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.292528457193, 716.2694052066892, 738.5900825042099, 768.4620765464176, 805.5851236613141, 12785.041121915847, 12986.54547090852, 12996.740065198703, 13089.541866034691, 13438.328083595818, 14680.926595367035, 15352.385904563833, 15382.923085384557, 15409.537713868574, 15485.0, 726.1685370251059, 749.5952185819651, 916.2624087609488, 929.530587053537, 943.2878176976374, 900.7703035725881, 932.7528205025674, 934.1685899549373, 936.4287784451479, 939.2063706168277, 940.7836197674538, 954.885413750351, 956.9521523923811, 958.5590628310986, 958.8034452937165, 770.7071312901062, 945.7919257763281, 958.4919992404002, 959.3236768078488, 976.1556253840376, 728.5992704012772, 733.4938892164389, 735.9153697324823, 736.628002858553, 739.2238149942539, 14553.927230363886, 14559.199244041574, 14563.0, 14665.0, 14715.0, 11816.645500634995, 11916.225445346025, 12072.783477575953, 12134.211276267015, 12230.327331996737, 9867.40795552269, 9957.253206009505, 9995.750106247402, 10322.483875806254, 10414.739631509197, 3393.915152121192, 3443.1220038890174, 3453.240287136851, 3467.6358982306747, 3554.626764189749, 75970.62014689947, 76583.23416765817, 76754.61622691852, 77453.83819242715, 77591.0, 9176.95411522938, 9239.260859131253, 9275.90724092764, 9497.0, 9527.714168574954, 20417.387478375673, 20757.377278681663, 20823.58352832965, 20847.583048339253, 20865.37403877886, 7113.039739635186, 7287.890681639779, 7331.74338898136, 7428.480006399608, 7481.0, 3828.5979972102527, 3886.689064874803, 3894.824732887027, 3903.843846246175, 3978.4430179774854, 3435.1068722131927, 3498.6151523332414, 3500.9124771880906, 3503.0, 3512.964870351315, 620.3176505843536, 623.3423737956499, 628.1457218183358, 648.678903942542, 651.5081113759081, 564.6809552602848, 607.6080927801631, 611.1382950040422, 615.7690865925279, 627.157709390547, 7879.606019699107, 8034.959825200836, 8214.671413143407, 8220.753377398687, 8274.213949674771, 574.2104606166521, 587.4198406287074, 601.0323379359228, 605.0052241405062, 609.5489337889929, 3809.8666546670734, 3836.558795738526, 3867.013911452618, 3876.1084950460986, 4069.084455997436, 95887.52056239675, 96752.51623741836, 96939.0, 96957.0, 97303.02696973081, 75302.0, 75419.0, 75923.62038189884, 78247.60876195582, 79663.0, 54867.0, 69694.65152674305, 70816.0, 71000.64499677469, 71112.0, 7654.15804261542, 7710.4602677814255, 7786.649600768093, 7858.292753652198, 7894.605269736605, 35806.462903057, 41847.0, 42275.0, 42278.788606056776, 44138.55861441473, 57656.42343576511, 57711.1343329842, 59739.40260597512, 61294.080588792094, 62351.0, 8629.784255393413, 10187.388756674623, 10187.949060254652, 10226.846597300897, 10420.739481513023, 9371.81256374855, 11119.27724697892, 11344.602938897098, 11454.94272528632, 11840.822387664364, 10373.377597344184, 10560.577576896838, 10681.626143084955, 10727.839082413613, 10858.185636077167, 10487.26589138753, 10499.212559058255, 10502.82653972014, 10550.788984220426, 10852.023317901427, 10083.596656133672, 10294.0, 10486.947565262124, 10559.683209503728, 10594.205434592282, 8409.327253819558, 8592.49376471684, 8641.95679021626, 8643.092475290005, 8653.61058752345, 7116.822079448055, 8510.957445212734, 8695.608697608497, 8958.462492250486, 8983.865242021506], "value": 6664.013584072878, "unit": "score"}], "name": "dromaeo_css", "value": 6981.546263140098, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 107.0, 112.0, 113.0, 115.0, 111.0, 112.0, 104.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 151.0, 143.0, 185.0, 149.0, 174.0, 141.0, 121.0, 171.0, 120.0], "value": 153.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 185.0, 184.0, 184.0, 182.0, 179.0, 185.0, 183.0, 217.0], "value": 186.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 86.0, 88.0, 53.0, 60.0, 56.0, 84.0, 84.0, 56.0], "value": 72.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 96.0, 137.0, 80.0, 78.0, 78.0, 125.0, 80.0, 78.0, 126.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 86.0, 84.0, 86.0, 84.0, 92.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 106.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 92.0, 95.0], "value": 99.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 130.0, 136.0, 85.0, 85.0, 86.0, 86.0, 86.0, 87.0, 83.0], "value": 97.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 59.0, 59.0, 59.0, 58.0, 60.0, 80.0, 60.0, 58.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 76.0, 74.0, 71.0, 66.0, 66.0, 67.0, 68.0, 67.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 83.0, 82.0, 82.0, 81.0, 81.0, 82.0, 82.0, 81.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 139.0, 137.0, 137.0, 139.0, 135.0, 141.0, 197.0, 141.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 196.0, 195.0, 195.0, 195.0, 198.0, 208.0, 202.0, 192.0, 195.0], "value": 197.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 71.0, 70.0, 70.0, 70.0, 70.0, 70.0, 69.0, 70.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1528.8999999999999, "alertThreshold": 2.0}]} 02:56:41 INFO - Return code: 0 02:56:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:56:41 ERROR - # TBPL SUCCESS # 02:56:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:56:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:56:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:56:41 INFO - 2016-04-28 02:56:41.548 screenresolution[1670:9699] starting screenresolution argv=screenresolution get 02:56:41 INFO - 2016-04-28 02:56:41.551 screenresolution[1670:9699] Display 0: 1600x1200x32@60 02:56:41 INFO - 2016-04-28 02:56:41.557 screenresolution[1671:9702] starting screenresolution argv=screenresolution list 02:56:41 INFO - Available Modes on Display 0 02:56:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:56:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:56:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:56:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:56:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:56:41 INFO - Intel Iris: 02:56:41 INFO - Chipset Model: Intel Iris 02:56:41 INFO - Type: GPU 02:56:41 INFO - Bus: Built-In 02:56:41 INFO - VRAM (Dynamic, Max): 1536 MB 02:56:41 INFO - Vendor: Intel (0x8086) 02:56:41 INFO - Device ID: 0x0a2e 02:56:41 INFO - Revision ID: 0x0009 02:56:41 INFO - Displays: 02:56:41 INFO - Display: 02:56:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:56:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:56:41 INFO - Display Serial Number: 1600x1200 60 02:56:41 INFO - Main Display: Yes 02:56:41 INFO - Mirror: Off 02:56:41 INFO - Online: Yes 02:56:41 INFO - Rotation: Supported 02:56:41 INFO - Return code: 0 02:56:41 INFO - Running post-action listener: _resource_record_post_action 02:56:41 INFO - Running post-run listener: _resource_record_post_run 02:56:42 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37545472; Write bytes: 694352896; Read time: 393; Write time: 1818 02:56:42 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 391336448; Write bytes: 385419264; Read time: 29778; Write time: 677 02:56:42 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35706368; Write bytes: 295384064; Read time: 371; Write time: 1107 02:56:42 INFO - Running post-run listener: _upload_blobber_files 02:56:42 INFO - Blob upload gear active. 02:56:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:56:42 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 02:56:42 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:56:42 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:56:43 INFO - (blobuploader) - INFO - Open directory for files ... 02:56:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:56:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:56:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:44 INFO - (blobuploader) - INFO - Done attempting. 02:56:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:56:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:56:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:45 INFO - (blobuploader) - INFO - Done attempting. 02:56:45 INFO - (blobuploader) - INFO - Iteration through files over. 02:56:45 INFO - Return code: 0 02:56:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:56:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:56:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8966e0fd0e4ad2951f1c079c0c2f10c50772cd8147a55bb8d465ced8f805eee5d155e64ec096296bf99bc2e288cc1d98df1ea1be8a4bffdd8f1b21420456ecb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78ccc8070670fade789a6d55280094042cdd3b855facf6b9c9233cc5f6dd1e09cc19c38d551b85d5aab37d8a179084d57039aa1510ab32432d0c50a21c53a4bb"} 02:56:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:56:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:56:45 INFO - Contents: 02:56:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8966e0fd0e4ad2951f1c079c0c2f10c50772cd8147a55bb8d465ced8f805eee5d155e64ec096296bf99bc2e288cc1d98df1ea1be8a4bffdd8f1b21420456ecb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78ccc8070670fade789a6d55280094042cdd3b855facf6b9c9233cc5f6dd1e09cc19c38d551b85d5aab37d8a179084d57039aa1510ab32432d0c50a21c53a4bb"} 02:56:45 INFO - Running post-run listener: copy_logs_to_upload_dir 02:56:45 INFO - Copying logs to upload dir... 02:56:45 INFO - mkdir: /builds/slave/test/build/upload/logs 02:56:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.534039 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-28 02:56:45.081268) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 02:56:45.084557) ========= 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.6Ns0W3VikQ/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.o6h1BlX4P0/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8966e0fd0e4ad2951f1c079c0c2f10c50772cd8147a55bb8d465ced8f805eee5d155e64ec096296bf99bc2e288cc1d98df1ea1be8a4bffdd8f1b21420456ecb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78ccc8070670fade789a6d55280094042cdd3b855facf6b9c9233cc5f6dd1e09cc19c38d551b85d5aab37d8a179084d57039aa1510ab32432d0c50a21c53a4bb"} build_url:https://queue.taskcluster.net/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011061 build_url: 'https://queue.taskcluster.net/v1/task/cmdk7IwzSvWvUgSOS4PyZQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8966e0fd0e4ad2951f1c079c0c2f10c50772cd8147a55bb8d465ced8f805eee5d155e64ec096296bf99bc2e288cc1d98df1ea1be8a4bffdd8f1b21420456ecb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78ccc8070670fade789a6d55280094042cdd3b855facf6b9c9233cc5f6dd1e09cc19c38d551b85d5aab37d8a179084d57039aa1510ab32432d0c50a21c53a4bb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 02:56:45.118596) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 02:56:45.118927) ========= 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.6Ns0W3VikQ/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.o6h1BlX4P0/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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.005028 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 02:56:45.188854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 02:56:45.189193) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 02:56:45.189581) ========= ========= Total master_lag: 0.27 =========