builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0209 starttime: 1469110697.49 results: success (0) buildid: 20160721051621 builduid: bf131c21c7b14185b0b77d876625dce3 revision: 512d3ff7151c16f30ea8f93414d048c708815110 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:17.488134) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:17.488667) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:17.489009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:17.832445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:17.833235) ========= 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.uNTWNXvBWg/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.Io5tlUbbsj/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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-07-21 07:18:17-- 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% 36.8M=0s 2016-07-21 07:18:17 (36.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136983 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:17.998906) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:18.000010) ========= 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.uNTWNXvBWg/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.Io5tlUbbsj/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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.026031 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:18.054329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-07-21 07:18:18.055147) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 512d3ff7151c16f30ea8f93414d048c708815110 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 512d3ff7151c16f30ea8f93414d048c708815110 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uNTWNXvBWg/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.Io5tlUbbsj/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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-07-21 07:18:18,137 truncating revision to first 12 chars 2016-07-21 07:18:18,137 Setting DEBUG logging. 2016-07-21 07:18:18,137 attempt 1/10 2016-07-21 07:18:18,137 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/512d3ff7151c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 07:18:20,298 unpacking tar archive at: mozilla-beta-512d3ff7151c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.430250 ========= master_lag: 1.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-07-21 07:18:21.700373) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:21.700750) ========= script_repo_revision: 512d3ff7151c16f30ea8f93414d048c708815110 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:21.701247) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:21.701592) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 07:18:21.721179) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-21 07:18:21.721501) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uNTWNXvBWg/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.Io5tlUbbsj/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 07:18:21 INFO - MultiFileLogger online at 20160721 07:18:21 in /builds/slave/test 07:18:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 07:18:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:18:21 INFO - {'append_to_log': False, 07:18:21 INFO - 'base_work_dir': '/builds/slave/test', 07:18:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:18:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:18:21 INFO - 'branch': 'Mozilla-Beta', 07:18:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:18:21 INFO - 'config_files': ('talos/mac_config.py',), 07:18:21 INFO - 'default_actions': ('clobber', 07:18:21 INFO - 'read-buildbot-config', 07:18:21 INFO - 'download-and-extract', 07:18:21 INFO - 'populate-webroot', 07:18:21 INFO - 'create-virtualenv', 07:18:21 INFO - 'install', 07:18:21 INFO - 'run-tests'), 07:18:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:18:21 INFO - 'download_minidump_stackwalk': True, 07:18:21 INFO - 'download_symbols': 'ondemand', 07:18:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:18:21 INFO - 'tooltool.py': '/tools/tooltool.py', 07:18:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:18:21 INFO - '/tools/misc-python/virtualenv.py')}, 07:18:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:18:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:18:21 INFO - 'installer_path': 'installer.exe', 07:18:21 INFO - 'log_level': 'info', 07:18:21 INFO - 'log_name': 'talos', 07:18:21 INFO - 'log_to_console': True, 07:18:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:18:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:18:21 INFO - 'opt_config_files': (), 07:18:21 INFO - 'pip_index': False, 07:18:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:18:21 INFO - 'cmd': ('bash', 07:18:21 INFO - '-c', 07:18:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:18:21 INFO - 'enabled': True, 07:18:21 INFO - 'halt_on_failure': False, 07:18:21 INFO - 'name': 'check_screen_resolution'},), 07:18:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:18:21 INFO - 'cmd': ('bash', 07:18:21 INFO - '-c', 07:18:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:18:21 INFO - 'enabled': True, 07:18:21 INFO - 'halt_on_failure': False, 07:18:21 INFO - 'name': 'check_screen_resolution'},), 07:18:21 INFO - 'run_cmd_checks_enabled': True, 07:18:21 INFO - 'sps_profile': False, 07:18:21 INFO - 'sps_profile_interval': 0, 07:18:21 INFO - 'suite': 'dromaeojs-e10s', 07:18:21 INFO - 'system_bits': '32', 07:18:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:18:21 INFO - 'title': 't-yosemite-r7-0209', 07:18:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:18:21 INFO - 'use_talos_json': True, 07:18:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:18:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:18:21 INFO - 'work_dir': 'build'} 07:18:21 INFO - ##### 07:18:21 INFO - ##### Running clobber step. 07:18:21 INFO - ##### 07:18:21 INFO - Running pre-action listener: _resource_record_pre_action 07:18:21 INFO - Running main action method: clobber 07:18:21 INFO - rmtree: /builds/slave/test/build 07:18:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:18:23 INFO - Running post-action listener: _resource_record_post_action 07:18:23 INFO - ##### 07:18:23 INFO - ##### Running read-buildbot-config step. 07:18:23 INFO - ##### 07:18:23 INFO - Running pre-action listener: _resource_record_pre_action 07:18:23 INFO - Running main action method: read_buildbot_config 07:18:23 INFO - Using buildbot properties: 07:18:23 INFO - { 07:18:23 INFO - "project": "", 07:18:23 INFO - "product": "firefox", 07:18:23 INFO - "script_repo_revision": "production", 07:18:23 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 07:18:23 INFO - "repository": "", 07:18:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 07:18:23 INFO - "buildid": "20160721051621", 07:18:23 INFO - "pgo_build": "False", 07:18:23 INFO - "basedir": "/builds/slave/test", 07:18:23 INFO - "buildnumber": 36, 07:18:23 INFO - "slavename": "t-yosemite-r7-0209", 07:18:23 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 07:18:23 INFO - "platform": "yosemite_r7", 07:18:23 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:18:23 INFO - "branch": "mozilla-beta", 07:18:23 INFO - "repo_path": "releases/mozilla-beta", 07:18:23 INFO - "revision": "512d3ff7151c16f30ea8f93414d048c708815110", 07:18:23 INFO - "stage_platform": "macosx64", 07:18:23 INFO - "builduid": "bf131c21c7b14185b0b77d876625dce3", 07:18:23 INFO - "slavebuilddir": "test" 07:18:23 INFO - } 07:18:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 07:18:23 INFO - Running post-action listener: _resource_record_post_action 07:18:23 INFO - ##### 07:18:23 INFO - ##### Running download-and-extract step. 07:18:23 INFO - ##### 07:18:23 INFO - Running pre-action listener: _resource_record_pre_action 07:18:23 INFO - Running main action method: download_and_extract 07:18:23 INFO - mkdir: /builds/slave/test/build/tests 07:18: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')]} 07:18:23 INFO - https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:18:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 07:18:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 07:18:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 07:18:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 07:18:25 INFO - Downloaded 1165 bytes. 07:18:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 07:18:25 INFO - Using the following test package requirements: 07:18:25 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 07:18:25 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:18:25 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 07:18:25 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:18:25 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 07:18:25 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:18:25 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:18:25 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 07:18:25 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 07:18:25 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:18:25 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 07:18:25 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:18:25 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 07:18:25 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:18:25 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 07:18:25 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:18:25 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 07:18:25 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 07:18:25 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')]} 07:18:25 INFO - https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:18:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:18:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:18:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 07:18:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 07:18:26 INFO - Downloaded 18314783 bytes. 07:18:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:18:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:18:29 INFO - Return code: 0 07:18:29 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:29 INFO - https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:18:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:18:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:18:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 07:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 07:18:30 INFO - Downloaded 18314783 bytes. 07:18:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:18:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:18:34 INFO - Return code: 0 07:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:34 INFO - https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:18:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 07:18:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 07:18:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 07:18:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 07:18:35 INFO - Downloaded 10840145 bytes. 07:18:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:18:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:18:35 INFO - Return code: 0 07:18:35 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')]} 07:18:35 INFO - https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 07:18:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:18:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:18:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 07:18:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 07:18:38 INFO - Downloaded 86192072 bytes. 07:18:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:18:38 INFO - mkdir: /builds/slave/test/properties 07:18:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:18:38 INFO - Writing to file /builds/slave/test/properties/build_url 07:18:38 INFO - Contents: 07:18:38 INFO - build_url:https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:18:39 INFO - Running post-action listener: _resource_record_post_action 07:18:39 INFO - Running post-action listener: set_extra_try_arguments 07:18:39 INFO - ##### 07:18:39 INFO - ##### Running populate-webroot step. 07:18:39 INFO - ##### 07:18:39 INFO - Running pre-action listener: _resource_record_pre_action 07:18:39 INFO - Running main action method: populate_webroot 07:18:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:18:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:18:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:18:39 INFO - '--tppagecycles', 07:18:39 INFO - '7'], 07:18:39 INFO - 'tests': ['tsvgm']}}, 07:18:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:18:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:18:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:18:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:18:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:18:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:18:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:39 INFO - 'talos_options': ['--disable-e10s'], 07:18:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:39 INFO - 'talos_options': ['--disable-e10s'], 07:18:39 INFO - 'tests': ['damp', 'tps']}, 07:18:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:39 INFO - 'tests': ['damp', 'tps']}, 07:18:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:18:39 INFO - 'tests': ['dromaeo_dom']}, 07:18:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:18:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:18:39 INFO - 'tests': ['a11yr', 07:18:39 INFO - 'ts_paint', 07:18:39 INFO - 'tpaint', 07:18:39 INFO - 'sessionrestore', 07:18:39 INFO - 'sessionrestore_no_auto_restore', 07:18:39 INFO - 'tabpaint']}, 07:18:39 INFO - 'other-e10s': {'tests': ['a11yr', 07:18:39 INFO - 'ts_paint', 07:18:39 INFO - 'tpaint', 07:18:39 INFO - 'sessionrestore', 07:18:39 INFO - 'sessionrestore_no_auto_restore', 07:18:39 INFO - 'tabpaint']}, 07:18:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:18:39 INFO - 'ts_paint', 07:18:39 INFO - 'tpaint', 07:18:39 INFO - 'sessionrestore', 07:18:39 INFO - 'sessionrestore_no_auto_restore', 07:18:39 INFO - 'tabpaint']}, 07:18:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:18:39 INFO - 'ts_paint', 07:18:39 INFO - 'tpaint', 07:18:39 INFO - 'sessionrestore', 07:18:39 INFO - 'sessionrestore_no_auto_restore', 07:18:39 INFO - 'tabpaint']}, 07:18:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:18:39 INFO - 'tests': ['a11yr', 07:18:39 INFO - 'ts_paint', 07:18:39 INFO - 'tpaint', 07:18:39 INFO - 'sessionrestore', 07:18:39 INFO - 'sessionrestore_no_auto_restore', 07:18:39 INFO - 'tabpaint']}, 07:18:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:18:39 INFO - 'tests': ['a11yr', 07:18:39 INFO - 'ts_paint', 07:18:39 INFO - 'tpaint', 07:18:39 INFO - 'sessionrestore', 07:18:39 INFO - 'sessionrestore_no_auto_restore', 07:18:39 INFO - 'tabpaint']}, 07:18:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:18:39 INFO - 'tests': ['tsvgx', 07:18:39 INFO - 'tsvgr_opacity', 07:18:39 INFO - 'tart', 07:18:39 INFO - 'tscrollx', 07:18:39 INFO - 'cart']}, 07:18:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:18:39 INFO - 'tsvgr_opacity', 07:18:39 INFO - 'tart', 07:18:39 INFO - 'tscrollx', 07:18:39 INFO - 'cart']}, 07:18:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:39 INFO - 'talos_options': ['--disable-e10s'], 07:18:39 INFO - 'tests': ['tp5o']}, 07:18:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:39 INFO - 'tests': ['tp5o']}, 07:18:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:39 INFO - 'talos_options': ['--disable-e10s', 07:18:39 INFO - '--xperf_path', 07:18:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:39 INFO - 'tests': ['tp5n']}, 07:18:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:39 INFO - 'talos_options': ['--xperf_path', 07:18:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:39 INFO - 'tests': ['tp5n']}}, 07:18:39 INFO - 'talos.zip': {'path': '', 07:18:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:18:39 INFO - Running post-action listener: _resource_record_post_action 07:18:39 INFO - ##### 07:18:39 INFO - ##### Running create-virtualenv step. 07:18:39 INFO - ##### 07:18:39 INFO - Running pre-action listener: _resource_record_pre_action 07:18:39 INFO - Running main action method: create_virtualenv 07:18:39 INFO - Creating virtualenv /builds/slave/test/build/venv 07:18:39 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 07:18:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:18:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:18:39 INFO - Using real prefix '/tools/python27' 07:18:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:18:40 INFO - Installing distribute.............................................................................................................................................................................................done. 07:18:43 INFO - Installing pip.................done. 07:18:43 INFO - Return code: 0 07:18:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:18: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')]} 07:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18: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')]} 07:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:43 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 0x108196a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dbbd96410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108035e00>, '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 0x107e9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108030b20>, '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.uNTWNXvBWg/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.Io5tlUbbsj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 07:18:43 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 07:18:43 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 07:18:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNTWNXvBWg/Render', 07:18:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:18:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:18:43 INFO - 'HOME': '/Users/cltbld', 07:18:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:18:43 INFO - 'LOGNAME': 'cltbld', 07:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:43 INFO - 'MOZ_NO_REMOTE': '1', 07:18:43 INFO - 'NO_EM_RESTART': '1', 07:18:43 INFO - 'PAGER': '/bin/cat', 07:18:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:43 INFO - 'PWD': '/builds/slave/test', 07:18:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:18:43 INFO - 'SHELL': '/bin/bash', 07:18:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Io5tlUbbsj/Listeners', 07:18:43 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 07:18:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:18:43 INFO - 'USER': 'cltbld', 07:18:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:18:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:43 INFO - 'XPC_FLAGS': '0x0', 07:18:43 INFO - 'XPC_SERVICE_NAME': '0', 07:18:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:43 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 07:18:43 INFO - Cleaning up... 07:18:43 INFO - Return code: 0 07:18:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:18: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')]} 07:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18: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')]} 07:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:43 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 0x108196a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dbbd96410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108035e00>, '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 0x107e9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108030b20>, '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.uNTWNXvBWg/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.Io5tlUbbsj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 07:18:43 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 07:18:43 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 07:18:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNTWNXvBWg/Render', 07:18:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:18:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:18:43 INFO - 'HOME': '/Users/cltbld', 07:18:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:18:43 INFO - 'LOGNAME': 'cltbld', 07:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:43 INFO - 'MOZ_NO_REMOTE': '1', 07:18:43 INFO - 'NO_EM_RESTART': '1', 07:18:43 INFO - 'PAGER': '/bin/cat', 07:18:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:43 INFO - 'PWD': '/builds/slave/test', 07:18:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:18:43 INFO - 'SHELL': '/bin/bash', 07:18:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Io5tlUbbsj/Listeners', 07:18:43 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 07:18:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:18:43 INFO - 'USER': 'cltbld', 07:18:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:18:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:43 INFO - 'XPC_FLAGS': '0x0', 07:18:43 INFO - 'XPC_SERVICE_NAME': '0', 07:18:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:43 INFO - Downloading/unpacking psutil>=0.7.1 07:18:43 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 07:18:43 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 07:18:43 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 07:18:43 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 07:18:43 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 07:18:43 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 07:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:18:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:46 INFO - Installing collected packages: psutil 07:18:46 INFO - Running setup.py install for psutil 07:18:46 INFO - building 'psutil._psutil_osx' extension 07:18:46 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 07:18:46 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 07:18:46 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 07:18:46 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 07:18:47 INFO - building 'psutil._psutil_posix' extension 07:18:47 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 07:18:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:18:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:18:47 INFO - ^ 07:18:47 INFO - 1 warning generated. 07:18:47 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 07:18:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:47 INFO - Successfully installed psutil 07:18:47 INFO - Cleaning up... 07:18:47 INFO - Return code: 0 07:18:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:47 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 0x108196a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dbbd96410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108035e00>, '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 0x107e9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108030b20>, '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.uNTWNXvBWg/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.Io5tlUbbsj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 07:18:47 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 07:18:47 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 07:18:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNTWNXvBWg/Render', 07:18:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:18:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:18:47 INFO - 'HOME': '/Users/cltbld', 07:18:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:18:47 INFO - 'LOGNAME': 'cltbld', 07:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:47 INFO - 'MOZ_NO_REMOTE': '1', 07:18:47 INFO - 'NO_EM_RESTART': '1', 07:18:47 INFO - 'PAGER': '/bin/cat', 07:18:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:47 INFO - 'PWD': '/builds/slave/test', 07:18:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:18:47 INFO - 'SHELL': '/bin/bash', 07:18:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Io5tlUbbsj/Listeners', 07:18:47 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 07:18:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:18:47 INFO - 'USER': 'cltbld', 07:18:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:18:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:47 INFO - 'XPC_FLAGS': '0x0', 07:18:47 INFO - 'XPC_SERVICE_NAME': '0', 07:18:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:18:50 INFO - Installing collected packages: mozsystemmonitor 07:18:50 INFO - Running setup.py install for mozsystemmonitor 07:18:50 INFO - Successfully installed mozsystemmonitor 07:18:50 INFO - Cleaning up... 07:18:50 INFO - Return code: 0 07:18:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:50 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 0x108196a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dbbd96410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108035e00>, '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 0x107e9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108030b20>, '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.uNTWNXvBWg/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.Io5tlUbbsj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 07:18:50 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 07:18:50 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 07:18:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNTWNXvBWg/Render', 07:18:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:18:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:18:50 INFO - 'HOME': '/Users/cltbld', 07:18:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:18:50 INFO - 'LOGNAME': 'cltbld', 07:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:50 INFO - 'MOZ_NO_REMOTE': '1', 07:18:50 INFO - 'NO_EM_RESTART': '1', 07:18:50 INFO - 'PAGER': '/bin/cat', 07:18:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:50 INFO - 'PWD': '/builds/slave/test', 07:18:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:18:50 INFO - 'SHELL': '/bin/bash', 07:18:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Io5tlUbbsj/Listeners', 07:18:50 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 07:18:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:18:50 INFO - 'USER': 'cltbld', 07:18:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:18:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:50 INFO - 'XPC_FLAGS': '0x0', 07:18:50 INFO - 'XPC_SERVICE_NAME': '0', 07:18:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:50 INFO - Downloading/unpacking blobuploader==1.2.4 07:18:50 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 07:18:50 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 07:18:50 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 07:18:50 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 07:18:50 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 07:18:50 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 07:18:53 INFO - Downloading blobuploader-1.2.4.tar.gz 07:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:18:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:18:53 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 07:18:53 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 07:18:53 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 07:18:53 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 07:18:53 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 07:18:53 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 07:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:18:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:18:53 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 07:18:53 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 07:18:53 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 07:18:53 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 07:18:53 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 07:18:53 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 07:18:54 INFO - Downloading docopt-0.6.1.tar.gz 07:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:18:54 INFO - Installing collected packages: blobuploader, requests, docopt 07:18:54 INFO - Running setup.py install for blobuploader 07:18:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:18:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:18:54 INFO - Running setup.py install for requests 07:18:55 INFO - Running setup.py install for docopt 07:18:55 INFO - Successfully installed blobuploader requests docopt 07:18:55 INFO - Cleaning up... 07:18:55 INFO - Return code: 0 07:18:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18:55 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')]} 07:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:55 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')]} 07:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:55 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 0x108196a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dbbd96410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108035e00>, '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 0x107e9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108030b20>, '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.uNTWNXvBWg/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.Io5tlUbbsj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 07:18:55 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 07:18:55 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 07:18:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNTWNXvBWg/Render', 07:18:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:18:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:18:55 INFO - 'HOME': '/Users/cltbld', 07:18:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:18:55 INFO - 'LOGNAME': 'cltbld', 07:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:55 INFO - 'MOZ_NO_REMOTE': '1', 07:18:55 INFO - 'NO_EM_RESTART': '1', 07:18:55 INFO - 'PAGER': '/bin/cat', 07:18:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:55 INFO - 'PWD': '/builds/slave/test', 07:18:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:18:55 INFO - 'SHELL': '/bin/bash', 07:18:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Io5tlUbbsj/Listeners', 07:18:55 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 07:18:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:18:55 INFO - 'USER': 'cltbld', 07:18:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:18:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:55 INFO - 'XPC_FLAGS': '0x0', 07:18:55 INFO - 'XPC_SERVICE_NAME': '0', 07:18:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:18:55 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-SzXzCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:18:55 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-89EWN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:18:55 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-n8VGnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:18:55 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-HMyuPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:18:55 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-kZqpq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:18:56 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-lhkQ0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:18:56 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-dBsbpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:18:56 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-Jx3yTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:18:56 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-IB1rkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:18:56 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-kTgdsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:18:56 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-eXgFkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:18:56 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-NDRmTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:18:56 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-Pn7deh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:18:56 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-1UbmGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:56 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-SGR3r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:18:57 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-W4Qbse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:18:57 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-N3gQ7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:18:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:18:57 INFO - Running setup.py install for manifestparser 07:18:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:18:57 INFO - Running setup.py install for mozcrash 07:18:57 INFO - Running setup.py install for mozdebug 07:18:57 INFO - Running setup.py install for mozdevice 07:18:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:18:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:18:57 INFO - Running setup.py install for mozfile 07:18:57 INFO - Running setup.py install for mozhttpd 07:18:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:18:58 INFO - Running setup.py install for mozinfo 07:18:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:18:58 INFO - Running setup.py install for mozInstall 07:18:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:18:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:18:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:18:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:18:58 INFO - Running setup.py install for mozleak 07:18:58 INFO - Running setup.py install for mozlog 07:18:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:18:58 INFO - Running setup.py install for moznetwork 07:18:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:18:58 INFO - Running setup.py install for mozprocess 07:18:59 INFO - Running setup.py install for mozprofile 07:18:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:18:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:18:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:18:59 INFO - Running setup.py install for mozrunner 07:18:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:18:59 INFO - Running setup.py install for mozscreenshot 07:18:59 INFO - Running setup.py install for moztest 07:18:59 INFO - Running setup.py install for mozversion 07:18:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:18:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:18:59 INFO - Cleaning up... 07:18:59 INFO - Return code: 0 07:18:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18:59 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')]} 07:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:59 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')]} 07:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:59 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 0x108196a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dbbd96410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108035e00>, '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 0x107e9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108030b20>, '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.uNTWNXvBWg/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.Io5tlUbbsj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 07:18:59 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 07:18:59 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 07:18:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNTWNXvBWg/Render', 07:18:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:18:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:18:59 INFO - 'HOME': '/Users/cltbld', 07:18:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:18:59 INFO - 'LOGNAME': 'cltbld', 07:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:59 INFO - 'MOZ_NO_REMOTE': '1', 07:18:59 INFO - 'NO_EM_RESTART': '1', 07:18:59 INFO - 'PAGER': '/bin/cat', 07:18:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:59 INFO - 'PWD': '/builds/slave/test', 07:18:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:18:59 INFO - 'SHELL': '/bin/bash', 07:18:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Io5tlUbbsj/Listeners', 07:18:59 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 07:18:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:18:59 INFO - 'USER': 'cltbld', 07:18:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:18:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:59 INFO - 'XPC_FLAGS': '0x0', 07:18:59 INFO - 'XPC_SERVICE_NAME': '0', 07:18:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:00 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-Sxo3nE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:00 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)) 07:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:00 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-xndjCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:00 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)) 07:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:00 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-7zUHot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:00 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)) 07:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:00 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-px9AzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:00 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)) 07:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:00 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-koxXGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:00 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)) 07:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:00 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-YZRXYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:00 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)) 07:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:00 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-Ncykcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:00 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)) 07:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:00 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-L7LjCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:00 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)) 07:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:00 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-mlwoJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:01 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)) 07:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-9xLAMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:01 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)) 07:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-7BE18U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:01 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)) 07:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-hzRzE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:01 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)) 07:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-oEjWJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:01 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)) 07:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-FawF0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:01 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)) 07:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-Vof4ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:01 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)) 07:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-F9IRZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:01 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)) 07:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:01 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-KZHgiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:01 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)) 07:19:01 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)) 07:19:01 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)) 07:19:01 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)) 07:19:01 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)) 07:19:01 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)) 07:19:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19:04 INFO - Downloading blessings-1.6.tar.gz 07:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:19:04 INFO - Installing collected packages: blessings 07:19:04 INFO - Running setup.py install for blessings 07:19:04 INFO - Successfully installed blessings 07:19:04 INFO - Cleaning up... 07:19:04 INFO - Return code: 0 07:19:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:19:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:05 INFO - Reading from file tmpfile_stdout 07:19:05 INFO - Current package versions: 07:19:05 INFO - blessings == 1.6 07:19:05 INFO - blobuploader == 1.2.4 07:19:05 INFO - docopt == 0.6.1 07:19:05 INFO - manifestparser == 1.1 07:19:05 INFO - mozInstall == 1.12 07:19:05 INFO - mozcrash == 0.17 07:19:05 INFO - mozdebug == 0.1 07:19:05 INFO - mozdevice == 0.48 07:19:05 INFO - mozfile == 1.2 07:19:05 INFO - mozhttpd == 0.7 07:19:05 INFO - mozinfo == 0.9 07:19:05 INFO - mozleak == 0.1 07:19:05 INFO - mozlog == 3.1 07:19:05 INFO - moznetwork == 0.27 07:19:05 INFO - mozprocess == 0.22 07:19:05 INFO - mozprofile == 0.28 07:19:05 INFO - mozrunner == 6.11 07:19:05 INFO - mozscreenshot == 0.1 07:19:05 INFO - mozsystemmonitor == 0.0 07:19:05 INFO - moztest == 0.7 07:19:05 INFO - mozversion == 1.4 07:19:05 INFO - psutil == 3.1.1 07:19:05 INFO - requests == 1.2.3 07:19:05 INFO - wsgiref == 0.1.2 07:19:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19: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')]} 07:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19: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')]} 07:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:05 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 0x108196a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dbbd96410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108035e00>, '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 0x107e9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108030b20>, '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.uNTWNXvBWg/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.Io5tlUbbsj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 07:19:05 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 07:19:05 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 07:19:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNTWNXvBWg/Render', 07:19:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:19:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:19:05 INFO - 'HOME': '/Users/cltbld', 07:19:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:19:05 INFO - 'LOGNAME': 'cltbld', 07:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:05 INFO - 'MOZ_NO_REMOTE': '1', 07:19:05 INFO - 'NO_EM_RESTART': '1', 07:19:05 INFO - 'PAGER': '/bin/cat', 07:19:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:05 INFO - 'PWD': '/builds/slave/test', 07:19:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:19:05 INFO - 'SHELL': '/bin/bash', 07:19:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Io5tlUbbsj/Listeners', 07:19:05 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 07:19:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:19:05 INFO - 'USER': 'cltbld', 07:19:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:19:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:05 INFO - 'XPC_FLAGS': '0x0', 07:19:05 INFO - 'XPC_SERVICE_NAME': '0', 07:19:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:05 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)) 07:19:05 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)) 07:19:05 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)) 07:19:05 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)) 07:19:05 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)) 07:19:05 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)) 07:19:05 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)) 07:19:05 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)) 07:19:05 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)) 07:19:05 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)) 07:19:05 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)) 07:19:05 INFO - Cleaning up... 07:19:05 INFO - Return code: 0 07:19:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:19: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')]} 07:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19: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')]} 07:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108196a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dbbd96410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108035e00>, '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 0x107e9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108030b20>, '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.uNTWNXvBWg/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.Io5tlUbbsj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 07:19: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', 'jsonschema'] in /builds/slave/test/build 07:19: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 jsonschema 07:19:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNTWNXvBWg/Render', 07:19:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:19:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:19:05 INFO - 'HOME': '/Users/cltbld', 07:19:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:19:05 INFO - 'LOGNAME': 'cltbld', 07:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:05 INFO - 'MOZ_NO_REMOTE': '1', 07:19:05 INFO - 'NO_EM_RESTART': '1', 07:19:05 INFO - 'PAGER': '/bin/cat', 07:19:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:05 INFO - 'PWD': '/builds/slave/test', 07:19:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:19:05 INFO - 'SHELL': '/bin/bash', 07:19:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Io5tlUbbsj/Listeners', 07:19:05 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 07:19:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:19:05 INFO - 'USER': 'cltbld', 07:19:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:19:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:05 INFO - 'XPC_FLAGS': '0x0', 07:19:05 INFO - 'XPC_SERVICE_NAME': '0', 07:19:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:05 INFO - Downloading/unpacking jsonschema 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:19:08 INFO - Downloading/unpacking functools32 (from jsonschema) 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19:08 INFO - Downloading functools32-3.2.3-2.tar.gz 07:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:19:08 INFO - warning: no files found matching '*.txt' 07:19:08 INFO - no previously-included directories found matching 'build' 07:19:08 INFO - no previously-included directories found matching 'dist' 07:19:08 INFO - no previously-included directories found matching '.git*' 07:19:08 INFO - Installing collected packages: jsonschema, functools32 07:19:08 INFO - Running setup.py install for functools32 07:19:08 INFO - warning: no files found matching '*.txt' 07:19:08 INFO - no previously-included directories found matching 'build' 07:19:08 INFO - no previously-included directories found matching 'dist' 07:19:08 INFO - no previously-included directories found matching '.git*' 07:19:08 INFO - Successfully installed jsonschema functools32 07:19:08 INFO - Cleaning up... 07:19:08 INFO - Return code: 0 07:19:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:19: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')]} 07:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19: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')]} 07:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108196a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081a6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dbbd96410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108035e00>, '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 0x107e9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108030b20>, '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.uNTWNXvBWg/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.Io5tlUbbsj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 07:19: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', 'flake8'] in /builds/slave/test/build 07:19: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 flake8 07:19:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNTWNXvBWg/Render', 07:19:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:19:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:19:08 INFO - 'HOME': '/Users/cltbld', 07:19:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:19:08 INFO - 'LOGNAME': 'cltbld', 07:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:08 INFO - 'MOZ_NO_REMOTE': '1', 07:19:08 INFO - 'NO_EM_RESTART': '1', 07:19:08 INFO - 'PAGER': '/bin/cat', 07:19:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:08 INFO - 'PWD': '/builds/slave/test', 07:19:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:19:08 INFO - 'SHELL': '/bin/bash', 07:19:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Io5tlUbbsj/Listeners', 07:19:08 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 07:19:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:19:08 INFO - 'USER': 'cltbld', 07:19:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:19:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:08 INFO - 'XPC_FLAGS': '0x0', 07:19:08 INFO - 'XPC_SERVICE_NAME': '0', 07:19:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:09 INFO - Downloading/unpacking flake8 07:19:09 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 07:19:09 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 07:19:09 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 07:19:09 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 07:19:09 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 07:19:09 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 07:19:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:19:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:19:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:19:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:19:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:19:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:19:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:19:12 INFO - no previously-included directories found matching 'docs/_build' 07:19:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:19:13 INFO - Running setup.py install for pep8 07:19:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:19:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:19:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:19:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:19:13 INFO - no previously-included directories found matching 'docs/_build' 07:19:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:19:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:19:13 INFO - Cleaning up... 07:19:13 INFO - Return code: 0 07:19:13 INFO - Running post-action listener: _resource_record_post_action 07:19:13 INFO - Running post-action listener: _start_resource_monitoring 07:19:13 INFO - Starting resource monitoring. 07:19:13 INFO - ##### 07:19:13 INFO - ##### Running install step. 07:19:13 INFO - ##### 07:19:13 INFO - Running pre-action listener: _resource_record_pre_action 07:19:13 INFO - Running main action method: install 07:19:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:13 INFO - Reading from file tmpfile_stdout 07:19:13 INFO - Detecting whether we're running mozinstall >=1.0... 07:19:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:19:13 INFO - Reading from file tmpfile_stdout 07:19:13 INFO - Output received: 07:19:13 INFO - Usage: mozinstall [options] installer 07:19:13 INFO - Options: 07:19:13 INFO - -h, --help show this help message and exit 07:19:13 INFO - -d DEST, --destination=DEST 07:19:13 INFO - Directory to install application into. [default: 07:19:13 INFO - "/builds/slave/test"] 07:19:13 INFO - --app=APP Application being installed. [default: firefox] 07:19:13 INFO - mkdir: /builds/slave/test/build/application 07:19:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:19:35 INFO - Reading from file tmpfile_stdout 07:19:35 INFO - Output received: 07:19:35 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:19:35 INFO - Running post-action listener: _resource_record_post_action 07:19:35 INFO - ##### 07:19:35 INFO - ##### Running run-tests step. 07:19:35 INFO - ##### 07:19:35 INFO - Running pre-action listener: _resource_record_pre_action 07:19:35 INFO - Running main action method: run_tests 07:19:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:19:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:19:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:19:35 INFO - 2016-07-21 07:19:35.768 screenresolution[1637:7502] starting screenresolution argv=screenresolution get 07:19:35 INFO - 2016-07-21 07:19:35.771 screenresolution[1637:7502] Display 0: 1600x1200x32@60 07:19:35 INFO - 2016-07-21 07:19:35.777 screenresolution[1638:7504] starting screenresolution argv=screenresolution list 07:19:35 INFO - Available Modes on Display 0 07:19:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:19:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:19:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:19:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:19:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:19:36 INFO - Intel Iris: 07:19:36 INFO - Chipset Model: Intel Iris 07:19:36 INFO - Type: GPU 07:19:36 INFO - Bus: Built-In 07:19:36 INFO - VRAM (Dynamic, Max): 1536 MB 07:19:36 INFO - Vendor: Intel (0x8086) 07:19:36 INFO - Device ID: 0x0a2e 07:19:36 INFO - Revision ID: 0x0009 07:19:36 INFO - Displays: 07:19:36 INFO - Display: 07:19:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:19:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:19:36 INFO - Display Serial Number: 1600x1200 60 07:19:36 INFO - Main Display: Yes 07:19:36 INFO - Mirror: Off 07:19:36 INFO - Online: Yes 07:19:36 INFO - Rotation: Supported 07:19:36 INFO - Return code: 0 07:19:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:19:36 INFO - Python 2.7.3 07:19:36 INFO - Return code: 0 07:19:36 INFO - grabbing minidump binary from tooltool 07:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:19:36 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 0x108035e00>, '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 0x107e9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108030b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:19:36 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 07:19:36 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 07:19:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:19:36 INFO - Return code: 0 07:19:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:19:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:19:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:19:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:19:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:19:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:19:37 INFO - Return code: 0 07:19:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0209', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0209 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:19:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNTWNXvBWg/Render', 07:19:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:19:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:19:37 INFO - 'HOME': '/Users/cltbld', 07:19:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:19:37 INFO - 'LOGNAME': 'cltbld', 07:19:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:19:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:37 INFO - 'MOZ_NO_REMOTE': '1', 07:19:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:19:37 INFO - 'NO_EM_RESTART': '1', 07:19:37 INFO - 'PAGER': '/bin/cat', 07:19:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:37 INFO - 'PWD': '/builds/slave/test', 07:19:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:19:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:19:37 INFO - 'SHELL': '/bin/bash', 07:19:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Io5tlUbbsj/Listeners', 07:19:37 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 07:19:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:19:37 INFO - 'USER': 'cltbld', 07:19:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:19:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:37 INFO - 'XPC_FLAGS': '0x0', 07:19:37 INFO - 'XPC_SERVICE_NAME': '0', 07:19:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:19:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0209', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:19:37 INFO - mozversion application_buildid: 20160721051621 07:19:37 INFO - mozversion application_changeset: 512d3ff7151c16f30ea8f93414d048c708815110 07:19:37 INFO - mozversion application_display_name: Firefox 07:19:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:19:37 INFO - mozversion application_name: Firefox 07:19:37 INFO - mozversion application_remotingname: firefox 07:19:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:19:37 INFO - mozversion application_vendor: Mozilla 07:19:37 INFO - mozversion application_version: 48.0 07:19:37 INFO - mozversion platform_buildid: 20160721051621 07:19:37 INFO - mozversion platform_changeset: 512d3ff7151c16f30ea8f93414d048c708815110 07:19:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:19:37 INFO - mozversion platform_version: 48.0 07:19:37 INFO - using testdate: 1469110777 07:19:37 INFO - actual date: 1469110777 07:19:37 INFO - starting webserver on 'localhost:49277' 07:19:37 INFO - SUITE-START | Running 2 tests 07:19:37 INFO - TEST-START | dromaeo_css 07:19:37 INFO - operating with platform_type : mac_ 07:19:37 INFO - Initialising browser for dromaeo_css test... 07:19:37 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpxqV_X3/profile http://localhost:49277/getInfo.html) 07:19:40 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 07:19:40 INFO - PROCESS | 1656 | colorDepth:24 07:19:40 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 07:19:40 INFO - PROCESS | 1656 | __metrics 07:19:40 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 07:19:41 INFO - TEST-INFO | 1656: exit 0 07:19:41 INFO - Browser initialized. 07:19:41 INFO - Running cycle 1/1 for dromaeo_css test... 07:19:41 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpxqV_X3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:53 INFO - PROCESS | 1660 | RSS: Main: 171122688 07:19:53 INFO - PROCESS | 1660 | 07:20:42 INFO - PROCESS | 1660 | 1469110842804 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] 07:22:53 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 07:22:54 INFO - PROCESS | 1660 | RSS: Main: 181870592 07:22:54 INFO - PROCESS | 1660 | 07:25:56 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 07:25:57 INFO - PROCESS | 1660 | RSS: Main: 192524288 07:25:57 INFO - PROCESS | 1660 | 07:28:58 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 07:28:59 INFO - PROCESS | 1660 | RSS: Main: 194699264 07:28:59 INFO - PROCESS | 1660 | 07:32:01 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 07:32:01 INFO - PROCESS | 1660 | RSS: Main: 198463488 07:32:01 INFO - PROCESS | 1660 | 07:35:04 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 07:35:04 INFO - PROCESS | 1660 | RSS: Main: 197632000 07:35:04 INFO - PROCESS | 1660 | 07:38:06 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 07:38:07 INFO - PROCESS | 1660 | RSS: Main: 202657792 07:38:07 INFO - PROCESS | 1660 | 07:38:07 INFO - PROCESS | 1660 | __start_tp_report 07:38:07 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 07:38:07 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 07:38:07 INFO - PROCESS | 1660 | |i|pagename|runs| 07:38:07 INFO - PROCESS | 1660 | |0;dojo.html;2965.2735079905424;3662.1393972416477;3697.6487233712787;3720.125770443946;3723.1064544509327;5961.254843144601;5965.2245208122995;5966.254218222723;5987.850303742403;6014.669193194372;5890.528757699384;5981.940180598203;6020.879582408349;6031.24609423822;6071.817845464643;5337.813176538822;5339.439358867321;5339.439358867321;5443.836684899459;5527.198556209347;5357.303550538424;5405.4324295948945;5412.323459567554;5480.3971563128225;5486.972565137189;5329.573634109282;5352.437994010631;5355.223492593572;5371.435999220084;5402.567794576444;5294.364676238837;5316.4683531646915;5337.839864804062;5365;5370.516653501184;5224.791008359699;5269.920951185735;5282.735863206824;5293.444188360205;5331.067063263913;4466.7716377995985;5759.769609215627;5807.709614519299;5829.650220986754;5833.7083145842535;6242.406971337716;6246.656433896134;6309.116723658692;6318.684065796691;6328.65192414417;6302.779402720928;6375.298717141157;6381.617102973836;6385.042243663441;6399.968000160016;6031.125486804476;6090.177825993478;6092.695365231721;6097.481714054266;6101.664408457489;6364.904526432108;6366.7771627993725;6412.743490260337;6478.190226221723;6511.413972742476;6297.086922396227;6300.369963003663;6312.242530896322;6312.431881130628;6315.400036996478;6321.051842223703;6336.049592561153;6343.460805831463;6354.555181137276;6365.777197798055;6190.102435146879;6207.286162091327;6240.843978900564;6269.7178626961895;6298.716557754912;5359.678419294854;6068.120122582201;6289.811305660837;6294.15028971083;6312.873742525124;5052.343195384577;5082.593392528589;5118.411382690963;5120.334356533627;5131.820386286462;4092.0997380576227;4441.178381999341;4536.8638940831825;4602.263637817933;4651.534846515389;5870.178175055496;5938.317093534299;6109.358517355702;6118.617310019568;6126.151269885539;6357.554971151975;6361.745530178741;6394.360563943568;6420.807375778734;6421.8073457796345;4635.930461043087;4770.069836381942;5275.5515781158265;5891.410858914074;6121.938780612226;4650.999999999933;5520.861978450571;5524.558035357162;5531.032069387841;5584.46947539983;5442.564594832483;6596.977468492391;6603.075569420285;6610.768623098168;6613.570117942415;5361.544268737201;6240.313565507699;6315.368463153832;6372.776952806629;6379.585326953733;5479.4520547944885;6583.868322633425;6607.9669601651685;6631.1379520662;6661.700223489857;6253.437190652863;6298.653574053288;6318.589291696025;6328.335524770017;6340.968295158495;6301.495880329654;6305.274893387319;6324.715387807468;6361.14124593174;6378.107065010995;6258.280297765815;6270.874582508415;6278.843028924313;6282.2147231596055;6301.495880329654;6072.240969878765;6262.68686565679;6267.122602835516;6271.686415679106;6289.496840252677;6194.81415557534;6200.3799620037635;6221.564490485623;6244.313125556276;6250.531210159347;6168.969155154375;6264;6281.842953926189;6287.46556542699;6330.778422755366;6127.877442451215;6170.81487555374;6247.843803904939;6251;6269.874602507833 07:38:07 INFO - PROCESS | 1660 | |1;ext.html;551.5008916930177;566.0621283197283;569.9800506982256;574.0900672434192;592.1384385718779;34714.82642586787;39353.21293574127;40091.59908400919;40116.1976760465;40159;41344.37983430251;42000.78999605005;42571;42702.572974270246;42707;9619.134277915004;9774.364666296704;9840.655577054804;9844.655437059704;9852.753681157958;9649.614015439374;9787.412755234673;9854.40873547586;9878.901210987906;9951.800963980717;9842.753931151707;9862.11240988311;9936.205103591696;9950.55222514985;9970.15253703436;9158.129977652112;9190.678326258583;9879.802403951953;9889;9919.65281215154;9664.661736839176;9672.08115229052;9770.853437198448;9780.510974451248;9814.509274536316;34047.659523404946;39845.402318965236;40260.19479610421;40789.18421631551;40898.1820363591;3167.825769582672;3395;3462.4460086386057;3893.6495715385468;3997.8200980955926;26371;26413.47173056528;26974.46051078987;27034.729652703616;27752.861235693894;2682;2695.9595606065923;2715.375463643353;2736.2748871549056;2779.4441111777724;366080;367054;367441;367628;368059;30400.39199216003;36351.4547281791;36381.81809090938;37235;38198.2360352797;36592.45111323332;36691.89924302275;36794.448083278774;36825.44761828575;36827;16244.431444899608;16424.4251451201;16524.25640846165;16617.91691041537;16639.83360166407;13954;13955.441782328593;14061;14063.2968351582;14073;6939.791806245821;8220.917790822135;8296.087430382653;8421.663133474593;8435.029971553227;3214.1321843102232;3462.290230502741;3472.5485686860548;3560;3575.6245594212755;1072.2708558180511;1098.527633117751;1124.5389390349917;1206.3485717712338;1211.6062279758937;30500.84749576238;31153;31492.685073148976;31522.52716209259;31630.841845790623;932.128459890005;944.8252073366449;1025.4565080507343;1068.8129577324094;1161.8663853656938;12630;15921.681566368608;15938.60153496172;15942.521724348288;16380.918095409446;579806.4038719287;582346;617623;621730;621767;63511;63519.36480635227;64419;64550;64630.353696463375;1487.2192099148033;1555;1568.3648122510174;1575.7951466309535;1591.7981923647571;25920.740792592587;30432.239194020327;30545.26548385004;30663;30727.846360768053;54969;55637.721811390686;55844.72077639586;56067.878642426105;56223;509698;549047;549130;552175;552505;27309.72690273072;28435.715642844134;28783.424331512833;28900.27749306284;28904.566431503965;47796.04407911892;48196;48937;49244;49256;32757.34485310328;39053;40144.397834033094;40327;40676.3898541528;38739.97765917835;38951;39633.60366396299;39745.80127099346;40511.392329115675;34193.829030854686;38621;38993.41509877411;39636.80181599074;39675.80162099171;30021.699783002765;32580.34839303248;33391.83304083464;33690.32619347648;33723.66276337303;25285;25642;25711;25987.401259873863;26021.349466263495 07:38:07 INFO - PROCESS | 1660 | |2;jquery.html;413.1324219139807;413.40263319503293;413.85308215583484;424.08609446642487;424.2977871622464;20771;21461.356159315226;21506.56986860262;21697.783022169773;22768.316950491513;12487.25076495411;12599.937000314985;12865.485380584765;12913.677158071054;12968;5275.340582427197;5516.503514683678;5569.610127291091;5583.274174357328;5587.580931430139;5464.972675136619;5467.371252305996;5959.642421454727;6079.665618390986;6123.571350005502;5880.470757631833;6008.909866352008;6025.969870150643;6047.516198704115;6070.6661133637635;5352.411234764173;5386.515213630772;5498.752556134964;5502.284702988626;5992.250968628921;5275.997560463499;5346.251524786533;5366.731663416853;5367.06076436626;5373.570114390839;14273.714525709427;14337.21145337006;14436.711265774626;14678.706425871424;14714.484993025193;2089.770125286217;2122.0450797141193;2190.1896298369547;2301.4016355747626;2830.3631682871396;8456.788580285542;10151.94924025375;10248.846267305997;10414.687559373231;10572.947135264352;1656.287796247613;1797.4607617714764;1818.5544541587265;1819.3632228719976;1862.2644055598098;106112.93887061108;106229.93770062277;106553;109864.45067774689;111269;12148.878511214774;12254.264744115382;12272.447739851728;12403.25580465175;12431.254124752544;14210.360533776005;14580.927095364455;15668.843311566738;15846.683066338608;15855.286512106983;9250.4912229828;9439.480828554495;9454.14912657864;9472.479013654178;9489.1934185595;8024.879626805603;9032.63869445215;9413.57638906251;9430.858537121949;9466.432014079177;4875.781054736316;4953.975230123899;5001.099802035668;5003.774830132653;5025.597952163818;2044.703517989883;2089.9268525601533;2091.937241882746;2113.6618141097656;2159.4709296222213;846.6909578003985;911.1389736698756;935.7333160049353;1015.5227043289642;1091.2143256855052;19924.90037549803;20925.37223883286;21182.894085529475;21397.893010535157;22461.43846403853;946.5409276500892;975.8243516167158;995.7759504111661;1034.8085604163255;1085.7177133945231;10697;11485.483153258123;11497.482613282422;11520.481578328996;11732.648020559396;660271;661066;678206;678373;680465;79178;124106.5178696421;138651;139260;142460;1047.9895201048043;1096.4517741129434;1112.7663190730038;1117.6088369070924;1121.0807138146643;17935;18137.818621813614;18230.45308640743;18488.890666560048;18885;37263.88208353754;51104;51924.74037629788;54532.18201727056;57817.843643127744;79204.60397697975;80899;81736.59131704542;82754.75867861866;83418.58290708507;7145.1425828900865;8162.7143049992965;8513.531755753245;8591.6992905248;8696.565171741515;10911.563537458413;12611;12809.807852882028;12926.806097908728;13135.408906599036;10974.670759877217;11156.553737850396;11203.943980280046;11248;11319.886801131883;9141.268698504236;10435.37387756737;10814.35113893169;11007.789143194403;11222.158338124511;10771.946140269249;10927.235093543693;11186.888131118585;11221.943890280496;11628.534858605899;8174.346052315682;8306.418550701394;8371.037330707046;8423.241908228289;8426.073131955603;9997.950010250193;10785.029347358775;10860.728481788019;11045.28205666629;11071.446427678746 07:38:07 INFO - PROCESS | 1660 | |3;mootools.html;1662.069241224914;1686.485621885325;1981.9603607927843;2030.0661695620015;2123.957520849582;8370.037445693748;8962.148595883396;9261.79596652435;9467.10062544059;9491.288153388497;9083.31875109366;9109.04355042721;9195.494247816367;9212.94051184114;9261.398009129402;2494.6133349330885;2502.3493891588137;2523.5962246040635;2534.7085085215253;2535.2140836340795;2497.7502249774966;2533.8353007054484;2544.134994102005;2547.630593563932;2549.2352294311727;2183.2140429445385;2489.7136829264687;2519.105717470299;2559.9360015999655;2571.074413211252;2516.7986561075163;2520.5589021921273;2539.1874600127967;2543.4023004593905;2569.832960857538;2515.1448507507534;2544.70735865376;2550.5664037113734;2563.1669707345;2563.871806409672;9332.580033898423;9346.813063738688;9381.812363752755;9387.10822471864;9391.812163756755;5589.189567512729;5623.128415095667;5740.425957404268;5779.711014449261;5792.4497172768515;3559.750817442754;3692.132348898007;3701.3337599232127;3711.832967516468;3761.341765191108;1036.1710631494775;1050.165118730611;1057.3285963413211;1062.596213438896;1067.0876400677464;12109.697257568543;12120.45457954394;12150.756984860252;12343.321117338543;12634.620961371174;4907.87730306738;4982.77577509013;5015.623828212899;5093.745312734349;5115.155999260155;10489.213309001703;10565.735856603646;10578.629747958785;10601.416922069206;10625.681229563126;5688.8862222755315;5689.0328644130595;5733.541316694655;5736.77052917887;5740.052891272977;4566.908661826745;5013.799448022111;5073.061483625541;5185.403678576937;5187.429382767892;4206.47419072616;4213.1784302061415;4225.830966761357;4236.9364459533135;4261.126469073833;1413.3851774478135;1423.992880035593;1430.7138572285585;1436.0235040172574;1442.1203066129654;848.7284069097952;860.3848248502351;916.2029034739819;952.7760976170595;979.060102301784;6085.117657939574;6163.907541386883;6181.134641150243;6202;6292.056191571301;985.8915519292872;997.4015590645555;1020.6886899495577;1026.3585259212991;1050.5325130317087;3543.309054734302;3745.887623371303;3753.9061523462133;3823.044238940265;4099;11071;11133.888661113286;11360.375179365214;11449.942750286194;11468.598599048993;10609.469526523642;10696.090832279187;10699.572017119228;10729.78540429187;10850.186236032172;8573.699920502753;8622.223999840044;8681;8708.433951793113;8780.165884240987;5888.676122813286;6053.364396738279;6085.056816193497;6100.6339619621185;6165.599236049642;9769.511524423893;10036.397816131055;10063.144632706302;10111.292209545261;10169.9491502542;9816.55825487869;10355.896441035795;10460.529276182438;10479.790404192026;10735.516901739597;6761.188657361148;7139.892901606584;7622.961885190539;7852.960735196288;7932.6430310637315;8401.411901166859;8559.786005349915;8576.65693372283;8642.351823613128;8644.827103458021;7636.80907977305;7773.144954055162;7816.609169541386;7872.212778722082;7881.251281128284;7578.621068946641;7632.923670763222;7659.195784442553;7683.385329173764;7695.422843286664;6130.356312587292;7337.59643219628;7380.667869945973;7405.444591655755;7430.665620047002;4977.178765503651;5032.647714659939;5133.640645154804;5233.424323324355;5238.5023422774775;5146.665466744649;5208.296879921162;5246.947530524799;5383.138697808332;5455.754491047833 07:38:07 INFO - PROCESS | 1660 | |4;prototype.html;340.29219224014054;341.94357930941396;342.41105298885924;347.98086105264207;348.42509858733104;5995.220621319228;7038.155421349439;7064.116985376828;7111.146662400519;7151.213366529678;6925.792226233209;6928.618925959083;7018.227994920555;7042.366187043165;7072.504924655276;5197.636165468419;5201.765920533576;5225.947740522603;5231.79072837088;5235.502627250406;4954.207326827708;5058;5151.665141765792;5187.273781670569;5198.896022079556;5075.340205773245;5082.949170508303;5086.135356989321;5105.923411148836;5148.5881129509735;5106.131957567204;5109.64232503723;5122.538971492546;5142.07442660321;5144.022635699205;4400.295952647593;4404.361367601679;4421.248387774086;4427.911441771179;4466.7766611669285;6701.229358623772;6785.864282714368;6788.59268443895;6791.932080679179;6809.761658341934;5896.174535565025;6081.209442772455;6081.787137450212;6083.330833608299;6086.573939824214;7429.9257007430315;7483.578120157153;7487.1389790173735;7494.550326980344;7515.398768098539;4026.838926442939;4936.703797772145;4936.728479933602;4938.654294199408;4952.430470495903;7886.566238856861;7931.325837303836;7932.7223547176145;7936.246056624612;7949.920500795034;4593.402857628487;4925.335079764258;5038.093143234253;5044.54599086084;5046.369203849519;5128.358955130609;5140.820071297487;5141.2288156776785;5152.407473140637;5160.354955630546;6067.453929146398;6070.484008859208;6077.696115194222;6083.6045657032155;6088.330283668793;7587;7613.124490683532;7621.6570254338685;7624.504407213513;7629.847403051908;1778.8704172850075;1800.5768644368563;1800.6578750037452;1802.7025540785885;1806.096951524238;1016.598443614768;1066.632011955874;1155.930644161353;1156.410230782307;1161.465725766157;6958.826029349206;7015.684294206773;7035.085438892911;7035.47233957445;7068.434525237969;6154;7691.423143264277;7706.07527096752;7727.497712648772;7754.728584499516;7014.22843487216;7076.903080022502;7148.035015272975;7198.136223653195;7243.913412988094;3337.7830441021256;4023.4970628671417;4177.4778152730905;4181.979090104591;4201.033762234703;8214.548199848947;8223.465474744242;8244;8248.587570621565;8268.2558569729;6774.051632771416;6926.826829329307;8124.390670699721;8211.58942052895;8244.134365891616;6677.3656502632175;8289.917100828914;8311.709090181814;8320.126386729427;8329.708460203863;7579.924200757921;7851.016613686763;7957.323627491728;7964.721234756756;7976.840463190588;7740.883886741816;7766.456348055582;7772.378209743094;7775;7799.298063174341;8273.255407013397;8287.171282871665;8293.046299675614;8295.95852020736;8311.459755115899;4879.194932836042;4939.8885250818275;4942.851714448572;4948.62885283598;4955;6583.835404114935;7486.588237646982;7846;7866.213378662317;7899.526028438312;7535.359494442814;7583.696652134074;7596.202398748052;7623.733169339046;7632.351250143578;7572.621368931421;7584.393248540214;7593.202713714981;7598.354139898171;7609.6575654094595;5966.552508561788;7102.964485177541;7401.777946661608;7406.740764073232;7428.182899880901;6393.2328120625825;7289.942958271127;7535.73624923125;7594.430417718582;7610.771676849703;7427.665755041145;7429.665665045194;7433.739819106306;7451.776446706607;7482.513636613603 07:38:07 INFO - PROCESS | 1660 | |5;yui.html;754.3060384446309;759.9740350526788;768.896199013133;773.7021246819972;788.2708494642455;15287.159206243652;15389.846101538995;15534.611634709137;15630.218489075543;15718.685626287468;14368.712625747505;14425.495107671233;14481.63795905103;14496.130232186077;14506.927465362685;763.2329508843618;942.5805516545106;962.0427674463918;965.2037069417723;966.6375109334;965.7971825916566;975.7072878136566;976.7362812040781;977.3402953006728;978.9021097890226;1015.527779582494;1023.8413045977885;1036.0675392147052;1036.512838965685;1040.5577629507468;846.2299307630088;1018.9796204075914;1025.3898930136556;1028.7479567505934;1032.9845052324222;737.3032484302337;743.2567432567432;765.490948519234;770.1182146442349;770.7649167004062;14799.186044767534;14864.405423783035;15154.166520841349;15246.771298430533;15291.541253762405;13259.27074010929;13287.335633218301;13326.400311985984;13443.395047222899;13472.652734726547;10226.846597300972;10261.692149235534;10397.376157430579;10548.156147508182;10636.414997175152;3558;3593.8562457501666;3634.0733113056267;3685.0418891088243;3686.5760437549757;81954.36091278141;83815.580922095;83983;84884.57557712233;85085;9746.220302375792;9752.951235243778;9923.156531694742;10027.197824174049;10095.444750538643;23462.64806027911;23484;23488.53022939566;23504.412389690395;23581.88209058944;7608.733694320672;7614.543127412373;7782.961085194538;7836.216378362118;7900.644470998819;4161.583841615814;4195.832166713297;4201;4211.852585159505;4215.346621273708;3748.2690875279604;3765.661090501868;3816.5420149581673;3816.770993740329;3816.809159542012;619.8326451857973;649.2922714241499;649.8862699027651;669.3741351836048;690.5028379566704;561.9185218143429;616.3374372549438;618.8607563298312;626.6021076616381;628.0892705576932;5925.822225333247;8363.121872203452;8515.531645759418;8585.080913543168;8638.35212359063;538.2760187547821;594.005041555393;628.544305378606;629.754395785644;638.524299396943;3486.6299548544234;3993.3610622300293;4040.616141466556;4046.858359957387;4081.7142800003717;72368;92547;93036.53481732548;94070.52964735133;96281.51859240659;81431;81676.59161704272;81684;82975;86338;74283;74845.62577187188;75205.99999999891;75384.86922696054;75643.48713025708;7956.84086318282;8109.3917956152345;8219.83560328802;8222.876656850032;8262.256396924306;50790.22234221784;50907.49092509028;51205.7439712799;51846.481535185674;51991.480085198666;63668;65092.34907651052;65205;65958.67020664866;71316;8511.404201705822;10349.172066234834;10360.637377691744;10409.063184313449;10612.787744245226;11152.386618736047;11288.604898828502;11305.886941130813;11516.82724759146;12091.972182364598;10511.526981286013;10605.469726513798;10675.359478431319;11059.723506912069;11075.83386249223;10432.68701938943;10635.734106647396;10674.306170098918;10701.571937122428;10976.957189067025;10560.683179504627;10595.205359597907;10800.351978881292;11103.611373601885;11106.666799996014;8922.509261990654;9114.726558203265;9156.679516217167;9246.95376523113;9536.809263814546;9177.816443671223;9253.213476854273;9273.397229180351;9331.626734930527;9350.579223935076 07:38:07 INFO - PROCESS | 1660 | __end_tp_report 07:38:07 INFO - PROCESS | 1660 | __start_cc_report 07:38:07 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,391 07:38:07 INFO - PROCESS | 1660 | __end_cc_report 07:38:07 INFO - PROCESS | 1660 | __startTimestamp1469111887233__endTimestamp 07:38:07 INFO - PROCESS | 1660 | 07:38:07 INFO - PROCESS | 1660 | ------- Summary: start ------- 07:38:07 INFO - PROCESS | 1660 | Number of tests: 6 07:38:07 INFO - PROCESS | 1660 | 07:38:07 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5862.10 Median:6168.97 stddev:674.85 (10.9%) stddev-sans-first:637.51 07:38:07 INFO - PROCESS | 1660 | Values: 2965.3 3662.1 3697.6 3720.1 3723.1 5961.3 5965.2 5966.3 5987.9 6014.7 5890.5 5981.9 6020.9 6031.2 6071.8 5337.8 5339.4 5339.4 5443.8 5527.2 5357.3 5405.4 5412.3 5480.4 5487.0 5329.6 5352.4 5355.2 5371.4 5402.6 5294.4 5316.5 5337.8 5365.0 5370.5 5224.8 5269.9 5282.7 5293.4 5331.1 4466.8 5759.8 5807.7 5829.7 5833.7 6242.4 6246.7 6309.1 6318.7 6328.7 6302.8 6375.3 6381.6 6385.0 6400.0 6031.1 6090.2 6092.7 6097.5 6101.7 6364.9 6366.8 6412.7 6478.2 6511.4 6297.1 6300.4 6312.2 6312.4 6315.4 6321.1 6336.0 6343.5 6354.6 6365.8 6190.1 6207.3 6240.8 6269.7 6298.7 5359.7 6068.1 6289.8 6294.2 6312.9 5052.3 5082.6 5118.4 5120.3 5131.8 4092.1 4441.2 4536.9 4602.3 4651.5 5870.2 5938.3 6109.4 6118.6 6126.2 6357.6 6361.7 6394.4 6420.8 6421.8 4635.9 4770.1 5275.6 5891.4 6121.9 4651.0 5520.9 5524.6 5531.0 5584.5 5442.6 6597.0 6603.1 6610.8 6613.6 5361.5 6240.3 6315.4 6372.8 6379.6 5479.5 6583.9 6608.0 6631.1 6661.7 6253.4 6298.7 6318.6 6328.3 6341.0 6301.5 6305.3 6324.7 6361.1 6378.1 6258.3 6270.9 6278.8 6282.2 6301.5 6072.2 6262.7 6267.1 6271.7 6289.5 6194.8 6200.4 6221.6 6244.3 6250.5 6169.0 6264.0 6281.8 6287.5 6330.8 6127.9 6170.8 6247.8 6251.0 6269.9 07:38:07 INFO - PROCESS | 1660 | 07:38:07 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:63435.02 Median:38680.49 stddev:137677.19 (355.9%) stddev-sans-first:137982.46 07:38:07 INFO - PROCESS | 1660 | Values: 551.5 566.1 570.0 574.1 592.1 34714.8 39353.2 40091.6 40116.2 40159.0 41344.4 42000.8 42571.0 42702.6 42707.0 9619.1 9774.4 9840.7 9844.7 9852.8 9649.6 9787.4 9854.4 9878.9 9951.8 9842.8 9862.1 9936.2 9950.6 9970.2 9158.1 9190.7 9879.8 9889.0 9919.7 9664.7 9672.1 9770.9 9780.5 9814.5 34047.7 39845.4 40260.2 40789.2 40898.2 3167.8 3395.0 3462.4 3893.6 3997.8 26371.0 26413.5 26974.5 27034.7 27752.9 2682.0 2696.0 2715.4 2736.3 2779.4 366080.0 367054.0 367441.0 367628.0 368059.0 30400.4 36351.5 36381.8 37235.0 38198.2 36592.5 36691.9 36794.4 36825.4 36827.0 16244.4 16424.4 16524.3 16617.9 16639.8 13954.0 13955.4 14061.0 14063.3 14073.0 6939.8 8220.9 8296.1 8421.7 8435.0 3214.1 3462.3 3472.5 3560.0 3575.6 1072.3 1098.5 1124.5 1206.3 1211.6 30500.8 31153.0 31492.7 31522.5 31630.8 932.1 944.8 1025.5 1068.8 1161.9 12630.0 15921.7 15938.6 15942.5 16380.9 579806.4 582346.0 617623.0 621730.0 621767.0 63511.0 63519.4 64419.0 64550.0 64630.4 1487.2 1555.0 1568.4 1575.8 1591.8 25920.7 30432.2 30545.3 30663.0 30727.8 54969.0 55637.7 55844.7 56067.9 56223.0 509698.0 549047.0 549130.0 552175.0 552505.0 27309.7 28435.7 28783.4 28900.3 28904.6 47796.0 48196.0 48937.0 49244.0 49256.0 32757.3 39053.0 40144.4 40327.0 40676.4 38740.0 38951.0 39633.6 39745.8 40511.4 34193.8 38621.0 38993.4 39636.8 39675.8 30021.7 32580.3 33391.8 33690.3 33723.7 25285.0 25642.0 25711.0 25987.4 26021.3 07:38:07 INFO - PROCESS | 1660 | 07:38:07 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:36329.54 Median:21429.62 stddev:111384.14 (519.8%) stddev-sans-first:111663.95 07:38:07 INFO - PROCESS | 1660 | Values: 413.1 413.4 413.9 424.1 424.3 20771.0 21461.4 21506.6 21697.8 22768.3 12487.3 12599.9 12865.5 12913.7 12968.0 5275.3 5516.5 5569.6 5583.3 5587.6 5465.0 5467.4 5959.6 6079.7 6123.6 5880.5 6008.9 6026.0 6047.5 6070.7 5352.4 5386.5 5498.8 5502.3 5992.3 5276.0 5346.3 5366.7 5367.1 5373.6 14273.7 14337.2 14436.7 14678.7 14714.5 2089.8 2122.0 2190.2 2301.4 2830.4 8456.8 10151.9 10248.8 10414.7 10572.9 1656.3 1797.5 1818.6 1819.4 1862.3 106112.9 106229.9 106553.0 109864.5 111269.0 12148.9 12254.3 12272.4 12403.3 12431.3 14210.4 14580.9 15668.8 15846.7 15855.3 9250.5 9439.5 9454.1 9472.5 9489.2 8024.9 9032.6 9413.6 9430.9 9466.4 4875.8 4954.0 5001.1 5003.8 5025.6 2044.7 2089.9 2091.9 2113.7 2159.5 846.7 911.1 935.7 1015.5 1091.2 19924.9 20925.4 21182.9 21397.9 22461.4 946.5 975.8 995.8 1034.8 1085.7 10697.0 11485.5 11497.5 11520.5 11732.6 660271.0 661066.0 678206.0 678373.0 680465.0 79178.0 124106.5 138651.0 139260.0 142460.0 1048.0 1096.5 1112.8 1117.6 1121.1 17935.0 18137.8 18230.5 18488.9 18885.0 37263.9 51104.0 51924.7 54532.2 57817.8 79204.6 80899.0 81736.6 82754.8 83418.6 7145.1 8162.7 8513.5 8591.7 8696.6 10911.6 12611.0 12809.8 12926.8 13135.4 10974.7 11156.6 11203.9 11248.0 11319.9 9141.3 10435.4 10814.4 11007.8 11222.2 10771.9 10927.2 11186.9 11221.9 11628.5 8174.3 8306.4 8371.0 8423.2 8426.1 9998.0 10785.0 10860.7 11045.3 11071.4 07:38:07 INFO - PROCESS | 1660 | 07:38:07 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5969.86 Median:5014.71 stddev:3306.15 (65.9%) stddev-sans-first:3299.58 07:38:07 INFO - PROCESS | 1660 | Values: 1662.1 1686.5 1982.0 2030.1 2124.0 8370.0 8962.1 9261.8 9467.1 9491.3 9083.3 9109.0 9195.5 9212.9 9261.4 2494.6 2502.3 2523.6 2534.7 2535.2 2497.8 2533.8 2544.1 2547.6 2549.2 2183.2 2489.7 2519.1 2559.9 2571.1 2516.8 2520.6 2539.2 2543.4 2569.8 2515.1 2544.7 2550.6 2563.2 2563.9 9332.6 9346.8 9381.8 9387.1 9391.8 5589.2 5623.1 5740.4 5779.7 5792.4 3559.8 3692.1 3701.3 3711.8 3761.3 1036.2 1050.2 1057.3 1062.6 1067.1 12109.7 12120.5 12150.8 12343.3 12634.6 4907.9 4982.8 5015.6 5093.7 5115.2 10489.2 10565.7 10578.6 10601.4 10625.7 5688.9 5689.0 5733.5 5736.8 5740.1 4566.9 5013.8 5073.1 5185.4 5187.4 4206.5 4213.2 4225.8 4236.9 4261.1 1413.4 1424.0 1430.7 1436.0 1442.1 848.7 860.4 916.2 952.8 979.1 6085.1 6163.9 6181.1 6202.0 6292.1 985.9 997.4 1020.7 1026.4 1050.5 3543.3 3745.9 3753.9 3823.0 4099.0 11071.0 11133.9 11360.4 11449.9 11468.6 10609.5 10696.1 10699.6 10729.8 10850.2 8573.7 8622.2 8681.0 8708.4 8780.2 5888.7 6053.4 6085.1 6100.6 6165.6 9769.5 10036.4 10063.1 10111.3 10169.9 9816.6 10355.9 10460.5 10479.8 10735.5 6761.2 7139.9 7623.0 7853.0 7932.6 8401.4 8559.8 8576.7 8642.4 8644.8 7636.8 7773.1 7816.6 7872.2 7881.3 7578.6 7632.9 7659.2 7683.4 7695.4 6130.4 7337.6 7380.7 7405.4 7430.7 4977.2 5032.6 5133.6 5233.4 5238.5 5146.7 5208.3 5246.9 5383.1 5455.8 07:38:07 INFO - PROCESS | 1660 | 07:38:07 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:6157.32 Median:6986.53 stddev:1980.16 (28.3%) stddev-sans-first:1936.98 07:38:07 INFO - PROCESS | 1660 | Values: 340.3 341.9 342.4 348.0 348.4 5995.2 7038.2 7064.1 7111.1 7151.2 6925.8 6928.6 7018.2 7042.4 7072.5 5197.6 5201.8 5225.9 5231.8 5235.5 4954.2 5058.0 5151.7 5187.3 5198.9 5075.3 5082.9 5086.1 5105.9 5148.6 5106.1 5109.6 5122.5 5142.1 5144.0 4400.3 4404.4 4421.2 4427.9 4466.8 6701.2 6785.9 6788.6 6791.9 6809.8 5896.2 6081.2 6081.8 6083.3 6086.6 7429.9 7483.6 7487.1 7494.6 7515.4 4026.8 4936.7 4936.7 4938.7 4952.4 7886.6 7931.3 7932.7 7936.2 7949.9 4593.4 4925.3 5038.1 5044.5 5046.4 5128.4 5140.8 5141.2 5152.4 5160.4 6067.5 6070.5 6077.7 6083.6 6088.3 7587.0 7613.1 7621.7 7624.5 7629.8 1778.9 1800.6 1800.7 1802.7 1806.1 1016.6 1066.6 1155.9 1156.4 1161.5 6958.8 7015.7 7035.1 7035.5 7068.4 6154.0 7691.4 7706.1 7727.5 7754.7 7014.2 7076.9 7148.0 7198.1 7243.9 3337.8 4023.5 4177.5 4182.0 4201.0 8214.5 8223.5 8244.0 8248.6 8268.3 6774.1 6926.8 8124.4 8211.6 8244.1 6677.4 8289.9 8311.7 8320.1 8329.7 7579.9 7851.0 7957.3 7964.7 7976.8 7740.9 7766.5 7772.4 7775.0 7799.3 8273.3 8287.2 8293.0 8296.0 8311.5 4879.2 4939.9 4942.9 4948.6 4955.0 6583.8 7486.6 7846.0 7866.2 7899.5 7535.4 7583.7 7596.2 7623.7 7632.4 7572.6 7584.4 7593.2 7598.4 7609.7 5966.6 7103.0 7401.8 7406.7 7428.2 6393.2 7289.9 7535.7 7594.4 7610.8 7427.7 7429.7 7433.7 7451.8 7482.5 07:38:07 INFO - PROCESS | 1660 | 07:38:07 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:18621.92 Median:550.10 stddev:26338.91 (4788.0%) stddev-sans-first:26378.63 07:38:07 INFO - PROCESS | 1660 | Values: 754.3 760.0 768.9 773.7 788.3 15287.2 15389.8 15534.6 15630.2 15718.7 14368.7 14425.5 14481.6 14496.1 14506.9 763.2 942.6 962.0 965.2 966.6 965.8 975.7 976.7 977.3 978.9 1015.5 1023.8 1036.1 1036.5 1040.6 846.2 1019.0 1025.4 1028.7 1033.0 737.3 743.3 765.5 770.1 770.8 14799.2 14864.4 15154.2 15246.8 15291.5 13259.3 13287.3 13326.4 13443.4 13472.7 10226.8 10261.7 10397.4 10548.2 10636.4 3558.0 3593.9 3634.1 3685.0 3686.6 81954.4 83815.6 83983.0 84884.6 85085.0 9746.2 9753.0 9923.2 10027.2 10095.4 23462.6 23484.0 23488.5 23504.4 23581.9 7608.7 7614.5 7783.0 7836.2 7900.6 4161.6 4195.8 4201.0 4211.9 4215.3 3748.3 3765.7 3816.5 3816.8 3816.8 619.8 649.3 649.9 669.4 690.5 561.9 616.3 618.9 626.6 628.1 5925.8 8363.1 8515.5 8585.1 8638.4 538.3 594.0 628.5 629.8 638.5 3486.6 3993.4 4040.6 4046.9 4081.7 72368.0 92547.0 93036.5 94070.5 96281.5 81431.0 81676.6 81684.0 82975.0 86338.0 74283.0 74845.6 75206.0 75384.9 75643.5 7956.8 8109.4 8219.8 8222.9 8262.3 50790.2 50907.5 51205.7 51846.5 51991.5 63668.0 65092.3 65205.0 65958.7 71316.0 8511.4 10349.2 10360.6 10409.1 10612.8 11152.4 11288.6 11305.9 11516.8 12092.0 10511.5 10605.5 10675.4 11059.7 11075.8 10432.7 10635.7 10674.3 10701.6 10977.0 10560.7 10595.2 10800.4 11103.6 11106.7 8922.5 9114.7 9156.7 9247.0 9536.8 9177.8 9253.2 9273.4 9331.6 9350.6 07:38:07 INFO - PROCESS | 1660 | -------- Summary: end -------- 07:38:07 INFO - PROCESS | 1660 | 07:38:07 INFO - TEST-INFO | 1660: exit 0 07:38:07 INFO - TEST-OK | dromaeo_css | took 1110174ms 07:38:07 INFO - TEST-START | kraken 07:38:07 INFO - operating with platform_type : mac_ 07:38:07 INFO - Initialising browser for kraken test... 07:38:07 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmp5ydmWx/profile http://localhost:49277/getInfo.html) 07:38:10 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 07:38:10 INFO - PROCESS | 1669 | colorDepth:24 07:38:10 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 07:38:10 INFO - PROCESS | 1669 | __metrics 07:38:10 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 07:38:10 INFO - TEST-INFO | 1669: exit 0 07:38:10 INFO - Browser initialized. 07:38:10 INFO - Running cycle 1/1 for kraken test... 07:38:10 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmp5ydmWx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:22 INFO - PROCESS | 1673 | RSS: Main: 171028480 07:38:22 INFO - PROCESS | 1673 | 07:38:25 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 07:38:26 INFO - PROCESS | 1673 | RSS: Main: 183599104 07:38:26 INFO - PROCESS | 1673 | 07:38:28 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 07:38:29 INFO - PROCESS | 1673 | RSS: Main: 192327680 07:38:29 INFO - PROCESS | 1673 | 07:38:32 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 07:38:33 INFO - PROCESS | 1673 | RSS: Main: 195940352 07:38:33 INFO - PROCESS | 1673 | 07:38:35 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 07:38:35 INFO - PROCESS | 1673 | RSS: Main: 197349376 07:38:35 INFO - PROCESS | 1673 | 07:38:38 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:38:38 INFO - PROCESS | 1673 | RSS: Main: 197582848 07:38:38 INFO - PROCESS | 1673 | 07:38:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 07:38:42 INFO - PROCESS | 1673 | RSS: Main: 198119424 07:38:42 INFO - PROCESS | 1673 | 07:38:45 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 07:38:45 INFO - PROCESS | 1673 | RSS: Main: 198025216 07:38:45 INFO - PROCESS | 1673 | 07:38:48 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 07:38:49 INFO - PROCESS | 1673 | RSS: Main: 198008832 07:38:49 INFO - PROCESS | 1673 | 07:38:51 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:38:51 INFO - PROCESS | 1673 | RSS: Main: 197795840 07:38:51 INFO - PROCESS | 1673 | 07:38:53 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:38:54 INFO - PROCESS | 1673 | RSS: Main: 197881856 07:38:54 INFO - PROCESS | 1673 | 07:38:56 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:38:56 INFO - PROCESS | 1673 | RSS: Main: 197988352 07:38:56 INFO - PROCESS | 1673 | 07:38:59 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:39:00 INFO - PROCESS | 1673 | RSS: Main: 197947392 07:39:00 INFO - PROCESS | 1673 | 07:39:03 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:39:03 INFO - PROCESS | 1673 | RSS: Main: 197881856 07:39:03 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 07:39:05 INFO - PROCESS | 1673 | RSS: Main: 199671808 07:39:05 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | __start_tp_report 07:39:05 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 07:39:05 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 07:39:05 INFO - PROCESS | 1673 | |i|pagename|runs| 07:39:05 INFO - PROCESS | 1673 | |0;ai-astar;111;118;108;115;118;118;106;115;116;117 07:39:05 INFO - PROCESS | 1673 | |1;audio-beat-detection;176;111;137;156;162;166;153;164;152;117 07:39:05 INFO - PROCESS | 1673 | |2;audio-dft;194;197;191;199;192;194;191;192;197;223 07:39:05 INFO - PROCESS | 1673 | |3;audio-fft;64;74;108;168;47;49;83;55;131;92 07:39:05 INFO - PROCESS | 1673 | |4;audio-oscillator;77;80;124;76;80;117;126;79;79;120 07:39:05 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;92;88;90;91;90;87;92;90;90;91 07:39:05 INFO - PROCESS | 1673 | |6;imaging-darkroom;95;97;151;151;94;95;98;95;129;152 07:39:05 INFO - PROCESS | 1673 | |7;imaging-desaturate;90;101;107;108;143;128;94;104;151;100 07:39:05 INFO - PROCESS | 1673 | |8;json-parse-financial;61;63;76;95;83;82;91;68;59;63 07:39:05 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;60;64;63;72;68;71;62;79;93;95 07:39:05 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;82;80;79;82;81;80;82;80;81;83 07:39:05 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;145;140;149;128;124;125;123;128;169;177 07:39:05 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;172;163;169;163;164;164;160;181;147;190 07:39:05 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;67;68;70;67;70;67;90;74;60;92 07:39:05 INFO - PROCESS | 1673 | __end_tp_report 07:39:05 INFO - PROCESS | 1673 | __start_cc_report 07:39:05 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1032 07:39:05 INFO - PROCESS | 1673 | __end_cc_report 07:39:05 INFO - PROCESS | 1673 | __startTimestamp1469111945698__endTimestamp 07:39:05 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | ------- Summary: start ------- 07:39:05 INFO - PROCESS | 1673 | Number of tests: 14 07:39:05 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:114.20 Median:116.50 stddev:4.37 (3.7%) stddev-sans-first:4.48 07:39:05 INFO - PROCESS | 1673 | Values: 111.0 118.0 108.0 115.0 118.0 118.0 106.0 115.0 116.0 117.0 07:39:05 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:159.00 stddev:21.33 (13.4%) stddev-sans-first:20.34 07:39:05 INFO - PROCESS | 1673 | Values: 176.0 111.0 137.0 156.0 162.0 166.0 153.0 164.0 152.0 117.0 07:39:05 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:197.00 Median:195.50 stddev:9.55 (4.9%) stddev-sans-first:10.06 07:39:05 INFO - PROCESS | 1673 | Values: 194.0 197.0 191.0 199.0 192.0 194.0 191.0 192.0 197.0 223.0 07:39:05 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:87.10 Median:59.50 stddev:39.08 (65.7%) stddev-sans-first:40.55 07:39:05 INFO - PROCESS | 1673 | Values: 64.0 74.0 108.0 168.0 47.0 49.0 83.0 55.0 131.0 92.0 07:39:05 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:78.00 stddev:22.49 (28.8%) stddev-sans-first:22.80 07:39:05 INFO - PROCESS | 1673 | Values: 77.0 80.0 124.0 76.0 80.0 117.0 126.0 79.0 79.0 120.0 07:39:05 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:90.50 stddev:1.60 (1.8%) stddev-sans-first:1.54 07:39:05 INFO - PROCESS | 1673 | Values: 92.0 88.0 90.0 91.0 90.0 87.0 92.0 90.0 90.0 91.0 07:39:05 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:115.70 Median:95.00 stddev:26.68 (28.1%) stddev-sans-first:27.23 07:39:05 INFO - PROCESS | 1673 | Values: 95.0 97.0 151.0 151.0 94.0 95.0 98.0 95.0 129.0 152.0 07:39:05 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:112.60 Median:135.50 stddev:20.85 (15.4%) stddev-sans-first:20.45 07:39:05 INFO - PROCESS | 1673 | Values: 90.0 101.0 107.0 108.0 143.0 128.0 94.0 104.0 151.0 100.0 07:39:05 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:74.10 Median:79.00 stddev:13.13 (16.6%) stddev-sans-first:13.04 07:39:05 INFO - PROCESS | 1673 | Values: 61.0 63.0 76.0 95.0 83.0 82.0 91.0 68.0 59.0 63.0 07:39:05 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:71.50 stddev:12.56 (17.6%) stddev-sans-first:12.45 07:39:05 INFO - PROCESS | 1673 | Values: 60.0 64.0 63.0 72.0 68.0 71.0 62.0 79.0 93.0 95.0 07:39:05 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.50 stddev:1.25 (1.5%) stddev-sans-first:1.27 07:39:05 INFO - PROCESS | 1673 | Values: 82.0 80.0 79.0 82.0 81.0 80.0 82.0 80.0 81.0 83.0 07:39:05 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:142.50 stddev:19.34 (13.6%) stddev-sans-first:20.46 07:39:05 INFO - PROCESS | 1673 | Values: 145.0 140.0 149.0 128.0 124.0 125.0 123.0 128.0 169.0 177.0 07:39:05 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:166.50 stddev:11.80 (7.1%) stddev-sans-first:12.39 07:39:05 INFO - PROCESS | 1673 | Values: 172.0 163.0 169.0 163.0 164.0 164.0 160.0 181.0 147.0 190.0 07:39:05 INFO - PROCESS | 1673 | 07:39:05 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:70.00 stddev:10.37 (14.8%) stddev-sans-first:10.81 07:39:05 INFO - PROCESS | 1673 | Values: 67.0 68.0 70.0 67.0 70.0 67.0 90.0 74.0 60.0 92.0 07:39:05 INFO - PROCESS | 1673 | -------- Summary: end -------- 07:39:05 INFO - PROCESS | 1673 | 07:39:06 INFO - TEST-INFO | 1673: exit 0 07:39:06 INFO - TEST-OK | kraken | took 58801ms 07:39:06 INFO - SUITE-END | took 1168s 07:39:06 INFO - Completed test suite (00:19:29) 07:39:06 INFO - javascript benchmark 07:39:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2965.2735079905424, 3662.1393972416477, 3697.6487233712787, 3720.125770443946, 3723.1064544509327, 5961.254843144601, 5965.2245208122995, 5966.254218222723, 5987.850303742403, 6014.669193194372, 5890.528757699384, 5981.940180598203, 6020.879582408349, 6031.24609423822, 6071.817845464643, 5337.813176538822, 5339.439358867321, 5339.439358867321, 5443.836684899459, 5527.198556209347, 5357.303550538424, 5405.4324295948945, 5412.323459567554, 5480.3971563128225, 5486.972565137189, 5329.573634109282, 5352.437994010631, 5355.223492593572, 5371.435999220084, 5402.567794576444, 5294.364676238837, 5316.4683531646915, 5337.839864804062, 5365.0, 5370.516653501184, 5224.791008359699, 5269.920951185735, 5282.735863206824, 5293.444188360205, 5331.067063263913, 4466.7716377995985, 5759.769609215627, 5807.709614519299, 5829.650220986754, 5833.7083145842535, 6242.406971337716, 6246.656433896134, 6309.116723658692, 6318.684065796691, 6328.65192414417, 6302.779402720928, 6375.298717141157, 6381.617102973836, 6385.042243663441, 6399.968000160016, 6031.125486804476, 6090.177825993478, 6092.695365231721, 6097.481714054266, 6101.664408457489, 6364.904526432108, 6366.7771627993725, 6412.743490260337, 6478.190226221723, 6511.413972742476, 6297.086922396227, 6300.369963003663, 6312.242530896322, 6312.431881130628, 6315.400036996478, 6321.051842223703, 6336.049592561153, 6343.460805831463, 6354.555181137276, 6365.777197798055, 6190.102435146879, 6207.286162091327, 6240.843978900564, 6269.7178626961895, 6298.716557754912, 5359.678419294854, 6068.120122582201, 6289.811305660837, 6294.15028971083, 6312.873742525124, 5052.343195384577, 5082.593392528589, 5118.411382690963, 5120.334356533627, 5131.820386286462, 4092.0997380576227, 4441.178381999341, 4536.8638940831825, 4602.263637817933, 4651.534846515389, 5870.178175055496, 5938.317093534299, 6109.358517355702, 6118.617310019568, 6126.151269885539, 6357.554971151975, 6361.745530178741, 6394.360563943568, 6420.807375778734, 6421.8073457796345, 4635.930461043087, 4770.069836381942, 5275.5515781158265, 5891.410858914074, 6121.938780612226, 4650.999999999933, 5520.861978450571, 5524.558035357162, 5531.032069387841, 5584.46947539983, 5442.564594832483, 6596.977468492391, 6603.075569420285, 6610.768623098168, 6613.570117942415, 5361.544268737201, 6240.313565507699, 6315.368463153832, 6372.776952806629, 6379.585326953733, 5479.4520547944885, 6583.868322633425, 6607.9669601651685, 6631.1379520662, 6661.700223489857, 6253.437190652863, 6298.653574053288, 6318.589291696025, 6328.335524770017, 6340.968295158495, 6301.495880329654, 6305.274893387319, 6324.715387807468, 6361.14124593174, 6378.107065010995, 6258.280297765815, 6270.874582508415, 6278.843028924313, 6282.2147231596055, 6301.495880329654, 6072.240969878765, 6262.68686565679, 6267.122602835516, 6271.686415679106, 6289.496840252677, 6194.81415557534, 6200.3799620037635, 6221.564490485623, 6244.313125556276, 6250.531210159347, 6168.969155154375, 6264.0, 6281.842953926189, 6287.46556542699, 6330.778422755366, 6127.877442451215, 6170.81487555374, 6247.843803904939, 6251.0, 6269.874602507833], "value": 5821.737097540478, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.5008916930177, 566.0621283197283, 569.9800506982256, 574.0900672434192, 592.1384385718779, 34714.82642586787, 39353.21293574127, 40091.59908400919, 40116.1976760465, 40159.0, 41344.37983430251, 42000.78999605005, 42571.0, 42702.572974270246, 42707.0, 9619.134277915004, 9774.364666296704, 9840.655577054804, 9844.655437059704, 9852.753681157958, 9649.614015439374, 9787.412755234673, 9854.40873547586, 9878.901210987906, 9951.800963980717, 9842.753931151707, 9862.11240988311, 9936.205103591696, 9950.55222514985, 9970.15253703436, 9158.129977652112, 9190.678326258583, 9879.802403951953, 9889.0, 9919.65281215154, 9664.661736839176, 9672.08115229052, 9770.853437198448, 9780.510974451248, 9814.509274536316, 34047.659523404946, 39845.402318965236, 40260.19479610421, 40789.18421631551, 40898.1820363591, 3167.825769582672, 3395.0, 3462.4460086386057, 3893.6495715385468, 3997.8200980955926, 26371.0, 26413.47173056528, 26974.46051078987, 27034.729652703616, 27752.861235693894, 2682.0, 2695.9595606065923, 2715.375463643353, 2736.2748871549056, 2779.4441111777724, 366080.0, 367054.0, 367441.0, 367628.0, 368059.0, 30400.39199216003, 36351.4547281791, 36381.81809090938, 37235.0, 38198.2360352797, 36592.45111323332, 36691.89924302275, 36794.448083278774, 36825.44761828575, 36827.0, 16244.431444899608, 16424.4251451201, 16524.25640846165, 16617.91691041537, 16639.83360166407, 13954.0, 13955.441782328593, 14061.0, 14063.2968351582, 14073.0, 6939.791806245821, 8220.917790822135, 8296.087430382653, 8421.663133474593, 8435.029971553227, 3214.1321843102232, 3462.290230502741, 3472.5485686860548, 3560.0, 3575.6245594212755, 1072.2708558180511, 1098.527633117751, 1124.5389390349917, 1206.3485717712338, 1211.6062279758937, 30500.84749576238, 31153.0, 31492.685073148976, 31522.52716209259, 31630.841845790623, 932.128459890005, 944.8252073366449, 1025.4565080507343, 1068.8129577324094, 1161.8663853656938, 12630.0, 15921.681566368608, 15938.60153496172, 15942.521724348288, 16380.918095409446, 579806.4038719287, 582346.0, 617623.0, 621730.0, 621767.0, 63511.0, 63519.36480635227, 64419.0, 64550.0, 64630.353696463375, 1487.2192099148033, 1555.0, 1568.3648122510174, 1575.7951466309535, 1591.7981923647571, 25920.740792592587, 30432.239194020327, 30545.26548385004, 30663.0, 30727.846360768053, 54969.0, 55637.721811390686, 55844.72077639586, 56067.878642426105, 56223.0, 509698.0, 549047.0, 549130.0, 552175.0, 552505.0, 27309.72690273072, 28435.715642844134, 28783.424331512833, 28900.27749306284, 28904.566431503965, 47796.04407911892, 48196.0, 48937.0, 49244.0, 49256.0, 32757.34485310328, 39053.0, 40144.397834033094, 40327.0, 40676.3898541528, 38739.97765917835, 38951.0, 39633.60366396299, 39745.80127099346, 40511.392329115675, 34193.829030854686, 38621.0, 38993.41509877411, 39636.80181599074, 39675.80162099171, 30021.699783002765, 32580.34839303248, 33391.83304083464, 33690.32619347648, 33723.66276337303, 25285.0, 25642.0, 25711.0, 25987.401259873863, 26021.349466263495], "value": 18650.402154675354, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.1324219139807, 413.40263319503293, 413.85308215583484, 424.08609446642487, 424.2977871622464, 20771.0, 21461.356159315226, 21506.56986860262, 21697.783022169773, 22768.316950491513, 12487.25076495411, 12599.937000314985, 12865.485380584765, 12913.677158071054, 12968.0, 5275.340582427197, 5516.503514683678, 5569.610127291091, 5583.274174357328, 5587.580931430139, 5464.972675136619, 5467.371252305996, 5959.642421454727, 6079.665618390986, 6123.571350005502, 5880.470757631833, 6008.909866352008, 6025.969870150643, 6047.516198704115, 6070.6661133637635, 5352.411234764173, 5386.515213630772, 5498.752556134964, 5502.284702988626, 5992.250968628921, 5275.997560463499, 5346.251524786533, 5366.731663416853, 5367.06076436626, 5373.570114390839, 14273.714525709427, 14337.21145337006, 14436.711265774626, 14678.706425871424, 14714.484993025193, 2089.770125286217, 2122.0450797141193, 2190.1896298369547, 2301.4016355747626, 2830.3631682871396, 8456.788580285542, 10151.94924025375, 10248.846267305997, 10414.687559373231, 10572.947135264352, 1656.287796247613, 1797.4607617714764, 1818.5544541587265, 1819.3632228719976, 1862.2644055598098, 106112.93887061108, 106229.93770062277, 106553.0, 109864.45067774689, 111269.0, 12148.878511214774, 12254.264744115382, 12272.447739851728, 12403.25580465175, 12431.254124752544, 14210.360533776005, 14580.927095364455, 15668.843311566738, 15846.683066338608, 15855.286512106983, 9250.4912229828, 9439.480828554495, 9454.14912657864, 9472.479013654178, 9489.1934185595, 8024.879626805603, 9032.63869445215, 9413.57638906251, 9430.858537121949, 9466.432014079177, 4875.781054736316, 4953.975230123899, 5001.099802035668, 5003.774830132653, 5025.597952163818, 2044.703517989883, 2089.9268525601533, 2091.937241882746, 2113.6618141097656, 2159.4709296222213, 846.6909578003985, 911.1389736698756, 935.7333160049353, 1015.5227043289642, 1091.2143256855052, 19924.90037549803, 20925.37223883286, 21182.894085529475, 21397.893010535157, 22461.43846403853, 946.5409276500892, 975.8243516167158, 995.7759504111661, 1034.8085604163255, 1085.7177133945231, 10697.0, 11485.483153258123, 11497.482613282422, 11520.481578328996, 11732.648020559396, 660271.0, 661066.0, 678206.0, 678373.0, 680465.0, 79178.0, 124106.5178696421, 138651.0, 139260.0, 142460.0, 1047.9895201048043, 1096.4517741129434, 1112.7663190730038, 1117.6088369070924, 1121.0807138146643, 17935.0, 18137.818621813614, 18230.45308640743, 18488.890666560048, 18885.0, 37263.88208353754, 51104.0, 51924.74037629788, 54532.18201727056, 57817.843643127744, 79204.60397697975, 80899.0, 81736.59131704542, 82754.75867861866, 83418.58290708507, 7145.1425828900865, 8162.7143049992965, 8513.531755753245, 8591.6992905248, 8696.565171741515, 10911.563537458413, 12611.0, 12809.807852882028, 12926.806097908728, 13135.408906599036, 10974.670759877217, 11156.553737850396, 11203.943980280046, 11248.0, 11319.886801131883, 9141.268698504236, 10435.37387756737, 10814.35113893169, 11007.789143194403, 11222.158338124511, 10771.946140269249, 10927.235093543693, 11186.888131118585, 11221.943890280496, 11628.534858605899, 8174.346052315682, 8306.418550701394, 8371.037330707046, 8423.241908228289, 8426.073131955603, 9997.950010250193, 10785.029347358775, 10860.728481788019, 11045.28205666629, 11071.446427678746], "value": 9468.422281755611, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1662.069241224914, 1686.485621885325, 1981.9603607927843, 2030.0661695620015, 2123.957520849582, 8370.037445693748, 8962.148595883396, 9261.79596652435, 9467.10062544059, 9491.288153388497, 9083.31875109366, 9109.04355042721, 9195.494247816367, 9212.94051184114, 9261.398009129402, 2494.6133349330885, 2502.3493891588137, 2523.5962246040635, 2534.7085085215253, 2535.2140836340795, 2497.7502249774966, 2533.8353007054484, 2544.134994102005, 2547.630593563932, 2549.2352294311727, 2183.2140429445385, 2489.7136829264687, 2519.105717470299, 2559.9360015999655, 2571.074413211252, 2516.7986561075163, 2520.5589021921273, 2539.1874600127967, 2543.4023004593905, 2569.832960857538, 2515.1448507507534, 2544.70735865376, 2550.5664037113734, 2563.1669707345, 2563.871806409672, 9332.580033898423, 9346.813063738688, 9381.812363752755, 9387.10822471864, 9391.812163756755, 5589.189567512729, 5623.128415095667, 5740.425957404268, 5779.711014449261, 5792.4497172768515, 3559.750817442754, 3692.132348898007, 3701.3337599232127, 3711.832967516468, 3761.341765191108, 1036.1710631494775, 1050.165118730611, 1057.3285963413211, 1062.596213438896, 1067.0876400677464, 12109.697257568543, 12120.45457954394, 12150.756984860252, 12343.321117338543, 12634.620961371174, 4907.87730306738, 4982.77577509013, 5015.623828212899, 5093.745312734349, 5115.155999260155, 10489.213309001703, 10565.735856603646, 10578.629747958785, 10601.416922069206, 10625.681229563126, 5688.8862222755315, 5689.0328644130595, 5733.541316694655, 5736.77052917887, 5740.052891272977, 4566.908661826745, 5013.799448022111, 5073.061483625541, 5185.403678576937, 5187.429382767892, 4206.47419072616, 4213.1784302061415, 4225.830966761357, 4236.9364459533135, 4261.126469073833, 1413.3851774478135, 1423.992880035593, 1430.7138572285585, 1436.0235040172574, 1442.1203066129654, 848.7284069097952, 860.3848248502351, 916.2029034739819, 952.7760976170595, 979.060102301784, 6085.117657939574, 6163.907541386883, 6181.134641150243, 6202.0, 6292.056191571301, 985.8915519292872, 997.4015590645555, 1020.6886899495577, 1026.3585259212991, 1050.5325130317087, 3543.309054734302, 3745.887623371303, 3753.9061523462133, 3823.044238940265, 4099.0, 11071.0, 11133.888661113286, 11360.375179365214, 11449.942750286194, 11468.598599048993, 10609.469526523642, 10696.090832279187, 10699.572017119228, 10729.78540429187, 10850.186236032172, 8573.699920502753, 8622.223999840044, 8681.0, 8708.433951793113, 8780.165884240987, 5888.676122813286, 6053.364396738279, 6085.056816193497, 6100.6339619621185, 6165.599236049642, 9769.511524423893, 10036.397816131055, 10063.144632706302, 10111.292209545261, 10169.9491502542, 9816.55825487869, 10355.896441035795, 10460.529276182438, 10479.790404192026, 10735.516901739597, 6761.188657361148, 7139.892901606584, 7622.961885190539, 7852.960735196288, 7932.6430310637315, 8401.411901166859, 8559.786005349915, 8576.65693372283, 8642.351823613128, 8644.827103458021, 7636.80907977305, 7773.144954055162, 7816.609169541386, 7872.212778722082, 7881.251281128284, 7578.621068946641, 7632.923670763222, 7659.195784442553, 7683.385329173764, 7695.422843286664, 6130.356312587292, 7337.59643219628, 7380.667869945973, 7405.444591655755, 7430.665620047002, 4977.178765503651, 5032.647714659939, 5133.640645154804, 5233.424323324355, 5238.5023422774775, 5146.665466744649, 5208.296879921162, 5246.947530524799, 5383.138697808332, 5455.754491047833], "value": 4824.146127737712, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.29219224014054, 341.94357930941396, 342.41105298885924, 347.98086105264207, 348.42509858733104, 5995.220621319228, 7038.155421349439, 7064.116985376828, 7111.146662400519, 7151.213366529678, 6925.792226233209, 6928.618925959083, 7018.227994920555, 7042.366187043165, 7072.504924655276, 5197.636165468419, 5201.765920533576, 5225.947740522603, 5231.79072837088, 5235.502627250406, 4954.207326827708, 5058.0, 5151.665141765792, 5187.273781670569, 5198.896022079556, 5075.340205773245, 5082.949170508303, 5086.135356989321, 5105.923411148836, 5148.5881129509735, 5106.131957567204, 5109.64232503723, 5122.538971492546, 5142.07442660321, 5144.022635699205, 4400.295952647593, 4404.361367601679, 4421.248387774086, 4427.911441771179, 4466.7766611669285, 6701.229358623772, 6785.864282714368, 6788.59268443895, 6791.932080679179, 6809.761658341934, 5896.174535565025, 6081.209442772455, 6081.787137450212, 6083.330833608299, 6086.573939824214, 7429.9257007430315, 7483.578120157153, 7487.1389790173735, 7494.550326980344, 7515.398768098539, 4026.838926442939, 4936.703797772145, 4936.728479933602, 4938.654294199408, 4952.430470495903, 7886.566238856861, 7931.325837303836, 7932.7223547176145, 7936.246056624612, 7949.920500795034, 4593.402857628487, 4925.335079764258, 5038.093143234253, 5044.54599086084, 5046.369203849519, 5128.358955130609, 5140.820071297487, 5141.2288156776785, 5152.407473140637, 5160.354955630546, 6067.453929146398, 6070.484008859208, 6077.696115194222, 6083.6045657032155, 6088.330283668793, 7587.0, 7613.124490683532, 7621.6570254338685, 7624.504407213513, 7629.847403051908, 1778.8704172850075, 1800.5768644368563, 1800.6578750037452, 1802.7025540785885, 1806.096951524238, 1016.598443614768, 1066.632011955874, 1155.930644161353, 1156.410230782307, 1161.465725766157, 6958.826029349206, 7015.684294206773, 7035.085438892911, 7035.47233957445, 7068.434525237969, 6154.0, 7691.423143264277, 7706.07527096752, 7727.497712648772, 7754.728584499516, 7014.22843487216, 7076.903080022502, 7148.035015272975, 7198.136223653195, 7243.913412988094, 3337.7830441021256, 4023.4970628671417, 4177.4778152730905, 4181.979090104591, 4201.033762234703, 8214.548199848947, 8223.465474744242, 8244.0, 8248.587570621565, 8268.2558569729, 6774.051632771416, 6926.826829329307, 8124.390670699721, 8211.58942052895, 8244.134365891616, 6677.3656502632175, 8289.917100828914, 8311.709090181814, 8320.126386729427, 8329.708460203863, 7579.924200757921, 7851.016613686763, 7957.323627491728, 7964.721234756756, 7976.840463190588, 7740.883886741816, 7766.456348055582, 7772.378209743094, 7775.0, 7799.298063174341, 8273.255407013397, 8287.171282871665, 8293.046299675614, 8295.95852020736, 8311.459755115899, 4879.194932836042, 4939.8885250818275, 4942.851714448572, 4948.62885283598, 4955.0, 6583.835404114935, 7486.588237646982, 7846.0, 7866.213378662317, 7899.526028438312, 7535.359494442814, 7583.696652134074, 7596.202398748052, 7623.733169339046, 7632.351250143578, 7572.621368931421, 7584.393248540214, 7593.202713714981, 7598.354139898171, 7609.6575654094595, 5966.552508561788, 7102.964485177541, 7401.777946661608, 7406.740764073232, 7428.182899880901, 6393.2328120625825, 7289.942958271127, 7535.73624923125, 7594.430417718582, 7610.771676849703, 7427.665755041145, 7429.665665045194, 7433.739819106306, 7451.776446706607, 7482.513636613603], "value": 5493.20615002295, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.3060384446309, 759.9740350526788, 768.896199013133, 773.7021246819972, 788.2708494642455, 15287.159206243652, 15389.846101538995, 15534.611634709137, 15630.218489075543, 15718.685626287468, 14368.712625747505, 14425.495107671233, 14481.63795905103, 14496.130232186077, 14506.927465362685, 763.2329508843618, 942.5805516545106, 962.0427674463918, 965.2037069417723, 966.6375109334, 965.7971825916566, 975.7072878136566, 976.7362812040781, 977.3402953006728, 978.9021097890226, 1015.527779582494, 1023.8413045977885, 1036.0675392147052, 1036.512838965685, 1040.5577629507468, 846.2299307630088, 1018.9796204075914, 1025.3898930136556, 1028.7479567505934, 1032.9845052324222, 737.3032484302337, 743.2567432567432, 765.490948519234, 770.1182146442349, 770.7649167004062, 14799.186044767534, 14864.405423783035, 15154.166520841349, 15246.771298430533, 15291.541253762405, 13259.27074010929, 13287.335633218301, 13326.400311985984, 13443.395047222899, 13472.652734726547, 10226.846597300972, 10261.692149235534, 10397.376157430579, 10548.156147508182, 10636.414997175152, 3558.0, 3593.8562457501666, 3634.0733113056267, 3685.0418891088243, 3686.5760437549757, 81954.36091278141, 83815.580922095, 83983.0, 84884.57557712233, 85085.0, 9746.220302375792, 9752.951235243778, 9923.156531694742, 10027.197824174049, 10095.444750538643, 23462.64806027911, 23484.0, 23488.53022939566, 23504.412389690395, 23581.88209058944, 7608.733694320672, 7614.543127412373, 7782.961085194538, 7836.216378362118, 7900.644470998819, 4161.583841615814, 4195.832166713297, 4201.0, 4211.852585159505, 4215.346621273708, 3748.2690875279604, 3765.661090501868, 3816.5420149581673, 3816.770993740329, 3816.809159542012, 619.8326451857973, 649.2922714241499, 649.8862699027651, 669.3741351836048, 690.5028379566704, 561.9185218143429, 616.3374372549438, 618.8607563298312, 626.6021076616381, 628.0892705576932, 5925.822225333247, 8363.121872203452, 8515.531645759418, 8585.080913543168, 8638.35212359063, 538.2760187547821, 594.005041555393, 628.544305378606, 629.754395785644, 638.524299396943, 3486.6299548544234, 3993.3610622300293, 4040.616141466556, 4046.858359957387, 4081.7142800003717, 72368.0, 92547.0, 93036.53481732548, 94070.52964735133, 96281.51859240659, 81431.0, 81676.59161704272, 81684.0, 82975.0, 86338.0, 74283.0, 74845.62577187188, 75205.99999999891, 75384.86922696054, 75643.48713025708, 7956.84086318282, 8109.3917956152345, 8219.83560328802, 8222.876656850032, 8262.256396924306, 50790.22234221784, 50907.49092509028, 51205.7439712799, 51846.481535185674, 51991.480085198666, 63668.0, 65092.34907651052, 65205.0, 65958.67020664866, 71316.0, 8511.404201705822, 10349.172066234834, 10360.637377691744, 10409.063184313449, 10612.787744245226, 11152.386618736047, 11288.604898828502, 11305.886941130813, 11516.82724759146, 12091.972182364598, 10511.526981286013, 10605.469726513798, 10675.359478431319, 11059.723506912069, 11075.83386249223, 10432.68701938943, 10635.734106647396, 10674.306170098918, 10701.571937122428, 10976.957189067025, 10560.683179504627, 10595.205359597907, 10800.351978881292, 11103.611373601885, 11106.666799996014, 8922.509261990654, 9114.726558203265, 9156.679516217167, 9246.95376523113, 9536.809263814546, 9177.816443671223, 9253.213476854273, 9273.397229180351, 9331.626734930527, 9350.579223935076], "value": 7037.133635289587, "unit": "score"}], "name": "dromaeo_css", "value": 7593.616473119217, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 118.0, 108.0, 115.0, 118.0, 118.0, 106.0, 115.0, 116.0, 117.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 111.0, 137.0, 156.0, 162.0, 166.0, 153.0, 164.0, 152.0, 117.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 197.0, 191.0, 199.0, 192.0, 194.0, 191.0, 192.0, 197.0, 223.0], "value": 197.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 108.0, 168.0, 47.0, 49.0, 83.0, 55.0, 131.0, 92.0], "value": 87.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 124.0, 76.0, 80.0, 117.0, 126.0, 79.0, 79.0, 120.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 90.0, 91.0, 90.0, 87.0, 92.0, 90.0, 90.0, 91.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 151.0, 151.0, 94.0, 95.0, 98.0, 95.0, 129.0, 152.0], "value": 115.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 101.0, 107.0, 108.0, 143.0, 128.0, 94.0, 104.0, 151.0, 100.0], "value": 112.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 76.0, 95.0, 83.0, 82.0, 91.0, 68.0, 59.0, 63.0], "value": 74.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 63.0, 72.0, 68.0, 71.0, 62.0, 79.0, 93.0, 95.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 79.0, 82.0, 81.0, 80.0, 82.0, 80.0, 81.0, 83.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 140.0, 149.0, 128.0, 124.0, 125.0, 123.0, 128.0, 169.0, 177.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 163.0, 169.0, 163.0, 164.0, 164.0, 160.0, 181.0, 147.0, 190.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 67.0, 70.0, 67.0, 90.0, 74.0, 60.0, 92.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1570.3, "alertThreshold": 2.0}]} 07:39:06 INFO - Return code: 0 07:39:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:39:06 ERROR - # TBPL SUCCESS # 07:39:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:39:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:39:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:39:07 INFO - 2016-07-21 07:39:07.014 screenresolution[1678:10602] starting screenresolution argv=screenresolution get 07:39:07 INFO - 2016-07-21 07:39:07.017 screenresolution[1678:10602] Display 0: 1600x1200x32@60 07:39:07 INFO - 2016-07-21 07:39:07.022 screenresolution[1679:10605] starting screenresolution argv=screenresolution list 07:39:07 INFO - Available Modes on Display 0 07:39:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:39:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:39:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:39:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:39:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:39:07 INFO - Intel Iris: 07:39:07 INFO - Chipset Model: Intel Iris 07:39:07 INFO - Type: GPU 07:39:07 INFO - Bus: Built-In 07:39:07 INFO - VRAM (Dynamic, Max): 1536 MB 07:39:07 INFO - Vendor: Intel (0x8086) 07:39:07 INFO - Device ID: 0x0a2e 07:39:07 INFO - Revision ID: 0x0009 07:39:07 INFO - Displays: 07:39:07 INFO - Display: 07:39:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:39:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:39:07 INFO - Display Serial Number: 1600x1200 60 07:39:07 INFO - Main Display: Yes 07:39:07 INFO - Mirror: Off 07:39:07 INFO - Online: Yes 07:39:07 INFO - Rotation: Supported 07:39:07 INFO - Return code: 0 07:39:07 INFO - Running post-action listener: _resource_record_post_action 07:39:07 INFO - Running post-run listener: _resource_record_post_run 07:39:08 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 36976128; Write bytes: 496137216; Read time: 245; Write time: 1585 07:39:08 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 195823616; Write bytes: 184774656; Read time: 17488; Write time: 417 07:39:08 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 29879808; Write bytes: 300569600; Read time: 183; Write time: 1134 07:39:08 INFO - Running post-run listener: _upload_blobber_files 07:39:08 INFO - Blob upload gear active. 07:39:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:39:08 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 07:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:39:08 INFO - (blobuploader) - INFO - Open directory for files ... 07:39:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:39:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:39:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:09 INFO - (blobuploader) - INFO - Done attempting. 07:39:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:39:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:39:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:10 INFO - (blobuploader) - INFO - Done attempting. 07:39:10 INFO - (blobuploader) - INFO - Iteration through files over. 07:39:10 INFO - Return code: 0 07:39:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:39:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:39:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e939529355078044a735226e7c043b1db939e60e29e63b0aedfd3e29e402d250aa7037ff5ed726c6a6efe8a09243f8969c2d6bdddccc1fb5846c27f122224bd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb086eddbf2c456058b672f356039bfb07d346db09dfff42a9b66ec4570a4832723ea137d91bf6fa766619b08e37b03174d052adaab190e1586c9810a5dbfb4d"} 07:39:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:39:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:39:10 INFO - Contents: 07:39:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e939529355078044a735226e7c043b1db939e60e29e63b0aedfd3e29e402d250aa7037ff5ed726c6a6efe8a09243f8969c2d6bdddccc1fb5846c27f122224bd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb086eddbf2c456058b672f356039bfb07d346db09dfff42a9b66ec4570a4832723ea137d91bf6fa766619b08e37b03174d052adaab190e1586c9810a5dbfb4d"} 07:39:10 INFO - Running post-run listener: copy_logs_to_upload_dir 07:39:10 INFO - Copying logs to upload dir... 07:39:10 INFO - mkdir: /builds/slave/test/build/upload/logs 07:39:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.083485 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-21 07:39:10.849805) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 07:39:10.853464) ========= 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.uNTWNXvBWg/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.Io5tlUbbsj/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e939529355078044a735226e7c043b1db939e60e29e63b0aedfd3e29e402d250aa7037ff5ed726c6a6efe8a09243f8969c2d6bdddccc1fb5846c27f122224bd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb086eddbf2c456058b672f356039bfb07d346db09dfff42a9b66ec4570a4832723ea137d91bf6fa766619b08e37b03174d052adaab190e1586c9810a5dbfb4d"} build_url:https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011035 build_url: 'https://queue.taskcluster.net/v1/task/S2iai0vQT4OMC1m2JbPogg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e939529355078044a735226e7c043b1db939e60e29e63b0aedfd3e29e402d250aa7037ff5ed726c6a6efe8a09243f8969c2d6bdddccc1fb5846c27f122224bd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb086eddbf2c456058b672f356039bfb07d346db09dfff42a9b66ec4570a4832723ea137d91bf6fa766619b08e37b03174d052adaab190e1586c9810a5dbfb4d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 07:39:10.889403) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:39:10.890131) ========= 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.uNTWNXvBWg/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.Io5tlUbbsj/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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.005261 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 07:39:10.941165) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 07:39:10.941496) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 07:39:10.941860) ========= ========= Total master_lag: 1.39 =========