builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0389 starttime: 1466439858.46 results: success (0) buildid: 20160620070425 builduid: 6b5e7b7430ee456c8f22171c26de6907 revision: 11986e1994456d9d8c4a006caa8e15bd1c8410f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 09:24:18.460592) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 09:24:18.461140) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 09:24:18.461428) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 09:24:18.486204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 09:24:18.486573) ========= 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.fo93KodIXq/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.TdlFDi7ffU/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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-06-20 09:24:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.7M=0.001s 2016-06-20 09:24:18 (18.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131701 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 09:24:18.640388) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 09:24:18.640821) ========= 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.fo93KodIXq/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.TdlFDi7ffU/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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.025359 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 09:24:18.690774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-06-20 09:24:18.691165) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 11986e1994456d9d8c4a006caa8e15bd1c8410f1 --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 11986e1994456d9d8c4a006caa8e15bd1c8410f1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fo93KodIXq/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.TdlFDi7ffU/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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-06-20 09:24:18,775 truncating revision to first 12 chars 2016-06-20 09:24:18,775 Setting DEBUG logging. 2016-06-20 09:24:18,775 attempt 1/10 2016-06-20 09:24:18,775 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/11986e199445?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-20 09:24:20,538 unpacking tar archive at: mozilla-beta-11986e199445/testing/mozharness/ program finished with exit code 0 elapsedTime=2.050848 ========= master_lag: 1.37 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-06-20 09:24:22.116200) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 09:24:22.116567) ========= script_repo_revision: 11986e1994456d9d8c4a006caa8e15bd1c8410f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 09:24:22.117070) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 09:24:22.117367) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 09:24:22.149242) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-20 09:24:22.149634) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fo93KodIXq/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.TdlFDi7ffU/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:24:22 INFO - MultiFileLogger online at 20160620 09:24:22 in /builds/slave/test 09:24:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:24:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:24:22 INFO - {'append_to_log': False, 09:24:22 INFO - 'base_work_dir': '/builds/slave/test', 09:24:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:24:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:24:22 INFO - 'branch': 'Mozilla-Beta', 09:24:22 INFO - 'buildbot_json_path': 'buildprops.json', 09:24:22 INFO - 'config_files': ('talos/mac_config.py',), 09:24:22 INFO - 'default_actions': ('clobber', 09:24:22 INFO - 'read-buildbot-config', 09:24:22 INFO - 'download-and-extract', 09:24:22 INFO - 'populate-webroot', 09:24:22 INFO - 'create-virtualenv', 09:24:22 INFO - 'install', 09:24:22 INFO - 'run-tests'), 09:24:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:24:22 INFO - 'download_minidump_stackwalk': True, 09:24:22 INFO - 'download_symbols': 'ondemand', 09:24:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:24:22 INFO - 'tooltool.py': '/tools/tooltool.py', 09:24:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:24:22 INFO - '/tools/misc-python/virtualenv.py')}, 09:24:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:24:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:24:22 INFO - 'installer_path': 'installer.exe', 09:24:22 INFO - 'log_level': 'info', 09:24:22 INFO - 'log_name': 'talos', 09:24:22 INFO - 'log_to_console': True, 09:24:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:24:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:24:22 INFO - 'opt_config_files': (), 09:24:22 INFO - 'pip_index': False, 09:24:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:24:22 INFO - 'cmd': ('bash', 09:24:22 INFO - '-c', 09:24:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:24:22 INFO - 'enabled': True, 09:24:22 INFO - 'halt_on_failure': False, 09:24:22 INFO - 'name': 'check_screen_resolution'},), 09:24:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:24:22 INFO - 'cmd': ('bash', 09:24:22 INFO - '-c', 09:24:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:24:22 INFO - 'enabled': True, 09:24:22 INFO - 'halt_on_failure': False, 09:24:22 INFO - 'name': 'check_screen_resolution'},), 09:24:22 INFO - 'run_cmd_checks_enabled': True, 09:24:22 INFO - 'sps_profile': False, 09:24:22 INFO - 'sps_profile_interval': 0, 09:24:22 INFO - 'suite': 'dromaeojs', 09:24:22 INFO - 'system_bits': '32', 09:24:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:24:22 INFO - 'title': 't-yosemite-r7-0389', 09:24:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:24:22 INFO - 'use_talos_json': True, 09:24:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:24:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:24:22 INFO - 'work_dir': 'build'} 09:24:22 INFO - ##### 09:24:22 INFO - ##### Running clobber step. 09:24:22 INFO - ##### 09:24:22 INFO - Running pre-action listener: _resource_record_pre_action 09:24:22 INFO - Running main action method: clobber 09:24:22 INFO - rmtree: /builds/slave/test/build 09:24:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:24:24 INFO - Running post-action listener: _resource_record_post_action 09:24:24 INFO - ##### 09:24:24 INFO - ##### Running read-buildbot-config step. 09:24:24 INFO - ##### 09:24:24 INFO - Running pre-action listener: _resource_record_pre_action 09:24:24 INFO - Running main action method: read_buildbot_config 09:24:24 INFO - Using buildbot properties: 09:24:24 INFO - { 09:24:24 INFO - "project": "", 09:24:24 INFO - "product": "firefox", 09:24:24 INFO - "script_repo_revision": "production", 09:24:24 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:24:24 INFO - "repository": "", 09:24:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:24:24 INFO - "buildid": "20160620070425", 09:24:24 INFO - "pgo_build": "False", 09:24:24 INFO - "basedir": "/builds/slave/test", 09:24:24 INFO - "buildnumber": 8, 09:24:24 INFO - "slavename": "t-yosemite-r7-0389", 09:24:24 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:24:24 INFO - "platform": "yosemite_r7", 09:24:24 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:24:24 INFO - "branch": "mozilla-beta", 09:24:24 INFO - "repo_path": "releases/mozilla-beta", 09:24:24 INFO - "revision": "11986e1994456d9d8c4a006caa8e15bd1c8410f1", 09:24:24 INFO - "stage_platform": "macosx64", 09:24:24 INFO - "builduid": "6b5e7b7430ee456c8f22171c26de6907", 09:24:24 INFO - "slavebuilddir": "test" 09:24:24 INFO - } 09:24:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 09:24:24 INFO - Running post-action listener: _resource_record_post_action 09:24:24 INFO - ##### 09:24:24 INFO - ##### Running download-and-extract step. 09:24:24 INFO - ##### 09:24:24 INFO - Running pre-action listener: _resource_record_pre_action 09:24:24 INFO - Running main action method: download_and_extract 09:24:24 INFO - mkdir: /builds/slave/test/build/tests 09:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:24 INFO - https://queue.taskcluster.net/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:24:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 09:24:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 09:24:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/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 09:24:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/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 09:24:26 INFO - Downloaded 1165 bytes. 09:24:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 09:24:26 INFO - Using the following test package requirements: 09:24:26 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 09:24:26 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:24:26 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 09:24:26 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:24:26 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 09:24:26 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:24:26 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:24:26 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 09:24:26 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 09:24:26 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:24:26 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 09:24:26 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:24:26 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 09:24:26 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:24:26 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 09:24:26 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:24:26 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 09:24:26 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 09:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:26 INFO - https://queue.taskcluster.net/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:24:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:24:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:24:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/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 09:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/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 09:24:27 INFO - Downloaded 18300418 bytes. 09:24:27 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'] 09:24:27 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 09:24:30 INFO - Return code: 0 09:24:30 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 09:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:30 INFO - https://queue.taskcluster.net/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:24:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:24:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:24:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/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 09:24:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/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 09:24:31 INFO - Downloaded 18300418 bytes. 09:24:31 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'] 09:24:31 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 09:24:34 INFO - Return code: 0 09:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:34 INFO - https://queue.taskcluster.net/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:24:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 09:24:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 09:24:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/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 09:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/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 09:24:36 INFO - Downloaded 10840145 bytes. 09:24:36 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'] 09:24:36 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 09:24:37 INFO - Return code: 0 09:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:37 INFO - https://queue.taskcluster.net/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 09:24:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:24:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:24:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 09:24:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CY5ymJFDQA6-Yt661TadUQ/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 09:24:39 INFO - Downloaded 86249420 bytes. 09:24:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:24:39 INFO - mkdir: /builds/slave/test/properties 09:24:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:24:39 INFO - Writing to file /builds/slave/test/properties/build_url 09:24:39 INFO - Contents: 09:24:39 INFO - build_url:https://queue.taskcluster.net/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:24:41 INFO - Running post-action listener: _resource_record_post_action 09:24:41 INFO - Running post-action listener: set_extra_try_arguments 09:24:41 INFO - ##### 09:24:41 INFO - ##### Running populate-webroot step. 09:24:41 INFO - ##### 09:24:41 INFO - Running pre-action listener: _resource_record_pre_action 09:24:41 INFO - Running main action method: populate_webroot 09:24:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:24:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:24:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:24:41 INFO - '--tppagecycles', 09:24:41 INFO - '7'], 09:24:41 INFO - 'tests': ['tsvgm']}}, 09:24:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:24:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:24:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:24:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:24:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:24:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:24:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:41 INFO - 'talos_options': ['--disable-e10s'], 09:24:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:41 INFO - 'talos_options': ['--disable-e10s'], 09:24:41 INFO - 'tests': ['damp', 'tps']}, 09:24:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:41 INFO - 'tests': ['damp', 'tps']}, 09:24:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:24:41 INFO - 'tests': ['dromaeo_dom']}, 09:24:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:24:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:24:41 INFO - 'tests': ['a11yr', 09:24:41 INFO - 'ts_paint', 09:24:41 INFO - 'tpaint', 09:24:41 INFO - 'sessionrestore', 09:24:41 INFO - 'sessionrestore_no_auto_restore', 09:24:41 INFO - 'tabpaint']}, 09:24:41 INFO - 'other-e10s': {'tests': ['a11yr', 09:24:41 INFO - 'ts_paint', 09:24:41 INFO - 'tpaint', 09:24:41 INFO - 'sessionrestore', 09:24:41 INFO - 'sessionrestore_no_auto_restore', 09:24:41 INFO - 'tabpaint']}, 09:24:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:24:41 INFO - 'ts_paint', 09:24:41 INFO - 'tpaint', 09:24:41 INFO - 'sessionrestore', 09:24:41 INFO - 'sessionrestore_no_auto_restore', 09:24:41 INFO - 'tabpaint']}, 09:24:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:24:41 INFO - 'ts_paint', 09:24:41 INFO - 'tpaint', 09:24:41 INFO - 'sessionrestore', 09:24:41 INFO - 'sessionrestore_no_auto_restore', 09:24:41 INFO - 'tabpaint']}, 09:24:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:24:41 INFO - 'tests': ['a11yr', 09:24:41 INFO - 'ts_paint', 09:24:41 INFO - 'tpaint', 09:24:41 INFO - 'sessionrestore', 09:24:41 INFO - 'sessionrestore_no_auto_restore', 09:24:41 INFO - 'tabpaint']}, 09:24:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:24:41 INFO - 'tests': ['a11yr', 09:24:41 INFO - 'ts_paint', 09:24:41 INFO - 'tpaint', 09:24:41 INFO - 'sessionrestore', 09:24:41 INFO - 'sessionrestore_no_auto_restore', 09:24:41 INFO - 'tabpaint']}, 09:24:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:24:41 INFO - 'tests': ['tsvgx', 09:24:41 INFO - 'tsvgr_opacity', 09:24:41 INFO - 'tart', 09:24:41 INFO - 'tscrollx', 09:24:41 INFO - 'cart']}, 09:24:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:24:41 INFO - 'tsvgr_opacity', 09:24:41 INFO - 'tart', 09:24:41 INFO - 'tscrollx', 09:24:41 INFO - 'cart']}, 09:24:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:41 INFO - 'talos_options': ['--disable-e10s'], 09:24:41 INFO - 'tests': ['tp5o']}, 09:24:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:41 INFO - 'tests': ['tp5o']}, 09:24:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:41 INFO - 'talos_options': ['--disable-e10s', 09:24:41 INFO - '--xperf_path', 09:24:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:41 INFO - 'tests': ['tp5n']}, 09:24:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:41 INFO - 'talos_options': ['--xperf_path', 09:24:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:41 INFO - 'tests': ['tp5n']}}, 09:24:41 INFO - 'talos.zip': {'path': '', 09:24:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:24:41 INFO - Running post-action listener: _resource_record_post_action 09:24:41 INFO - ##### 09:24:41 INFO - ##### Running create-virtualenv step. 09:24:41 INFO - ##### 09:24:41 INFO - Running pre-action listener: _resource_record_pre_action 09:24:41 INFO - Running main action method: create_virtualenv 09:24:41 INFO - Creating virtualenv /builds/slave/test/build/venv 09:24:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:24:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:24:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:24:41 INFO - Using real prefix '/tools/python27' 09:24:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:24:42 INFO - Installing distribute.............................................................................................................................................................................................done. 09:24:44 INFO - Installing pip.................done. 09:24:44 INFO - Return code: 0 09:24:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e8f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e907420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf99567fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e796e00>, '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 0x10e5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e791b20>, '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.fo93KodIXq/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.TdlFDi7ffU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:24:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fo93KodIXq/Render', 09:24:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:44 INFO - 'HOME': '/Users/cltbld', 09:24:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:44 INFO - 'LOGNAME': 'cltbld', 09:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:44 INFO - 'MOZ_NO_REMOTE': '1', 09:24:44 INFO - 'NO_EM_RESTART': '1', 09:24:44 INFO - 'PAGER': '/bin/cat', 09:24:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:44 INFO - 'PWD': '/builds/slave/test', 09:24:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:44 INFO - 'SHELL': '/bin/bash', 09:24:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TdlFDi7ffU/Listeners', 09:24:44 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 09:24:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:44 INFO - 'USER': 'cltbld', 09:24:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:44 INFO - 'XPC_FLAGS': '0x0', 09:24:44 INFO - 'XPC_SERVICE_NAME': '0', 09:24:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:24:45 INFO - Cleaning up... 09:24:45 INFO - Return code: 0 09:24:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:45 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 0x10e8f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e907420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf99567fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e796e00>, '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 0x10e5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e791b20>, '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.fo93KodIXq/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.TdlFDi7ffU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:24:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fo93KodIXq/Render', 09:24:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:45 INFO - 'HOME': '/Users/cltbld', 09:24:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:45 INFO - 'LOGNAME': 'cltbld', 09:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:45 INFO - 'MOZ_NO_REMOTE': '1', 09:24:45 INFO - 'NO_EM_RESTART': '1', 09:24:45 INFO - 'PAGER': '/bin/cat', 09:24:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:45 INFO - 'PWD': '/builds/slave/test', 09:24:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:45 INFO - 'SHELL': '/bin/bash', 09:24:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TdlFDi7ffU/Listeners', 09:24:45 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 09:24:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:45 INFO - 'USER': 'cltbld', 09:24:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:45 INFO - 'XPC_FLAGS': '0x0', 09:24:45 INFO - 'XPC_SERVICE_NAME': '0', 09:24:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:45 INFO - Downloading/unpacking psutil>=0.7.1 09:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:24:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:47 INFO - Installing collected packages: psutil 09:24:47 INFO - Running setup.py install for psutil 09:24:48 INFO - building 'psutil._psutil_osx' extension 09:24:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:24:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:24:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:24:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:24:48 INFO - building 'psutil._psutil_posix' extension 09:24:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:24:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:24:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:24:48 INFO - ^ 09:24:48 INFO - 1 warning generated. 09:24:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:24:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:49 INFO - Successfully installed psutil 09:24:49 INFO - Cleaning up... 09:24:49 INFO - Return code: 0 09:24:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:49 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 0x10e8f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e907420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf99567fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e796e00>, '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 0x10e5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e791b20>, '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.fo93KodIXq/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.TdlFDi7ffU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:24:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fo93KodIXq/Render', 09:24:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:49 INFO - 'HOME': '/Users/cltbld', 09:24:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:49 INFO - 'LOGNAME': 'cltbld', 09:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:49 INFO - 'MOZ_NO_REMOTE': '1', 09:24:49 INFO - 'NO_EM_RESTART': '1', 09:24:49 INFO - 'PAGER': '/bin/cat', 09:24:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:49 INFO - 'PWD': '/builds/slave/test', 09:24:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:49 INFO - 'SHELL': '/bin/bash', 09:24:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TdlFDi7ffU/Listeners', 09:24:49 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 09:24:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:49 INFO - 'USER': 'cltbld', 09:24:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:49 INFO - 'XPC_FLAGS': '0x0', 09:24:49 INFO - 'XPC_SERVICE_NAME': '0', 09:24:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:24:51 INFO - Installing collected packages: mozsystemmonitor 09:24:51 INFO - Running setup.py install for mozsystemmonitor 09:24:52 INFO - Successfully installed mozsystemmonitor 09:24:52 INFO - Cleaning up... 09:24:52 INFO - Return code: 0 09:24:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:52 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 0x10e8f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e907420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf99567fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e796e00>, '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 0x10e5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e791b20>, '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.fo93KodIXq/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.TdlFDi7ffU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fo93KodIXq/Render', 09:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:52 INFO - 'HOME': '/Users/cltbld', 09:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:52 INFO - 'LOGNAME': 'cltbld', 09:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:52 INFO - 'MOZ_NO_REMOTE': '1', 09:24:52 INFO - 'NO_EM_RESTART': '1', 09:24:52 INFO - 'PAGER': '/bin/cat', 09:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:52 INFO - 'PWD': '/builds/slave/test', 09:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:52 INFO - 'SHELL': '/bin/bash', 09:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TdlFDi7ffU/Listeners', 09:24:52 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 09:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:52 INFO - 'USER': 'cltbld', 09:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:52 INFO - 'XPC_FLAGS': '0x0', 09:24:52 INFO - 'XPC_SERVICE_NAME': '0', 09:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:52 INFO - Downloading/unpacking blobuploader==1.2.4 09:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:54 INFO - Downloading blobuploader-1.2.4.tar.gz 09:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:24:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:24:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:55 INFO - Downloading docopt-0.6.1.tar.gz 09:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:56 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:56 INFO - Running setup.py install for blobuploader 09:24:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:24:56 INFO - Running setup.py install for requests 09:24:56 INFO - Running setup.py install for docopt 09:24:56 INFO - Successfully installed blobuploader requests docopt 09:24:56 INFO - Cleaning up... 09:24:56 INFO - Return code: 0 09:24:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:56 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 0x10e8f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e907420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf99567fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e796e00>, '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 0x10e5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e791b20>, '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.fo93KodIXq/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.TdlFDi7ffU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:24:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fo93KodIXq/Render', 09:24:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:56 INFO - 'HOME': '/Users/cltbld', 09:24:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:56 INFO - 'LOGNAME': 'cltbld', 09:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:56 INFO - 'MOZ_NO_REMOTE': '1', 09:24:56 INFO - 'NO_EM_RESTART': '1', 09:24:56 INFO - 'PAGER': '/bin/cat', 09:24:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:56 INFO - 'PWD': '/builds/slave/test', 09:24:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:56 INFO - 'SHELL': '/bin/bash', 09:24:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TdlFDi7ffU/Listeners', 09:24:56 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 09:24:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:56 INFO - 'USER': 'cltbld', 09:24:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:56 INFO - 'XPC_FLAGS': '0x0', 09:24:56 INFO - 'XPC_SERVICE_NAME': '0', 09:24:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:57 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-vKxBp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:57 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-vjdYDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:57 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-7CdXnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:57 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-CL5Yzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:57 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-jTCRpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:57 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-V7zTnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:57 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Vli2Sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:57 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Dy4YHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:58 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Z5Zf7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:58 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-qy2DYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:58 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-mVvVCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:58 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-ssSRQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:58 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-8n2bG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:58 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Y7FsPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:58 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Z4CGaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:58 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-LYGlXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:58 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-JKvMBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:24:58 INFO - Running setup.py install for manifestparser 09:24:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:24:59 INFO - Running setup.py install for mozcrash 09:24:59 INFO - Running setup.py install for mozdebug 09:24:59 INFO - Running setup.py install for mozdevice 09:24:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:24:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:24:59 INFO - Running setup.py install for mozfile 09:24:59 INFO - Running setup.py install for mozhttpd 09:24:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:24:59 INFO - Running setup.py install for mozinfo 09:25:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:25:00 INFO - Running setup.py install for mozInstall 09:25:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:25:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:25:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:25:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:25:00 INFO - Running setup.py install for mozleak 09:25:00 INFO - Running setup.py install for mozlog 09:25:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:25:00 INFO - Running setup.py install for moznetwork 09:25:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:25:00 INFO - Running setup.py install for mozprocess 09:25:00 INFO - Running setup.py install for mozprofile 09:25:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:25:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:25:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:25:00 INFO - Running setup.py install for mozrunner 09:25:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:25:01 INFO - Running setup.py install for mozscreenshot 09:25:01 INFO - Running setup.py install for moztest 09:25:01 INFO - Running setup.py install for mozversion 09:25:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:25:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:25:01 INFO - Cleaning up... 09:25:01 INFO - Return code: 0 09:25:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:01 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 0x10e8f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e907420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf99567fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e796e00>, '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 0x10e5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e791b20>, '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.fo93KodIXq/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.TdlFDi7ffU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:25:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fo93KodIXq/Render', 09:25:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:01 INFO - 'HOME': '/Users/cltbld', 09:25:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:01 INFO - 'LOGNAME': 'cltbld', 09:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:01 INFO - 'MOZ_NO_REMOTE': '1', 09:25:01 INFO - 'NO_EM_RESTART': '1', 09:25:01 INFO - 'PAGER': '/bin/cat', 09:25:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:01 INFO - 'PWD': '/builds/slave/test', 09:25:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:01 INFO - 'SHELL': '/bin/bash', 09:25:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TdlFDi7ffU/Listeners', 09:25:01 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 09:25:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:01 INFO - 'USER': 'cltbld', 09:25:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:01 INFO - 'XPC_FLAGS': '0x0', 09:25:01 INFO - 'XPC_SERVICE_NAME': '0', 09:25:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:01 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-dVC1Kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:01 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-6mbb4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:02 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-sbmzSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:02 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-0RulWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:02 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-WD9Tuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:02 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-SMxTFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:02 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-xMGANG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:02 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-fYR9P8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:02 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-9o91Yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:02 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-NYJZ_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:02 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-TE6Os3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:02 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-hlTLlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:03 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Yh4D6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:03 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-GCffxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:03 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-EOkFB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:03 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-p9FT14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:03 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-xCM0it-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:25:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:06 INFO - Downloading blessings-1.6.tar.gz 09:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:25:06 INFO - Installing collected packages: blessings 09:25:06 INFO - Running setup.py install for blessings 09:25:06 INFO - Successfully installed blessings 09:25:06 INFO - Cleaning up... 09:25:06 INFO - Return code: 0 09:25:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:06 INFO - Reading from file tmpfile_stdout 09:25:06 INFO - Current package versions: 09:25:06 INFO - blessings == 1.6 09:25:06 INFO - blobuploader == 1.2.4 09:25:06 INFO - docopt == 0.6.1 09:25:06 INFO - manifestparser == 1.1 09:25:06 INFO - mozInstall == 1.12 09:25:06 INFO - mozcrash == 0.17 09:25:06 INFO - mozdebug == 0.1 09:25:06 INFO - mozdevice == 0.48 09:25:06 INFO - mozfile == 1.2 09:25:06 INFO - mozhttpd == 0.7 09:25:06 INFO - mozinfo == 0.9 09:25:06 INFO - mozleak == 0.1 09:25:06 INFO - mozlog == 3.1 09:25:06 INFO - moznetwork == 0.27 09:25:06 INFO - mozprocess == 0.22 09:25:06 INFO - mozprofile == 0.28 09:25:06 INFO - mozrunner == 6.11 09:25:06 INFO - mozscreenshot == 0.1 09:25:06 INFO - mozsystemmonitor == 0.0 09:25:06 INFO - moztest == 0.7 09:25:06 INFO - mozversion == 1.4 09:25:06 INFO - psutil == 3.1.1 09:25:06 INFO - requests == 1.2.3 09:25:06 INFO - wsgiref == 0.1.2 09:25:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:06 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 0x10e8f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e907420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf99567fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e796e00>, '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 0x10e5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e791b20>, '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.fo93KodIXq/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.TdlFDi7ffU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:25:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fo93KodIXq/Render', 09:25:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:06 INFO - 'HOME': '/Users/cltbld', 09:25:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:06 INFO - 'LOGNAME': 'cltbld', 09:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:06 INFO - 'MOZ_NO_REMOTE': '1', 09:25:06 INFO - 'NO_EM_RESTART': '1', 09:25:06 INFO - 'PAGER': '/bin/cat', 09:25:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:06 INFO - 'PWD': '/builds/slave/test', 09:25:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:06 INFO - 'SHELL': '/bin/bash', 09:25:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TdlFDi7ffU/Listeners', 09:25:06 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 09:25:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:06 INFO - 'USER': 'cltbld', 09:25:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:06 INFO - 'XPC_FLAGS': '0x0', 09:25:06 INFO - 'XPC_SERVICE_NAME': '0', 09:25:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:25:06 INFO - Cleaning up... 09:25:06 INFO - Return code: 0 09:25:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e8f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e907420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf99567fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e796e00>, '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 0x10e5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e791b20>, '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.fo93KodIXq/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.TdlFDi7ffU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:25:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fo93KodIXq/Render', 09:25:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:06 INFO - 'HOME': '/Users/cltbld', 09:25:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:06 INFO - 'LOGNAME': 'cltbld', 09:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:06 INFO - 'MOZ_NO_REMOTE': '1', 09:25:06 INFO - 'NO_EM_RESTART': '1', 09:25:06 INFO - 'PAGER': '/bin/cat', 09:25:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:06 INFO - 'PWD': '/builds/slave/test', 09:25:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:06 INFO - 'SHELL': '/bin/bash', 09:25:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TdlFDi7ffU/Listeners', 09:25:06 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 09:25:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:06 INFO - 'USER': 'cltbld', 09:25:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:06 INFO - 'XPC_FLAGS': '0x0', 09:25:06 INFO - 'XPC_SERVICE_NAME': '0', 09:25:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:07 INFO - Downloading/unpacking jsonschema 09:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:25:09 INFO - Downloading/unpacking functools32 (from jsonschema) 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:10 INFO - Downloading functools32-3.2.3-2.tar.gz 09:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:25:10 INFO - warning: no files found matching '*.txt' 09:25:10 INFO - no previously-included directories found matching 'build' 09:25:10 INFO - no previously-included directories found matching 'dist' 09:25:10 INFO - no previously-included directories found matching '.git*' 09:25:10 INFO - Installing collected packages: jsonschema, functools32 09:25:10 INFO - Running setup.py install for functools32 09:25:10 INFO - warning: no files found matching '*.txt' 09:25:10 INFO - no previously-included directories found matching 'build' 09:25:10 INFO - no previously-included directories found matching 'dist' 09:25:10 INFO - no previously-included directories found matching '.git*' 09:25:10 INFO - Successfully installed jsonschema functools32 09:25:10 INFO - Cleaning up... 09:25:10 INFO - Return code: 0 09:25:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e8f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e907420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf99567fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e796e00>, '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 0x10e5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e791b20>, '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.fo93KodIXq/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.TdlFDi7ffU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:25:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:25:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fo93KodIXq/Render', 09:25:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:10 INFO - 'HOME': '/Users/cltbld', 09:25:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:10 INFO - 'LOGNAME': 'cltbld', 09:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:10 INFO - 'MOZ_NO_REMOTE': '1', 09:25:10 INFO - 'NO_EM_RESTART': '1', 09:25:10 INFO - 'PAGER': '/bin/cat', 09:25:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:10 INFO - 'PWD': '/builds/slave/test', 09:25:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:10 INFO - 'SHELL': '/bin/bash', 09:25:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TdlFDi7ffU/Listeners', 09:25:10 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 09:25:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:10 INFO - 'USER': 'cltbld', 09:25:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:10 INFO - 'XPC_FLAGS': '0x0', 09:25:10 INFO - 'XPC_SERVICE_NAME': '0', 09:25:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:10 INFO - Downloading/unpacking flake8 09:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:25:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:25:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:25:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:25:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:25:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:25:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:25:14 INFO - no previously-included directories found matching 'docs/_build' 09:25:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:25:14 INFO - Running setup.py install for pep8 09:25:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:25:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:25:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:25:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:25:14 INFO - no previously-included directories found matching 'docs/_build' 09:25:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:25:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:25:14 INFO - Cleaning up... 09:25:14 INFO - Return code: 0 09:25:14 INFO - Running post-action listener: _resource_record_post_action 09:25:14 INFO - Running post-action listener: _start_resource_monitoring 09:25:14 INFO - Starting resource monitoring. 09:25:14 INFO - ##### 09:25:14 INFO - ##### Running install step. 09:25:14 INFO - ##### 09:25:14 INFO - Running pre-action listener: _resource_record_pre_action 09:25:14 INFO - Running main action method: install 09:25:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:15 INFO - Reading from file tmpfile_stdout 09:25:15 INFO - Detecting whether we're running mozinstall >=1.0... 09:25:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:25:15 INFO - Reading from file tmpfile_stdout 09:25:15 INFO - Output received: 09:25:15 INFO - Usage: mozinstall [options] installer 09:25:15 INFO - Options: 09:25:15 INFO - -h, --help show this help message and exit 09:25:15 INFO - -d DEST, --destination=DEST 09:25:15 INFO - Directory to install application into. [default: 09:25:15 INFO - "/builds/slave/test"] 09:25:15 INFO - --app=APP Application being installed. [default: firefox] 09:25:15 INFO - mkdir: /builds/slave/test/build/application 09:25:15 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'] 09:25:15 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 09:25:37 INFO - Reading from file tmpfile_stdout 09:25:37 INFO - Output received: 09:25:37 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:25:37 INFO - Running post-action listener: _resource_record_post_action 09:25:37 INFO - ##### 09:25:37 INFO - ##### Running run-tests step. 09:25:37 INFO - ##### 09:25:37 INFO - Running pre-action listener: _resource_record_pre_action 09:25:37 INFO - Running main action method: run_tests 09:25:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:25:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:25:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:25:37 INFO - 2016-06-20 09:25:37.278 screenresolution[1641:7459] starting screenresolution argv=screenresolution get 09:25:37 INFO - 2016-06-20 09:25:37.280 screenresolution[1641:7459] Display 0: 1600x1200x32@60 09:25:37 INFO - 2016-06-20 09:25:37.286 screenresolution[1642:7462] starting screenresolution argv=screenresolution list 09:25:37 INFO - Available Modes on Display 0 09:25:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:25:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:25:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:25:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:25:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:25:37 INFO - Intel Iris: 09:25:37 INFO - Chipset Model: Intel Iris 09:25:37 INFO - Type: GPU 09:25:37 INFO - Bus: Built-In 09:25:37 INFO - VRAM (Dynamic, Max): 1536 MB 09:25:37 INFO - Vendor: Intel (0x8086) 09:25:37 INFO - Device ID: 0x0a2e 09:25:37 INFO - Revision ID: 0x0009 09:25:37 INFO - Displays: 09:25:37 INFO - Display: 09:25:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:25:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:25:37 INFO - Display Serial Number: 1600x1200 60 09:25:37 INFO - Main Display: Yes 09:25:37 INFO - Mirror: Off 09:25:37 INFO - Online: Yes 09:25:37 INFO - Rotation: Supported 09:25:37 INFO - Return code: 0 09:25:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:25:37 INFO - Python 2.7.3 09:25:37 INFO - Return code: 0 09:25:37 INFO - grabbing minidump binary from tooltool 09:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:37 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 0x10e796e00>, '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 0x10e5ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e791b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:25:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:25:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:25:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:25:37 INFO - Return code: 0 09:25:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:25:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:25:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:25:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:25:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:25:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:25:38 INFO - Return code: 0 09:25:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0389', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0389 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:25:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fo93KodIXq/Render', 09:25:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:38 INFO - 'HOME': '/Users/cltbld', 09:25:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:38 INFO - 'LOGNAME': 'cltbld', 09:25:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:25:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:38 INFO - 'MOZ_NO_REMOTE': '1', 09:25:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:25:38 INFO - 'NO_EM_RESTART': '1', 09:25:38 INFO - 'PAGER': '/bin/cat', 09:25:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:38 INFO - 'PWD': '/builds/slave/test', 09:25:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:25:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:38 INFO - 'SHELL': '/bin/bash', 09:25:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TdlFDi7ffU/Listeners', 09:25:38 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 09:25:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:38 INFO - 'USER': 'cltbld', 09:25:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:38 INFO - 'XPC_FLAGS': '0x0', 09:25:38 INFO - 'XPC_SERVICE_NAME': '0', 09:25:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:25:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0389', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:25:38 INFO - mozversion application_buildid: 20160620070425 09:25:38 INFO - mozversion application_changeset: 11986e1994456d9d8c4a006caa8e15bd1c8410f1 09:25:38 INFO - mozversion application_display_name: Firefox 09:25:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:25:38 INFO - mozversion application_name: Firefox 09:25:38 INFO - mozversion application_remotingname: firefox 09:25:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:25:38 INFO - mozversion application_vendor: Mozilla 09:25:38 INFO - mozversion application_version: 48.0 09:25:38 INFO - mozversion platform_buildid: 20160620070425 09:25:38 INFO - mozversion platform_changeset: 11986e1994456d9d8c4a006caa8e15bd1c8410f1 09:25:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:25:38 INFO - mozversion platform_version: 48.0 09:25:38 INFO - using testdate: 1466439938 09:25:38 INFO - actual date: 1466439938 09:25:38 INFO - starting webserver on 'localhost:49284' 09:25:38 INFO - SUITE-START | Running 2 tests 09:25:38 INFO - TEST-START | dromaeo_css 09:25:38 INFO - operating with platform_type : mac_ 09:25:38 INFO - Initialising browser for dromaeo_css test... 09:25:38 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmpH8bSHb/profile http://localhost:49284/getInfo.html) 09:25:41 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 09:25:41 INFO - PROCESS | 1660 | colorDepth:24 09:25:41 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 09:25:41 INFO - PROCESS | 1660 | __metrics 09:25:41 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:25:41 ERROR - PROCESS | 1660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:25:41 INFO - TEST-INFO | 1660: exit 0 09:25:41 INFO - Browser initialized. 09:25:41 INFO - Running cycle 1/1 for dromaeo_css test... 09:25:41 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmpH8bSHb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:53 INFO - PROCESS | 1663 | RSS: Main: 161320960 09:25:53 INFO - PROCESS | 1663 | 09:26:44 INFO - PROCESS | 1663 | 1466440004913 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:28:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49284/tests/dromaeo/cssquery-ext.html) 09:28:56 INFO - PROCESS | 1663 | RSS: Main: 289718272 09:28:56 INFO - PROCESS | 1663 | 09:31:59 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-ext.html (next: http://localhost:49284/tests/dromaeo/cssquery-jquery.html) 09:31:59 INFO - PROCESS | 1663 | RSS: Main: 302481408 09:31:59 INFO - PROCESS | 1663 | 09:35:01 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49284/tests/dromaeo/cssquery-mootools.html) 09:35:02 INFO - PROCESS | 1663 | RSS: Main: 309788672 09:35:02 INFO - PROCESS | 1663 | 09:38:04 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49284/tests/dromaeo/cssquery-prototype.html) 09:38:04 INFO - PROCESS | 1663 | RSS: Main: 309354496 09:38:04 INFO - PROCESS | 1663 | 09:41:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49284/tests/dromaeo/cssquery-yui.html) 09:41:08 INFO - PROCESS | 1663 | RSS: Main: 276082688 09:41:08 INFO - PROCESS | 1663 | 09:44:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-yui.html (next: http://localhost:49284/tests/dromaeo/cssquery-dojo.html) 09:44:11 INFO - PROCESS | 1663 | RSS: Main: 327766016 09:44:11 INFO - PROCESS | 1663 | 09:44:11 INFO - PROCESS | 1663 | __start_tp_report 09:44:11 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 09:44:11 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 09:44:11 INFO - PROCESS | 1663 | |i|pagename|runs| 09:44:11 INFO - PROCESS | 1663 | |0;dojo.html;3585.426331786914;3613.2954073955557;3633.2370202257507;3640.6359364063587;3700.7594506357086;5692.288463942007;5736.340320863102;5736.885262294757;5752.964466396057;5761.395053519383;5729.770809167629;5763.567732420064;5772.855678608037;5775.740091695873;5780.53755699544;3984.5019372578354;5183.092958732225;5202.895942081156;5282.2076688496645;5293.497117773805;5231.503007214308;5298.311219541454;5300.602454815904;5307.973460132714;5312.150055991042;5192.065428222918;5247.47525247476;5248.5276325130735;5277.287566178555;5294;5276.393214780311;5277.3139491866195;5304.761285742151;5307.828227679699;5314.123169676998;5105.897882042338;5144.819931302424;5188.247704082924;5244.685318880841;5247.02929957959;5572.164175373686;5576.052071147915;5610.85972850682;5630.521405680522;5715.771369145229;6312.053192021188;6318.399752023551;6326.43062124411;6350.0792385103905;6357.777477788301;6103.511719062464;6340.778072767477;6395.2645445773405;6396.872062558769;6403;5791.681457519835;5808.128780682931;5878.588498805128;5886.205362276123;5902.468777809975;6341.968290158519;6369.904451433232;6371.267304260069;6372.4583410409705;6382.297947225801;6095.939040609537;6180.505559555315;6184.474319682788;6195.349488303754;6210.875782484325;6229.470495007975;6320.683965801692;6331.240251169889;6334.746610135543;6341.587796793194;6231.781887633911;6265.749370025148;6280.246370435577;6295.338989406138;6298.244210694655;6123.191113103653;6236.095766113888;6333.1450254216015;6352.237731472253;6359.20509936258;4189.6438802701505;4918.360613120343;4959.479254678206;4968.130577148984;4968.850934471971;4442.3336499524685;4479.10417916418;4501.0547784964865;4534.093181363674;4564.977175114103;6000.039993601003;6029.60807547508;6029.698515074228;6071.362506936796;6082.087686847009;5686.516646085046;6346.809595712136;6380.776672816429;6396.360363963659;6399.328070552618;5034.89930201394;5925.762969481172;5966.850828729316;6035.486983606354;6050.54620903434;5404.054290499225;5463.453654634504;5470.617056805985;5471.151971444432;5476.315460567429;5811.27359080115;6116.388361163937;6320.273168585672;6455.806325810233;6495.967520162369;6315.905261421174;6411.4229719325485;6421.133147025279;6426.164598602152;6430.710618022294;6482.773102941374;6484.221893372825;6487.513436492376;6502.512311576556;6513.023046543057;6109.799438327977;6184.196054512884;6257.4681152102585;6271.31015588294;6287.937120628735;6371.776987805404;6373.298937117006;6379.74481020754;6392.87214255703;6411.903821442776;5100.69395836251;5991.400859913973;6135.53983451234;6202.162708034358;6222;5964.970175149097;6090.665013424305;6106.9083963739695;6161.938380616137;6181.84545386369;6031.668258245839;6034.69826508664;6039.456448919618;6058.151858739868;6088.8782224356155;6175.166352542529;6203.410675985774;6204.13142160107;6211.440970312694;6216.44052035319;5908.911366329595;5988.880222395441;6001.459868611846;6051.394860513913;6065.120557519223 09:44:11 INFO - PROCESS | 1663 | |1;ext.html;538.55031049074;545.5989847462115;557.8270736071818;608.903972848872;632.3265722006063;32576.511352329704;33239.16902077449;39706.8014659927;40594.39108413369;40647.79676101615;43840.780796095976;44229;44292.89267768308;44293.33559996603;44335.113297734024;9655.710328690115;9865.852012219822;9874.40753554789;9879.308448408614;9889;9208.815823683522;9427.811443771121;9459.290553208502;11482.770344593104;11719.296842189453;11852.7629447411;11896.107791915598;11926.224795388316;11931.940340298286;11933.820992685074;11743.706407339841;11921.582744603897;11948.761024779542;11952.52189912411;11953.22304050234;11520.539178432853;11651.650450486499;11669.124815638776;11672;11676.824847627293;40570.39144412836;41016.79491602553;43286.78356608197;43346.56653433457;43368.56631433677;3374.1227280906896;3447.7586568940183;3545.929081418383;3718.51659284294;4000.57993910641;29113;29499.820007199687;29626.703732962826;29860.253493662614;30153.547696784346;2722.9591556126675;2740;2789.846558439285;2798.790090743182;2808.49447099522;389865;390179.0491047555;390463;390934;391009;37623.81188094042;38462.42306365407;66577.66711166414;67051.32948670548;67352.32647673559;36877.81561092231;36967;37158.44262336067;37159.81420092882;37187.81406093006;16492.917535412245;16658.416955406745;16661.25024373906;16674.999500029793;16676;13062.804057939138;14063.789043164361;14138.929305353407;14166.362513686909;14170.929145354414;7630.2751238632245;8132.512049276944;8247.793805154919;8249.8350032999;8434.662613495515;3131.123285480069;3352.379809735207;3532.788032718045;3552.378333791576;3585.7848529088337;1059.210887888528;1115.2360632966445;1170.3329102411544;1193.7791508570942;1195.9940200298943;27024.72975270222;27242.04652837141;30354.241143971136;31029.913953011535;31157;946.6286951187232;1134.7560274541013;1166.3759888459633;1174.5536696055615;1183.3668987092037;13739.313034348243;16276.43032493857;16595;17018.404355847735;17460.95234285947;491256;491391;496150;498900.54947527446;499687;62434;62931;63070.36929630645;63272.734545308835;63286.367136328045;1540.5147378575714;1561.640822610783;1567.3025503650765;1576.432484305649;1578.9763153552706;30170.547441787952;31997;32191.678083219806;32193.492910992012;32923.17692057718;56885.715571421875;57797.71101144468;57908;57918.4208157913;58068;584560;613363;614401;616159;616916;21922.123115075858;22088.44778880541;27852.86073569619;28340;28601;43271.350929736705;43323;43460.56539434565;44279.55720442755;45039.774801127096;35187.82406087953;36218.63781362258;36492.81753591215;36594;37318.81340593279;35864.8206758975;35977.74077907261;36097.63902360943;36498.905032849056;36508.26983460369;35647.82176089103;38434.61565384422;38938;39116.2176756469;39154;28449.43101138007;34938.60245590148;35252;36707.44938825973;37491.43762843614;23330.833458327354;26070.739292607588;26151.215463536126;26693.866530667998;26812.731872681023 09:44:11 INFO - PROCESS | 1663 | |2;jquery.html;369.15647744902867;417.0636920114344;419.7397613479642;419.9832006719731;430.46192259675405;15260.236988150604;18326.900385976835;20962;21393.57212855744;21813.23653672122;20605.4848628784;20898.686519702216;21899.781002189975;21916.780832191675;21946.670799938012;5715.571332150074;6269.059641053833;6283.183186185789;6290.528210384216;6291.150694656231;6069.939300607004;6169.598976066563;6225.657588832612;6255.186825712673;6255.749770009194;6050.2437195350585;6205.255369355684;6206.689665516728;6224.626522408647;6234.906476402857;5962.105684147369;6188.566800323979;6191.566590338655;6192.133101365813;6202.472789812871;6120.540959428016;6147.784827531015;6153.538484613627;6154.5076393888385;6158.445739883387;13374.33128343579;13603.795943060863;13868.514601988882;13955.651108722263;13983.65040873976;2158.9244376446904;2372.8932198050957;2403.4111642647663;2789.7070807565115;2860.1562539050824;9533.856992145124;9920.107190352903;10074.597016119347;10291.073803357658;10485;1802.9639407211914;1854.2026928420908;1964.1750464804672;2025.5847551252104;2036.4094412620323;108142.3778643321;116019;118541;119526;119782.401087994;12055.51777928873;12069.637910862688;12083.154179207371;12101.939490302668;12133.878661213275;14384.35270412834;14777;14793.186374749277;15821.288042038135;15851.920740396225;9236.953815230881;9270.536473176315;9277.536123193813;9337.673181438617;9368.110029547182;9358.485283309483;9366.812663746687;9379.765505862271;9406.482643454676;9462.810743785085;4011.919761604752;4417.889552761207;4649.604783593365;4669.4630117536235;4792.113459010025;2014.1339224133762;2037.847161462896;2068.6690129579197;2071.637463443891;2077.6779599162155;887.8490656588395;991.8115558043949;1020.7550187954837;1044.081208536483;1076.235872530512;18294.451166465027;18959.052047397574;19706.408807735792;20859.269925552533;21990.560188796455;894.6779159502574;1006.5671761142632;1038.133158812385;1049.4333060147435;1086.3699054548342;11171.16216283782;11589.304641721523;11622.244554103956;11661.708457288636;11747.823782643267;645612;650624;654916;668454;668874;70620.58758824794;70915.93626095612;71190.64404677943;106944;124385;1042.5569133118395;1103.9558417663363;1109.7614012987246;1109.9001089901947;1110.4336788237895;11319.207655464039;19469.415917522496;19507.21971121196;20379.388618341472;20763.584728305046;53670.46329536811;55546.722266390025;55965.72017139888;57911.710441447525;60305.79388412295;67393.32606673871;81075.39322368495;81122.18877811146;81378;82306;9886.406815591088;10499;11653.184277100521;12299.44652490658;12574.30246916691;7770.805729856799;11356.602518911799;13093.476260949456;13237.602871913858;13566.050376473551;11314;11533.308001519936;11782.99844513226;11817.231879927776;11906.642800715992;11239.325640461599;11378.374189419661;11406;11423.543058277575;11775.76448471043;11732.589359372381;11764.411779410824;11824.881751182378;11989.520419183134;12215.328156951098;12205.633830985085;12213.938930305292;12414.689632759253;12495.562655307021;12540.435680394221;11664.416779160838;11703.29780213156;11712.355820429959;12041.157119001937;12070 09:44:11 INFO - PROCESS | 1663 | |3;mootools.html;1478;1638.4429294040026;1670.582354411397;1972.1421181785925;2034.7660019097798;8075.111737708855;8652.480851148928;8825.33809964252;8825.646974121028;8826.161514656113;7378.96310518448;8518.957405212965;8827.735167944957;8831.337649676283;8835.072317406677;2531.962020569693;2549.8342607730438;2552.923412297634;2557.2328301509565;2558.526672565572;2480.52869954708;2541.009006487471;2545.121932933135;2548.5412625727363;2549.757773011561;2504.912328068518;2546.1343143331264;2546.3506805764505;2547.783438407738;2551.4897020595863;2507.3355560776317;2523.3439305780444;2533.5819589767666;2549.4263790646955;2549.757773011561;2465.839720418185;2521.2184222890965;2528.1657053172594;2534.176392672389;2540.0728734011955;8656.264217541517;8935.508547029911;8959.37284390093;8965.551722413853;8977.506237156953;5421.457854214586;5576.693281869496;5586.581006424534;5602.271704678406;5604.131359639263;3575.94636080459;3675.981620091909;3676.9080772980624;3678.08047988003;3714.1271801126713;1027.4913917610832;1056.260617567698;1058.3120971368594;1060.3796778884362;1060.4750648428999;11827.645170644895;11918.642440726706;11920.927116559551;11947.103967202494;11974.042076633936;4111.239420707178;4617.399738034034;4755.358026666425;4793.784279707422;4800.35195248644;9469.763255918657;9486.95256523713;9487.857682134774;9489.810203795885;9503.239740820718;5458.344998600193;5502.724863756796;5506.972465137648;5508.834734957877;5511.035568775448;3858.9421158682644;4013.257547353749;4713.057388522241;5036.949630503721;5098.643094983316;3902.2585708715255;3958.129211573449;3972.602739726004;4003.3594624860466;4005.619466150711;1246.7496169414114;1252.1985929005443;1254.2787896959285;1261.1928365845865;1264.4499642655474;885.3271513649672;950.9857352139724;955.6559638530124;984.389678399397;1002.4737013068197;6005.699715014319;6132.141500189977;6152.78465253714;6190.783322583688;6210;483.3619622098796;485.60665860652983;490.71048081632006;1065.7495488560182;1078.3745427651943;3958.3072962231495;4051.473308469939;4081.0409553754844;4081.10215752534;4121.814518346681;10389.324693894872;11090.5563777448;11229.3262404256;11234.49444774987;11238.381888996184;10646.14830813533;10931.836022459669;10947.233693641369;11065.889341106647;11077.833832492519;8326.875096873551;8442.831143377221;8480.872786908201;8497.66009359631;8516.8722469163;5692.7722891083895;5878.529717622494;5912.054071348563;6020.397960203944;6025.1564780931585;9539.236861051239;9694.079062489052;9849.261305402268;9861.605535778775;9883.308168428428;9790.922998470305;9941.453220072965;10090.949545252226;10158.441285729356;10172.389656620626;6507.577007494498;6659.53383263167;6976.127984002;7120.821979450555;7242.058532390755;8390.244877961013;8443.113473085237;8492.575371231538;8492.787680307794;8514.531700756517;7426.4430167736555;7563.584002879895;7602.50583712057;7619.238076192558;7663.69345226207;7355.5954422507275;7396.149442814145;7439.330460258603;7554.244575542401;7560.281773231534;7042.119735033121;7144.3570078693165;7158.964205178941;7178.389836863925;7183.5330703504105;4908.779104940215;5018.422881368543;5033.320501732365;5039.874003149951;5066.518680725325;4978.5270399312;5039.370078740158;5123.820666276662;5155.793768249378;5293.841184764463 09:44:11 INFO - PROCESS | 1663 | |4;prototype.html;327.5071018117732;332.8352465529563;341.93845107880577;344.3079410385125;346.1346633416459;6594.3735345142195;6621.768238111667;6698.162729658793;6740.629265390402;6755.121834161552;6286.685665716707;6434.517411194156;6466.224053113621;6614.933850661492;6622.304658010899;4940.7776650050655;5005.874853128665;5010.749462526877;5012.273220383042;5033.924491132627;5004.074246264435;5022.321986531808;5027.019731152427;5035.798568057292;5038.748062596856;4708.364370809948;4794.113089078514;4894.192458244385;4928.33467481889;4972.129877271481;4900.191468407708;4915.705057696532;4927.926081108786;4928.285398617216;4958.851234462936;4230.7038507304505;4245.724027938174;4247.299195632717;4251.766152861592;4254.638355739766;6335.176427064498;6341.270753863272;6344.397282258178;6345.397187267202;6354.968225158891;5787.363390027093;5795.913061304083;5803.65178089316;5812.651240925516;5813.505852002585;6805.795826125224;7007.894881576781;7014.473914456436;7026.859462810767;7037.788866334018;4695.201815691341;4729.266963620645;4744.051189762062;4745.288206768978;4756.762161891892;7403.629818509053;7406.296401841816;7408.036955195844;7410.740624078186;7414.406847452245;4785.832495862628;4785.856424307276;4810.975945120322;4812.302216178635;4814.807407703723;4866.902661946812;4873.6832105913;4873.853784386474;4874.53691899269;4874.780634871368;5555.77776888928;5727.742251598688;5747.971260143672;5757.971210144006;5778.624389414758;7003.614801185984;7044.36600705939;7048.048513450721;7072.504924655224;7073;1618.2636900210375;1674.0959881663764;1704.1734758642049;1705.590658242013;1710.9059001754774;1044.5404022230193;1096.446294621227;1126.8591426071741;1131.2985948711687;1132.6715252576826;5589.944100559023;6848.623325717133;6856.108705868205;6882.7591034313555;6885.965570172117;7309.89035164473;7322.231165727629;7329.413646908234;7331.486795924234;7333.523320984119;6952.826179345456;7017.89473157903;7027.297270273034;7031.859362812817;7037.401820845285;3703.9444408333898;3838.7120965927666;3879.9030024249055;3880.4373365862357;3886.8250928708276;6867.519273650796;7132.500724949204;7823.335016523545;7824.608769561499;7845.293923546908;7447.664855081534;7452.441066920002;7464.656361854918;7473.58895260755;7483.027206463234;7714.421418393643;7775.1447340792465;7775.688972441039;7780.727674531364;7814.296713295831;6032.095185722177;7013.333733295329;7241.927580724126;7274;7278.272172782679;6966.756163534252;7105.822354440974;7152.499325047404;7153.60655163971;7155.642217889189;7749.41879359039;7760.146383897654;7762.728304509315;7764.301212890867;7767.92232077672;4022.6379625833815;4843.346148269939;4845.781939812647;4846.321514987975;4858.692121242523;7057.329553692391;7242.348188663045;7252.202257751537;7403.185649578434;7425.368843648134;7100.289971003065;7144.9642751785905;7149.82125446868;7183.389411900047;7184.173820010766;7119.857602848017;7147.64261786919;7149.85700285981;7160.606166660884;7164.570125792261;6973.302669732986;6985.336393042653;6986.580805151707;6990.860182796418;6991.965040174767;5738.483536481736;5751.8562035949435;6775.1531058617675;6825.419839313516;7138.785836424916;6793.66031698423;6872.725090996304;6916.412104971134;6922.238553758982;7016.824579385556 09:44:11 INFO - PROCESS | 1663 | |5;yui.html;718.2888939949449;772.590527020679;783.2206954080683;806.0891192951967;810.4165001199135;15023.774643380344;15254.694906101899;15257.771133433007;15267.389304427823;15276.159811210393;12054;13512.98652601054;13747.175169489838;13929.442822287096;13937.651558711037;773.5165521549031;795.2961628958385;927.772695689557;968.9806203875918;970.2383628851353;956.9808603827919;969.6654654144309;974.0648976982105;975.5707488704983;976.3117002513246;838.337713206566;1030.0369154840248;1031.9174466042698;1034.100332710543;1034.6792494326746;838.584900474263;852.0244320253275;852.1138016462871;991.2565575818137;1032.9845052324147;771.4445599168589;771.699037375424;771.733751855609;771.8417724366492;771.9884201736978;15104.39582416702;15157.090574565562;15177.848221517754;15192.772108418383;15193.772093418607;12681.619551413472;12923.547675831394;13010.479580816756;13158.60524184276;13204.207747535083;10239.742783252974;10281;10285.640002599948;10364.896351036545;10476.79046419075;3542.220711443504;3587.94618080729;3589.964100358989;3623.4564815277918;3640.2355505343908;79778.60110699467;82076.58961705213;82523.5873820633;82647.5867620664;82972.92567685795;9488.430694158373;9626.181774549243;9680.854787178198;9794.951025244829;10324.638637647646;18234.908825456052;22048.228312009003;22102.668459973112;22112.88943555272;22120.668189977165;7501.512401693873;7694.576798276036;7705.691772329156;7786.1824508426935;7880.527168369917;4182.2890108681595;4238.321868501025;4322.135572885372;4349.499807522112;4521.299198624219;3741.4574886641285;3783.5838057813617;3799.6200379962333;3800.8669696560487;3813;597.2415032908182;603.3755063509246;609.5458883132095;615.7013848283578;628.4375483941847;605.6305653551331;609.3632154398664;617.478230894893;626.214101302862;631.034517188702;8278.793030174294;8477.364197685198;8485.363597730195;8532.36007299455;8619.61211745473;555.5944160762585;560.2212924035593;620.4694985787178;628.2712054017318;628.8836565235446;3843.1160833008007;3886.514185726784;3911.8239679214503;4008.2384346974563;4025.959740402617;82187.5890620543;82498;86382.13617863867;87261.12738872657;87660.1233987652;61059;76310;76859.61570192114;80430.19569804345;81686.36627267422;67738.66130669315;67788.32211677919;68235.31764682289;69011.30988690049;69195.65402172957;7882.251186137537;7882.330001949898;7899.486533375312;7965.920340796518;8015.198480152171;40503.1899362017;45748;49068.52794416173;50333.99332013413;52043;64781;66926;70508.94236586557;70684.29315706778;71550.64224679052;10233.539490723084;10349.172066234834;10518.421486818299;10545.050945414949;10564.84152737725;10925.399103049409;11170.720731981766;11188.776224475301;11227.045701115496;11680.591179308683;10337.9483102584;10481.58073677075;10493.317934334244;10588.4705764713;11116.944415277872;10325.380477171393;10423.322484038514;10529;10596.099331556905;11112.833307500556;10190.898091019291;10251.58993640246;10391.428471433841;10974;11013.953674400918;8789.077146899483;8862.049255697159;9034.774130646787;9122.664258566527;9218.308626852879;8912.55437228149;9029.548522573976;9065.592048357972;9095.226905713089;9204.309676774135 09:44:11 INFO - PROCESS | 1663 | __end_tp_report 09:44:11 INFO - PROCESS | 1663 | __start_cc_report 09:44:11 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1091 09:44:11 INFO - PROCESS | 1663 | __end_cc_report 09:44:11 INFO - PROCESS | 1663 | __startTimestamp1466441051332__endTimestamp 09:44:11 INFO - PROCESS | 1663 | 09:44:11 INFO - PROCESS | 1663 | ------- Summary: start ------- 09:44:11 INFO - PROCESS | 1663 | Number of tests: 6 09:44:11 INFO - PROCESS | 1663 | 09:44:11 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5805.20 Median:6039.46 stddev:657.36 (10.9%) stddev-sans-first:635.89 09:44:11 INFO - PROCESS | 1663 | Values: 3585.4 3613.3 3633.2 3640.6 3700.8 5692.3 5736.3 5736.9 5753.0 5761.4 5729.8 5763.6 5772.9 5775.7 5780.5 3984.5 5183.1 5202.9 5282.2 5293.5 5231.5 5298.3 5300.6 5308.0 5312.2 5192.1 5247.5 5248.5 5277.3 5294.0 5276.4 5277.3 5304.8 5307.8 5314.1 5105.9 5144.8 5188.2 5244.7 5247.0 5572.2 5576.1 5610.9 5630.5 5715.8 6312.1 6318.4 6326.4 6350.1 6357.8 6103.5 6340.8 6395.3 6396.9 6403.0 5791.7 5808.1 5878.6 5886.2 5902.5 6342.0 6369.9 6371.3 6372.5 6382.3 6095.9 6180.5 6184.5 6195.3 6210.9 6229.5 6320.7 6331.2 6334.7 6341.6 6231.8 6265.7 6280.2 6295.3 6298.2 6123.2 6236.1 6333.1 6352.2 6359.2 4189.6 4918.4 4959.5 4968.1 4968.9 4442.3 4479.1 4501.1 4534.1 4565.0 6000.0 6029.6 6029.7 6071.4 6082.1 5686.5 6346.8 6380.8 6396.4 6399.3 5034.9 5925.8 5966.9 6035.5 6050.5 5404.1 5463.5 5470.6 5471.2 5476.3 5811.3 6116.4 6320.3 6455.8 6496.0 6315.9 6411.4 6421.1 6426.2 6430.7 6482.8 6484.2 6487.5 6502.5 6513.0 6109.8 6184.2 6257.5 6271.3 6287.9 6371.8 6373.3 6379.7 6392.9 6411.9 5100.7 5991.4 6135.5 6202.2 6222.0 5965.0 6090.7 6106.9 6161.9 6181.8 6031.7 6034.7 6039.5 6058.2 6088.9 6175.2 6203.4 6204.1 6211.4 6216.4 5908.9 5988.9 6001.5 6051.4 6065.1 09:44:11 INFO - PROCESS | 1663 | 09:44:11 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:63570.27 Median:19725.30 stddev:135111.74 (685.0%) stddev-sans-first:135407.89 09:44:11 INFO - PROCESS | 1663 | Values: 538.6 545.6 557.8 608.9 632.3 32576.5 33239.2 39706.8 40594.4 40647.8 43840.8 44229.0 44292.9 44293.3 44335.1 9655.7 9865.9 9874.4 9879.3 9889.0 9208.8 9427.8 9459.3 11482.8 11719.3 11852.8 11896.1 11926.2 11931.9 11933.8 11743.7 11921.6 11948.8 11952.5 11953.2 11520.5 11651.7 11669.1 11672.0 11676.8 40570.4 41016.8 43286.8 43346.6 43368.6 3374.1 3447.8 3545.9 3718.5 4000.6 29113.0 29499.8 29626.7 29860.3 30153.5 2723.0 2740.0 2789.8 2798.8 2808.5 389865.0 390179.0 390463.0 390934.0 391009.0 37623.8 38462.4 66577.7 67051.3 67352.3 36877.8 36967.0 37158.4 37159.8 37187.8 16492.9 16658.4 16661.3 16675.0 16676.0 13062.8 14063.8 14138.9 14166.4 14170.9 7630.3 8132.5 8247.8 8249.8 8434.7 3131.1 3352.4 3532.8 3552.4 3585.8 1059.2 1115.2 1170.3 1193.8 1196.0 27024.7 27242.0 30354.2 31029.9 31157.0 946.6 1134.8 1166.4 1174.6 1183.4 13739.3 16276.4 16595.0 17018.4 17461.0 491256.0 491391.0 496150.0 498900.5 499687.0 62434.0 62931.0 63070.4 63272.7 63286.4 1540.5 1561.6 1567.3 1576.4 1579.0 30170.5 31997.0 32191.7 32193.5 32923.2 56885.7 57797.7 57908.0 57918.4 58068.0 584560.0 613363.0 614401.0 616159.0 616916.0 21922.1 22088.4 27852.9 28340.0 28601.0 43271.4 43323.0 43460.6 44279.6 45039.8 35187.8 36218.6 36492.8 36594.0 37318.8 35864.8 35977.7 36097.6 36498.9 36508.3 35647.8 38434.6 38938.0 39116.2 39154.0 28449.4 34938.6 35252.0 36707.4 37491.4 23330.8 26070.7 26151.2 26693.9 26812.7 09:44:11 INFO - PROCESS | 1663 | 09:44:11 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:35738.58 Median:20492.44 stddev:108552.05 (529.7%) stddev-sans-first:108824.08 09:44:11 INFO - PROCESS | 1663 | Values: 369.2 417.1 419.7 420.0 430.5 15260.2 18326.9 20962.0 21393.6 21813.2 20605.5 20898.7 21899.8 21916.8 21946.7 5715.6 6269.1 6283.2 6290.5 6291.2 6069.9 6169.6 6225.7 6255.2 6255.7 6050.2 6205.3 6206.7 6224.6 6234.9 5962.1 6188.6 6191.6 6192.1 6202.5 6120.5 6147.8 6153.5 6154.5 6158.4 13374.3 13603.8 13868.5 13955.7 13983.7 2158.9 2372.9 2403.4 2789.7 2860.2 9533.9 9920.1 10074.6 10291.1 10485.0 1803.0 1854.2 1964.2 2025.6 2036.4 108142.4 116019.0 118541.0 119526.0 119782.4 12055.5 12069.6 12083.2 12101.9 12133.9 14384.4 14777.0 14793.2 15821.3 15851.9 9237.0 9270.5 9277.5 9337.7 9368.1 9358.5 9366.8 9379.8 9406.5 9462.8 4011.9 4417.9 4649.6 4669.5 4792.1 2014.1 2037.8 2068.7 2071.6 2077.7 887.8 991.8 1020.8 1044.1 1076.2 18294.5 18959.1 19706.4 20859.3 21990.6 894.7 1006.6 1038.1 1049.4 1086.4 11171.2 11589.3 11622.2 11661.7 11747.8 645612.0 650624.0 654916.0 668454.0 668874.0 70620.6 70915.9 71190.6 106944.0 124385.0 1042.6 1104.0 1109.8 1109.9 1110.4 11319.2 19469.4 19507.2 20379.4 20763.6 53670.5 55546.7 55965.7 57911.7 60305.8 67393.3 81075.4 81122.2 81378.0 82306.0 9886.4 10499.0 11653.2 12299.4 12574.3 7770.8 11356.6 13093.5 13237.6 13566.1 11314.0 11533.3 11783.0 11817.2 11906.6 11239.3 11378.4 11406.0 11423.5 11775.8 11732.6 11764.4 11824.9 11989.5 12215.3 12205.6 12213.9 12414.7 12495.6 12540.4 11664.4 11703.3 11712.4 12041.2 12070.0 09:44:11 INFO - PROCESS | 1663 | 09:44:11 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5769.11 Median:5035.14 stddev:3192.59 (63.4%) stddev-sans-first:3185.26 09:44:11 INFO - PROCESS | 1663 | Values: 1478.0 1638.4 1670.6 1972.1 2034.8 8075.1 8652.5 8825.3 8825.6 8826.2 7379.0 8519.0 8827.7 8831.3 8835.1 2532.0 2549.8 2552.9 2557.2 2558.5 2480.5 2541.0 2545.1 2548.5 2549.8 2504.9 2546.1 2546.4 2547.8 2551.5 2507.3 2523.3 2533.6 2549.4 2549.8 2465.8 2521.2 2528.2 2534.2 2540.1 8656.3 8935.5 8959.4 8965.6 8977.5 5421.5 5576.7 5586.6 5602.3 5604.1 3575.9 3676.0 3676.9 3678.1 3714.1 1027.5 1056.3 1058.3 1060.4 1060.5 11827.6 11918.6 11920.9 11947.1 11974.0 4111.2 4617.4 4755.4 4793.8 4800.4 9469.8 9487.0 9487.9 9489.8 9503.2 5458.3 5502.7 5507.0 5508.8 5511.0 3858.9 4013.3 4713.1 5036.9 5098.6 3902.3 3958.1 3972.6 4003.4 4005.6 1246.7 1252.2 1254.3 1261.2 1264.4 885.3 951.0 955.7 984.4 1002.5 6005.7 6132.1 6152.8 6190.8 6210.0 483.4 485.6 490.7 1065.7 1078.4 3958.3 4051.5 4081.0 4081.1 4121.8 10389.3 11090.6 11229.3 11234.5 11238.4 10646.1 10931.8 10947.2 11065.9 11077.8 8326.9 8442.8 8480.9 8497.7 8516.9 5692.8 5878.5 5912.1 6020.4 6025.2 9539.2 9694.1 9849.3 9861.6 9883.3 9790.9 9941.5 10090.9 10158.4 10172.4 6507.6 6659.5 6976.1 7120.8 7242.1 8390.2 8443.1 8492.6 8492.8 8514.5 7426.4 7563.6 7602.5 7619.2 7663.7 7355.6 7396.1 7439.3 7554.2 7560.3 7042.1 7144.4 7159.0 7178.4 7183.5 4908.8 5018.4 5033.3 5039.9 5066.5 4978.5 5039.4 5123.8 5155.8 5293.8 09:44:11 INFO - PROCESS | 1663 | 09:44:11 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5833.71 Median:6660.23 stddev:1832.63 (27.5%) stddev-sans-first:1790.56 09:44:11 INFO - PROCESS | 1663 | Values: 327.5 332.8 341.9 344.3 346.1 6594.4 6621.8 6698.2 6740.6 6755.1 6286.7 6434.5 6466.2 6614.9 6622.3 4940.8 5005.9 5010.7 5012.3 5033.9 5004.1 5022.3 5027.0 5035.8 5038.7 4708.4 4794.1 4894.2 4928.3 4972.1 4900.2 4915.7 4927.9 4928.3 4958.9 4230.7 4245.7 4247.3 4251.8 4254.6 6335.2 6341.3 6344.4 6345.4 6355.0 5787.4 5795.9 5803.7 5812.7 5813.5 6805.8 7007.9 7014.5 7026.9 7037.8 4695.2 4729.3 4744.1 4745.3 4756.8 7403.6 7406.3 7408.0 7410.7 7414.4 4785.8 4785.9 4811.0 4812.3 4814.8 4866.9 4873.7 4873.9 4874.5 4874.8 5555.8 5727.7 5748.0 5758.0 5778.6 7003.6 7044.4 7048.0 7072.5 7073.0 1618.3 1674.1 1704.2 1705.6 1710.9 1044.5 1096.4 1126.9 1131.3 1132.7 5589.9 6848.6 6856.1 6882.8 6886.0 7309.9 7322.2 7329.4 7331.5 7333.5 6952.8 7017.9 7027.3 7031.9 7037.4 3703.9 3838.7 3879.9 3880.4 3886.8 6867.5 7132.5 7823.3 7824.6 7845.3 7447.7 7452.4 7464.7 7473.6 7483.0 7714.4 7775.1 7775.7 7780.7 7814.3 6032.1 7013.3 7241.9 7274.0 7278.3 6966.8 7105.8 7152.5 7153.6 7155.6 7749.4 7760.1 7762.7 7764.3 7767.9 4022.6 4843.3 4845.8 4846.3 4858.7 7057.3 7242.3 7252.2 7403.2 7425.4 7100.3 7145.0 7149.8 7183.4 7184.2 7119.9 7147.6 7149.9 7160.6 7164.6 6973.3 6985.3 6986.6 6990.9 6992.0 5738.5 5751.9 6775.2 6825.4 7138.8 6793.7 6872.7 6916.4 6922.2 7016.8 09:44:11 INFO - PROCESS | 1663 | 09:44:11 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:17887.74 Median:607.50 stddev:24994.98 (4114.4%) stddev-sans-first:25031.85 09:44:11 INFO - PROCESS | 1663 | Values: 718.3 772.6 783.2 806.1 810.4 15023.8 15254.7 15257.8 15267.4 15276.2 12054.0 13513.0 13747.2 13929.4 13937.7 773.5 795.3 927.8 969.0 970.2 957.0 969.7 974.1 975.6 976.3 838.3 1030.0 1031.9 1034.1 1034.7 838.6 852.0 852.1 991.3 1033.0 771.4 771.7 771.7 771.8 772.0 15104.4 15157.1 15177.8 15192.8 15193.8 12681.6 12923.5 13010.5 13158.6 13204.2 10239.7 10281.0 10285.6 10364.9 10476.8 3542.2 3587.9 3590.0 3623.5 3640.2 79778.6 82076.6 82523.6 82647.6 82972.9 9488.4 9626.2 9680.9 9795.0 10324.6 18234.9 22048.2 22102.7 22112.9 22120.7 7501.5 7694.6 7705.7 7786.2 7880.5 4182.3 4238.3 4322.1 4349.5 4521.3 3741.5 3783.6 3799.6 3800.9 3813.0 597.2 603.4 609.5 615.7 628.4 605.6 609.4 617.5 626.2 631.0 8278.8 8477.4 8485.4 8532.4 8619.6 555.6 560.2 620.5 628.3 628.9 3843.1 3886.5 3911.8 4008.2 4026.0 82187.6 82498.0 86382.1 87261.1 87660.1 61059.0 76310.0 76859.6 80430.2 81686.4 67738.7 67788.3 68235.3 69011.3 69195.7 7882.3 7882.3 7899.5 7965.9 8015.2 40503.2 45748.0 49068.5 50334.0 52043.0 64781.0 66926.0 70508.9 70684.3 71550.6 10233.5 10349.2 10518.4 10545.1 10564.8 10925.4 11170.7 11188.8 11227.0 11680.6 10337.9 10481.6 10493.3 10588.5 11116.9 10325.4 10423.3 10529.0 10596.1 11112.8 10190.9 10251.6 10391.4 10974.0 11014.0 8789.1 8862.0 9034.8 9122.7 9218.3 8912.6 9029.5 9065.6 9095.2 9204.3 09:44:11 INFO - PROCESS | 1663 | -------- Summary: end -------- 09:44:11 INFO - PROCESS | 1663 | 09:44:11 INFO - TEST-INFO | 1663: exit 0 09:44:11 INFO - TEST-OK | dromaeo_css | took 1112927ms 09:44:11 INFO - TEST-START | kraken 09:44:11 INFO - operating with platform_type : mac_ 09:44:11 INFO - Initialising browser for kraken test... 09:44:11 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmpojnD9C/profile http://localhost:49284/getInfo.html) 09:44:13 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 09:44:13 INFO - PROCESS | 1674 | colorDepth:24 09:44:13 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 09:44:13 INFO - PROCESS | 1674 | __metrics 09:44:13 INFO - PROCESS | 1674 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:44:13 ERROR - PROCESS | 1674 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:44:14 INFO - TEST-INFO | 1674: exit 0 09:44:14 INFO - Browser initialized. 09:44:14 INFO - Running cycle 1/1 for kraken test... 09:44:14 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmpojnD9C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:26 INFO - PROCESS | 1676 | RSS: Main: 161730560 09:44:26 INFO - PROCESS | 1676 | 09:44:29 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49284/tests/kraken/driver.html?testName=audio-beat-detection) 09:44:29 INFO - PROCESS | 1676 | RSS: Main: 223940608 09:44:29 INFO - PROCESS | 1676 | 09:44:32 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49284/tests/kraken/driver.html?testName=audio-dft) 09:44:33 INFO - PROCESS | 1676 | RSS: Main: 238972928 09:44:33 INFO - PROCESS | 1676 | 09:44:36 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49284/tests/kraken/driver.html?testName=audio-fft) 09:44:36 INFO - PROCESS | 1676 | RSS: Main: 325111808 09:44:36 INFO - PROCESS | 1676 | 09:44:38 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49284/tests/kraken/driver.html?testName=audio-oscillator) 09:44:39 INFO - PROCESS | 1676 | RSS: Main: 230871040 09:44:39 INFO - PROCESS | 1676 | 09:44:41 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49284/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:44:42 INFO - PROCESS | 1676 | RSS: Main: 231563264 09:44:42 INFO - PROCESS | 1676 | 09:44:45 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49284/tests/kraken/driver.html?testName=imaging-darkroom) 09:44:45 INFO - PROCESS | 1676 | RSS: Main: 267968512 09:44:45 INFO - PROCESS | 1676 | 09:44:48 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49284/tests/kraken/driver.html?testName=imaging-desaturate) 09:44:49 INFO - PROCESS | 1676 | RSS: Main: 270856192 09:44:49 INFO - PROCESS | 1676 | 09:44:51 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49284/tests/kraken/driver.html?testName=json-parse-financial) 09:44:52 INFO - PROCESS | 1676 | RSS: Main: 267968512 09:44:52 INFO - PROCESS | 1676 | 09:44:53 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49284/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:54 INFO - PROCESS | 1676 | RSS: Main: 258875392 09:44:54 INFO - PROCESS | 1676 | 09:44:56 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:57 INFO - PROCESS | 1676 | RSS: Main: 265875456 09:44:57 INFO - PROCESS | 1676 | 09:44:59 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:45:00 INFO - PROCESS | 1676 | RSS: Main: 270458880 09:45:00 INFO - PROCESS | 1676 | 09:45:02 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:45:03 INFO - PROCESS | 1676 | RSS: Main: 277585920 09:45:03 INFO - PROCESS | 1676 | 09:45:06 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:45:06 INFO - PROCESS | 1676 | RSS: Main: 274620416 09:45:06 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49284/tests/kraken/driver.html?testName=ai-astar) 09:45:08 INFO - PROCESS | 1676 | RSS: Main: 335753216 09:45:08 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | __start_tp_report 09:45:08 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 09:45:08 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 09:45:08 INFO - PROCESS | 1676 | |i|pagename|runs| 09:45:08 INFO - PROCESS | 1676 | |0;ai-astar;114;111;116;113;112;111;112;114;114;132 09:45:08 INFO - PROCESS | 1676 | |1;audio-beat-detection;155;117;142;163;115;144;142;160;161;144 09:45:08 INFO - PROCESS | 1676 | |2;audio-dft;184;182;186;185;185;184;183;183;183;184 09:45:08 INFO - PROCESS | 1676 | |3;audio-fft;70;76;72;150;55;55;56;64;128;57 09:45:08 INFO - PROCESS | 1676 | |4;audio-oscillator;92;90;142;79;88;86;126;80;78;124 09:45:08 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;88;85;88;87;89;85;89;86;103;130 09:45:08 INFO - PROCESS | 1676 | |6;imaging-darkroom;100;93;95;94;95;94;95;94;94;94 09:45:08 INFO - PROCESS | 1676 | |7;imaging-desaturate;86;86;87;85;83;84;83;85;84;85 09:45:08 INFO - PROCESS | 1676 | |8;json-parse-financial;58;62;62;61;62;62;62;78;58;57 09:45:08 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;60;63;66;69;78;98;93;96;94;78 09:45:08 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;74;76;79;78;80;78;78;78;100;79 09:45:08 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;126;127;125;125;126;123;132;144;163;157 09:45:08 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;200;210;180;162;159;158;163;161;164;160 09:45:08 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;67;67;83;99;92;72;69;66;66;65 09:45:08 INFO - PROCESS | 1676 | __end_tp_report 09:45:08 INFO - PROCESS | 1676 | __start_cc_report 09:45:08 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,2012 09:45:08 INFO - PROCESS | 1676 | __end_cc_report 09:45:08 INFO - PROCESS | 1676 | __startTimestamp1466441108862__endTimestamp 09:45:08 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | ------- Summary: start ------- 09:45:08 INFO - PROCESS | 1676 | Number of tests: 14 09:45:08 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:114.90 Median:114.00 stddev:6.21 (5.4%) stddev-sans-first:6.58 09:45:08 INFO - PROCESS | 1676 | Values: 114.0 111.0 116.0 113.0 112.0 111.0 112.0 114.0 114.0 132.0 09:45:08 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:149.50 stddev:17.01 (11.4%) stddev-sans-first:17.60 09:45:08 INFO - PROCESS | 1676 | Values: 155.0 117.0 142.0 163.0 115.0 144.0 142.0 160.0 161.0 144.0 09:45:08 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 09:45:08 INFO - PROCESS | 1676 | Values: 184.0 182.0 186.0 185.0 185.0 184.0 183.0 183.0 183.0 184.0 09:45:08 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:78.30 Median:60.50 stddev:33.28 (55.0%) stddev-sans-first:35.16 09:45:08 INFO - PROCESS | 1676 | Values: 70.0 76.0 72.0 150.0 55.0 55.0 56.0 64.0 128.0 57.0 09:45:08 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:83.00 stddev:23.15 (27.9%) stddev-sans-first:24.43 09:45:08 INFO - PROCESS | 1676 | Values: 92.0 90.0 142.0 79.0 88.0 86.0 126.0 80.0 78.0 124.0 09:45:08 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:93.00 Median:87.50 stddev:14.00 (16.0%) stddev-sans-first:14.73 09:45:08 INFO - PROCESS | 1676 | Values: 88.0 85.0 88.0 87.0 89.0 85.0 89.0 86.0 103.0 130.0 09:45:08 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:94.00 stddev:1.93 (2.1%) stddev-sans-first:0.67 09:45:08 INFO - PROCESS | 1676 | Values: 100.0 93.0 95.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 09:45:08 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.32 (1.5%) stddev-sans-first:1.32 09:45:08 INFO - PROCESS | 1676 | Values: 86.0 86.0 87.0 85.0 83.0 84.0 83.0 85.0 84.0 85.0 09:45:08 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.00 stddev:5.90 (9.5%) stddev-sans-first:6.06 09:45:08 INFO - PROCESS | 1676 | Values: 58.0 62.0 62.0 61.0 62.0 62.0 62.0 78.0 58.0 57.0 09:45:08 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:79.50 Median:85.50 stddev:14.74 (17.2%) stddev-sans-first:13.85 09:45:08 INFO - PROCESS | 1676 | Values: 60.0 63.0 66.0 69.0 78.0 98.0 93.0 96.0 94.0 78.0 09:45:08 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:78.00 stddev:7.23 (9.3%) stddev-sans-first:7.33 09:45:08 INFO - PROCESS | 1676 | Values: 74.0 76.0 79.0 78.0 80.0 78.0 78.0 78.0 100.0 79.0 09:45:08 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:129.50 stddev:14.63 (11.3%) stddev-sans-first:15.17 09:45:08 INFO - PROCESS | 1676 | Values: 126.0 127.0 125.0 125.0 126.0 123.0 132.0 144.0 163.0 157.0 09:45:08 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:163.50 stddev:18.76 (11.5%) stddev-sans-first:16.87 09:45:08 INFO - PROCESS | 1676 | Values: 200.0 210.0 180.0 162.0 159.0 158.0 163.0 161.0 164.0 160.0 09:45:08 INFO - PROCESS | 1676 | 09:45:08 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:70.50 stddev:12.30 (17.5%) stddev-sans-first:12.74 09:45:08 INFO - PROCESS | 1676 | Values: 67.0 67.0 83.0 99.0 92.0 72.0 69.0 66.0 66.0 65.0 09:45:08 INFO - PROCESS | 1676 | -------- Summary: end -------- 09:45:08 INFO - PROCESS | 1676 | 09:45:09 INFO - TEST-INFO | 1676: exit 0 09:45:09 INFO - TEST-OK | kraken | took 57773ms 09:45:09 INFO - SUITE-END | took 1170s 09:45:10 INFO - Completed test suite (00:19:31) 09:45:10 INFO - javascript benchmark 09:45:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3585.426331786914, 3613.2954073955557, 3633.2370202257507, 3640.6359364063587, 3700.7594506357086, 5692.288463942007, 5736.340320863102, 5736.885262294757, 5752.964466396057, 5761.395053519383, 5729.770809167629, 5763.567732420064, 5772.855678608037, 5775.740091695873, 5780.53755699544, 3984.5019372578354, 5183.092958732225, 5202.895942081156, 5282.2076688496645, 5293.497117773805, 5231.503007214308, 5298.311219541454, 5300.602454815904, 5307.973460132714, 5312.150055991042, 5192.065428222918, 5247.47525247476, 5248.5276325130735, 5277.287566178555, 5294.0, 5276.393214780311, 5277.3139491866195, 5304.761285742151, 5307.828227679699, 5314.123169676998, 5105.897882042338, 5144.819931302424, 5188.247704082924, 5244.685318880841, 5247.02929957959, 5572.164175373686, 5576.052071147915, 5610.85972850682, 5630.521405680522, 5715.771369145229, 6312.053192021188, 6318.399752023551, 6326.43062124411, 6350.0792385103905, 6357.777477788301, 6103.511719062464, 6340.778072767477, 6395.2645445773405, 6396.872062558769, 6403.0, 5791.681457519835, 5808.128780682931, 5878.588498805128, 5886.205362276123, 5902.468777809975, 6341.968290158519, 6369.904451433232, 6371.267304260069, 6372.4583410409705, 6382.297947225801, 6095.939040609537, 6180.505559555315, 6184.474319682788, 6195.349488303754, 6210.875782484325, 6229.470495007975, 6320.683965801692, 6331.240251169889, 6334.746610135543, 6341.587796793194, 6231.781887633911, 6265.749370025148, 6280.246370435577, 6295.338989406138, 6298.244210694655, 6123.191113103653, 6236.095766113888, 6333.1450254216015, 6352.237731472253, 6359.20509936258, 4189.6438802701505, 4918.360613120343, 4959.479254678206, 4968.130577148984, 4968.850934471971, 4442.3336499524685, 4479.10417916418, 4501.0547784964865, 4534.093181363674, 4564.977175114103, 6000.039993601003, 6029.60807547508, 6029.698515074228, 6071.362506936796, 6082.087686847009, 5686.516646085046, 6346.809595712136, 6380.776672816429, 6396.360363963659, 6399.328070552618, 5034.89930201394, 5925.762969481172, 5966.850828729316, 6035.486983606354, 6050.54620903434, 5404.054290499225, 5463.453654634504, 5470.617056805985, 5471.151971444432, 5476.315460567429, 5811.27359080115, 6116.388361163937, 6320.273168585672, 6455.806325810233, 6495.967520162369, 6315.905261421174, 6411.4229719325485, 6421.133147025279, 6426.164598602152, 6430.710618022294, 6482.773102941374, 6484.221893372825, 6487.513436492376, 6502.512311576556, 6513.023046543057, 6109.799438327977, 6184.196054512884, 6257.4681152102585, 6271.31015588294, 6287.937120628735, 6371.776987805404, 6373.298937117006, 6379.74481020754, 6392.87214255703, 6411.903821442776, 5100.69395836251, 5991.400859913973, 6135.53983451234, 6202.162708034358, 6222.0, 5964.970175149097, 6090.665013424305, 6106.9083963739695, 6161.938380616137, 6181.84545386369, 6031.668258245839, 6034.69826508664, 6039.456448919618, 6058.151858739868, 6088.8782224356155, 6175.166352542529, 6203.410675985774, 6204.13142160107, 6211.440970312694, 6216.44052035319, 5908.911366329595, 5988.880222395441, 6001.459868611846, 6051.394860513913, 6065.120557519223], "value": 5765.324507636124, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.55031049074, 545.5989847462115, 557.8270736071818, 608.903972848872, 632.3265722006063, 32576.511352329704, 33239.16902077449, 39706.8014659927, 40594.39108413369, 40647.79676101615, 43840.780796095976, 44229.0, 44292.89267768308, 44293.33559996603, 44335.113297734024, 9655.710328690115, 9865.852012219822, 9874.40753554789, 9879.308448408614, 9889.0, 9208.815823683522, 9427.811443771121, 9459.290553208502, 11482.770344593104, 11719.296842189453, 11852.7629447411, 11896.107791915598, 11926.224795388316, 11931.940340298286, 11933.820992685074, 11743.706407339841, 11921.582744603897, 11948.761024779542, 11952.52189912411, 11953.22304050234, 11520.539178432853, 11651.650450486499, 11669.124815638776, 11672.0, 11676.824847627293, 40570.39144412836, 41016.79491602553, 43286.78356608197, 43346.56653433457, 43368.56631433677, 3374.1227280906896, 3447.7586568940183, 3545.929081418383, 3718.51659284294, 4000.57993910641, 29113.0, 29499.820007199687, 29626.703732962826, 29860.253493662614, 30153.547696784346, 2722.9591556126675, 2740.0, 2789.846558439285, 2798.790090743182, 2808.49447099522, 389865.0, 390179.0491047555, 390463.0, 390934.0, 391009.0, 37623.81188094042, 38462.42306365407, 66577.66711166414, 67051.32948670548, 67352.32647673559, 36877.81561092231, 36967.0, 37158.44262336067, 37159.81420092882, 37187.81406093006, 16492.917535412245, 16658.416955406745, 16661.25024373906, 16674.999500029793, 16676.0, 13062.804057939138, 14063.789043164361, 14138.929305353407, 14166.362513686909, 14170.929145354414, 7630.2751238632245, 8132.512049276944, 8247.793805154919, 8249.8350032999, 8434.662613495515, 3131.123285480069, 3352.379809735207, 3532.788032718045, 3552.378333791576, 3585.7848529088337, 1059.210887888528, 1115.2360632966445, 1170.3329102411544, 1193.7791508570942, 1195.9940200298943, 27024.72975270222, 27242.04652837141, 30354.241143971136, 31029.913953011535, 31157.0, 946.6286951187232, 1134.7560274541013, 1166.3759888459633, 1174.5536696055615, 1183.3668987092037, 13739.313034348243, 16276.43032493857, 16595.0, 17018.404355847735, 17460.95234285947, 491256.0, 491391.0, 496150.0, 498900.54947527446, 499687.0, 62434.0, 62931.0, 63070.36929630645, 63272.734545308835, 63286.367136328045, 1540.5147378575714, 1561.640822610783, 1567.3025503650765, 1576.432484305649, 1578.9763153552706, 30170.547441787952, 31997.0, 32191.678083219806, 32193.492910992012, 32923.17692057718, 56885.715571421875, 57797.71101144468, 57908.0, 57918.4208157913, 58068.0, 584560.0, 613363.0, 614401.0, 616159.0, 616916.0, 21922.123115075858, 22088.44778880541, 27852.86073569619, 28340.0, 28601.0, 43271.350929736705, 43323.0, 43460.56539434565, 44279.55720442755, 45039.774801127096, 35187.82406087953, 36218.63781362258, 36492.81753591215, 36594.0, 37318.81340593279, 35864.8206758975, 35977.74077907261, 36097.63902360943, 36498.905032849056, 36508.26983460369, 35647.82176089103, 38434.61565384422, 38938.0, 39116.2176756469, 39154.0, 28449.43101138007, 34938.60245590148, 35252.0, 36707.44938825973, 37491.43762843614, 23330.833458327354, 26070.739292607588, 26151.215463536126, 26693.866530667998, 26812.731872681023], "value": 19259.881198652412, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.15647744902867, 417.0636920114344, 419.7397613479642, 419.9832006719731, 430.46192259675405, 15260.236988150604, 18326.900385976835, 20962.0, 21393.57212855744, 21813.23653672122, 20605.4848628784, 20898.686519702216, 21899.781002189975, 21916.780832191675, 21946.670799938012, 5715.571332150074, 6269.059641053833, 6283.183186185789, 6290.528210384216, 6291.150694656231, 6069.939300607004, 6169.598976066563, 6225.657588832612, 6255.186825712673, 6255.749770009194, 6050.2437195350585, 6205.255369355684, 6206.689665516728, 6224.626522408647, 6234.906476402857, 5962.105684147369, 6188.566800323979, 6191.566590338655, 6192.133101365813, 6202.472789812871, 6120.540959428016, 6147.784827531015, 6153.538484613627, 6154.5076393888385, 6158.445739883387, 13374.33128343579, 13603.795943060863, 13868.514601988882, 13955.651108722263, 13983.65040873976, 2158.9244376446904, 2372.8932198050957, 2403.4111642647663, 2789.7070807565115, 2860.1562539050824, 9533.856992145124, 9920.107190352903, 10074.597016119347, 10291.073803357658, 10485.0, 1802.9639407211914, 1854.2026928420908, 1964.1750464804672, 2025.5847551252104, 2036.4094412620323, 108142.3778643321, 116019.0, 118541.0, 119526.0, 119782.401087994, 12055.51777928873, 12069.637910862688, 12083.154179207371, 12101.939490302668, 12133.878661213275, 14384.35270412834, 14777.0, 14793.186374749277, 15821.288042038135, 15851.920740396225, 9236.953815230881, 9270.536473176315, 9277.536123193813, 9337.673181438617, 9368.110029547182, 9358.485283309483, 9366.812663746687, 9379.765505862271, 9406.482643454676, 9462.810743785085, 4011.919761604752, 4417.889552761207, 4649.604783593365, 4669.4630117536235, 4792.113459010025, 2014.1339224133762, 2037.847161462896, 2068.6690129579197, 2071.637463443891, 2077.6779599162155, 887.8490656588395, 991.8115558043949, 1020.7550187954837, 1044.081208536483, 1076.235872530512, 18294.451166465027, 18959.052047397574, 19706.408807735792, 20859.269925552533, 21990.560188796455, 894.6779159502574, 1006.5671761142632, 1038.133158812385, 1049.4333060147435, 1086.3699054548342, 11171.16216283782, 11589.304641721523, 11622.244554103956, 11661.708457288636, 11747.823782643267, 645612.0, 650624.0, 654916.0, 668454.0, 668874.0, 70620.58758824794, 70915.93626095612, 71190.64404677943, 106944.0, 124385.0, 1042.5569133118395, 1103.9558417663363, 1109.7614012987246, 1109.9001089901947, 1110.4336788237895, 11319.207655464039, 19469.415917522496, 19507.21971121196, 20379.388618341472, 20763.584728305046, 53670.46329536811, 55546.722266390025, 55965.72017139888, 57911.710441447525, 60305.79388412295, 67393.32606673871, 81075.39322368495, 81122.18877811146, 81378.0, 82306.0, 9886.406815591088, 10499.0, 11653.184277100521, 12299.44652490658, 12574.30246916691, 7770.805729856799, 11356.602518911799, 13093.476260949456, 13237.602871913858, 13566.050376473551, 11314.0, 11533.308001519936, 11782.99844513226, 11817.231879927776, 11906.642800715992, 11239.325640461599, 11378.374189419661, 11406.0, 11423.543058277575, 11775.76448471043, 11732.589359372381, 11764.411779410824, 11824.881751182378, 11989.520419183134, 12215.328156951098, 12205.633830985085, 12213.938930305292, 12414.689632759253, 12495.562655307021, 12540.435680394221, 11664.416779160838, 11703.29780213156, 11712.355820429959, 12041.157119001937, 12070.0], "value": 9897.897548242894, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.0, 1638.4429294040026, 1670.582354411397, 1972.1421181785925, 2034.7660019097798, 8075.111737708855, 8652.480851148928, 8825.33809964252, 8825.646974121028, 8826.161514656113, 7378.96310518448, 8518.957405212965, 8827.735167944957, 8831.337649676283, 8835.072317406677, 2531.962020569693, 2549.8342607730438, 2552.923412297634, 2557.2328301509565, 2558.526672565572, 2480.52869954708, 2541.009006487471, 2545.121932933135, 2548.5412625727363, 2549.757773011561, 2504.912328068518, 2546.1343143331264, 2546.3506805764505, 2547.783438407738, 2551.4897020595863, 2507.3355560776317, 2523.3439305780444, 2533.5819589767666, 2549.4263790646955, 2549.757773011561, 2465.839720418185, 2521.2184222890965, 2528.1657053172594, 2534.176392672389, 2540.0728734011955, 8656.264217541517, 8935.508547029911, 8959.37284390093, 8965.551722413853, 8977.506237156953, 5421.457854214586, 5576.693281869496, 5586.581006424534, 5602.271704678406, 5604.131359639263, 3575.94636080459, 3675.981620091909, 3676.9080772980624, 3678.08047988003, 3714.1271801126713, 1027.4913917610832, 1056.260617567698, 1058.3120971368594, 1060.3796778884362, 1060.4750648428999, 11827.645170644895, 11918.642440726706, 11920.927116559551, 11947.103967202494, 11974.042076633936, 4111.239420707178, 4617.399738034034, 4755.358026666425, 4793.784279707422, 4800.35195248644, 9469.763255918657, 9486.95256523713, 9487.857682134774, 9489.810203795885, 9503.239740820718, 5458.344998600193, 5502.724863756796, 5506.972465137648, 5508.834734957877, 5511.035568775448, 3858.9421158682644, 4013.257547353749, 4713.057388522241, 5036.949630503721, 5098.643094983316, 3902.2585708715255, 3958.129211573449, 3972.602739726004, 4003.3594624860466, 4005.619466150711, 1246.7496169414114, 1252.1985929005443, 1254.2787896959285, 1261.1928365845865, 1264.4499642655474, 885.3271513649672, 950.9857352139724, 955.6559638530124, 984.389678399397, 1002.4737013068197, 6005.699715014319, 6132.141500189977, 6152.78465253714, 6190.783322583688, 6210.0, 483.3619622098796, 485.60665860652983, 490.71048081632006, 1065.7495488560182, 1078.3745427651943, 3958.3072962231495, 4051.473308469939, 4081.0409553754844, 4081.10215752534, 4121.814518346681, 10389.324693894872, 11090.5563777448, 11229.3262404256, 11234.49444774987, 11238.381888996184, 10646.14830813533, 10931.836022459669, 10947.233693641369, 11065.889341106647, 11077.833832492519, 8326.875096873551, 8442.831143377221, 8480.872786908201, 8497.66009359631, 8516.8722469163, 5692.7722891083895, 5878.529717622494, 5912.054071348563, 6020.397960203944, 6025.1564780931585, 9539.236861051239, 9694.079062489052, 9849.261305402268, 9861.605535778775, 9883.308168428428, 9790.922998470305, 9941.453220072965, 10090.949545252226, 10158.441285729356, 10172.389656620626, 6507.577007494498, 6659.53383263167, 6976.127984002, 7120.821979450555, 7242.058532390755, 8390.244877961013, 8443.113473085237, 8492.575371231538, 8492.787680307794, 8514.531700756517, 7426.4430167736555, 7563.584002879895, 7602.50583712057, 7619.238076192558, 7663.69345226207, 7355.5954422507275, 7396.149442814145, 7439.330460258603, 7554.244575542401, 7560.281773231534, 7042.119735033121, 7144.3570078693165, 7158.964205178941, 7178.389836863925, 7183.5330703504105, 4908.779104940215, 5018.422881368543, 5033.320501732365, 5039.874003149951, 5066.518680725325, 4978.5270399312, 5039.370078740158, 5123.820666276662, 5155.793768249378, 5293.841184764463], "value": 4645.009175766906, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.5071018117732, 332.8352465529563, 341.93845107880577, 344.3079410385125, 346.1346633416459, 6594.3735345142195, 6621.768238111667, 6698.162729658793, 6740.629265390402, 6755.121834161552, 6286.685665716707, 6434.517411194156, 6466.224053113621, 6614.933850661492, 6622.304658010899, 4940.7776650050655, 5005.874853128665, 5010.749462526877, 5012.273220383042, 5033.924491132627, 5004.074246264435, 5022.321986531808, 5027.019731152427, 5035.798568057292, 5038.748062596856, 4708.364370809948, 4794.113089078514, 4894.192458244385, 4928.33467481889, 4972.129877271481, 4900.191468407708, 4915.705057696532, 4927.926081108786, 4928.285398617216, 4958.851234462936, 4230.7038507304505, 4245.724027938174, 4247.299195632717, 4251.766152861592, 4254.638355739766, 6335.176427064498, 6341.270753863272, 6344.397282258178, 6345.397187267202, 6354.968225158891, 5787.363390027093, 5795.913061304083, 5803.65178089316, 5812.651240925516, 5813.505852002585, 6805.795826125224, 7007.894881576781, 7014.473914456436, 7026.859462810767, 7037.788866334018, 4695.201815691341, 4729.266963620645, 4744.051189762062, 4745.288206768978, 4756.762161891892, 7403.629818509053, 7406.296401841816, 7408.036955195844, 7410.740624078186, 7414.406847452245, 4785.832495862628, 4785.856424307276, 4810.975945120322, 4812.302216178635, 4814.807407703723, 4866.902661946812, 4873.6832105913, 4873.853784386474, 4874.53691899269, 4874.780634871368, 5555.77776888928, 5727.742251598688, 5747.971260143672, 5757.971210144006, 5778.624389414758, 7003.614801185984, 7044.36600705939, 7048.048513450721, 7072.504924655224, 7073.0, 1618.2636900210375, 1674.0959881663764, 1704.1734758642049, 1705.590658242013, 1710.9059001754774, 1044.5404022230193, 1096.446294621227, 1126.8591426071741, 1131.2985948711687, 1132.6715252576826, 5589.944100559023, 6848.623325717133, 6856.108705868205, 6882.7591034313555, 6885.965570172117, 7309.89035164473, 7322.231165727629, 7329.413646908234, 7331.486795924234, 7333.523320984119, 6952.826179345456, 7017.89473157903, 7027.297270273034, 7031.859362812817, 7037.401820845285, 3703.9444408333898, 3838.7120965927666, 3879.9030024249055, 3880.4373365862357, 3886.8250928708276, 6867.519273650796, 7132.500724949204, 7823.335016523545, 7824.608769561499, 7845.293923546908, 7447.664855081534, 7452.441066920002, 7464.656361854918, 7473.58895260755, 7483.027206463234, 7714.421418393643, 7775.1447340792465, 7775.688972441039, 7780.727674531364, 7814.296713295831, 6032.095185722177, 7013.333733295329, 7241.927580724126, 7274.0, 7278.272172782679, 6966.756163534252, 7105.822354440974, 7152.499325047404, 7153.60655163971, 7155.642217889189, 7749.41879359039, 7760.146383897654, 7762.728304509315, 7764.301212890867, 7767.92232077672, 4022.6379625833815, 4843.346148269939, 4845.781939812647, 4846.321514987975, 4858.692121242523, 7057.329553692391, 7242.348188663045, 7252.202257751537, 7403.185649578434, 7425.368843648134, 7100.289971003065, 7144.9642751785905, 7149.82125446868, 7183.389411900047, 7184.173820010766, 7119.857602848017, 7147.64261786919, 7149.85700285981, 7160.606166660884, 7164.570125792261, 6973.302669732986, 6985.336393042653, 6986.580805151707, 6990.860182796418, 6991.965040174767, 5738.483536481736, 5751.8562035949435, 6775.1531058617675, 6825.419839313516, 7138.785836424916, 6793.66031698423, 6872.725090996304, 6916.412104971134, 6922.238553758982, 7016.824579385556], "value": 5223.306228811041, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.2888939949449, 772.590527020679, 783.2206954080683, 806.0891192951967, 810.4165001199135, 15023.774643380344, 15254.694906101899, 15257.771133433007, 15267.389304427823, 15276.159811210393, 12054.0, 13512.98652601054, 13747.175169489838, 13929.442822287096, 13937.651558711037, 773.5165521549031, 795.2961628958385, 927.772695689557, 968.9806203875918, 970.2383628851353, 956.9808603827919, 969.6654654144309, 974.0648976982105, 975.5707488704983, 976.3117002513246, 838.337713206566, 1030.0369154840248, 1031.9174466042698, 1034.100332710543, 1034.6792494326746, 838.584900474263, 852.0244320253275, 852.1138016462871, 991.2565575818137, 1032.9845052324147, 771.4445599168589, 771.699037375424, 771.733751855609, 771.8417724366492, 771.9884201736978, 15104.39582416702, 15157.090574565562, 15177.848221517754, 15192.772108418383, 15193.772093418607, 12681.619551413472, 12923.547675831394, 13010.479580816756, 13158.60524184276, 13204.207747535083, 10239.742783252974, 10281.0, 10285.640002599948, 10364.896351036545, 10476.79046419075, 3542.220711443504, 3587.94618080729, 3589.964100358989, 3623.4564815277918, 3640.2355505343908, 79778.60110699467, 82076.58961705213, 82523.5873820633, 82647.5867620664, 82972.92567685795, 9488.430694158373, 9626.181774549243, 9680.854787178198, 9794.951025244829, 10324.638637647646, 18234.908825456052, 22048.228312009003, 22102.668459973112, 22112.88943555272, 22120.668189977165, 7501.512401693873, 7694.576798276036, 7705.691772329156, 7786.1824508426935, 7880.527168369917, 4182.2890108681595, 4238.321868501025, 4322.135572885372, 4349.499807522112, 4521.299198624219, 3741.4574886641285, 3783.5838057813617, 3799.6200379962333, 3800.8669696560487, 3813.0, 597.2415032908182, 603.3755063509246, 609.5458883132095, 615.7013848283578, 628.4375483941847, 605.6305653551331, 609.3632154398664, 617.478230894893, 626.214101302862, 631.034517188702, 8278.793030174294, 8477.364197685198, 8485.363597730195, 8532.36007299455, 8619.61211745473, 555.5944160762585, 560.2212924035593, 620.4694985787178, 628.2712054017318, 628.8836565235446, 3843.1160833008007, 3886.514185726784, 3911.8239679214503, 4008.2384346974563, 4025.959740402617, 82187.5890620543, 82498.0, 86382.13617863867, 87261.12738872657, 87660.1233987652, 61059.0, 76310.0, 76859.61570192114, 80430.19569804345, 81686.36627267422, 67738.66130669315, 67788.32211677919, 68235.31764682289, 69011.30988690049, 69195.65402172957, 7882.251186137537, 7882.330001949898, 7899.486533375312, 7965.920340796518, 8015.198480152171, 40503.1899362017, 45748.0, 49068.52794416173, 50333.99332013413, 52043.0, 64781.0, 66926.0, 70508.94236586557, 70684.29315706778, 71550.64224679052, 10233.539490723084, 10349.172066234834, 10518.421486818299, 10545.050945414949, 10564.84152737725, 10925.399103049409, 11170.720731981766, 11188.776224475301, 11227.045701115496, 11680.591179308683, 10337.9483102584, 10481.58073677075, 10493.317934334244, 10588.4705764713, 11116.944415277872, 10325.380477171393, 10423.322484038514, 10529.0, 10596.099331556905, 11112.833307500556, 10190.898091019291, 10251.58993640246, 10391.428471433841, 10974.0, 11013.953674400918, 8789.077146899483, 8862.049255697159, 9034.774130646787, 9122.664258566527, 9218.308626852879, 8912.55437228149, 9029.548522573976, 9065.592048357972, 9095.226905713089, 9204.309676774135], "value": 6889.53473067752, "unit": "score"}], "name": "dromaeo_css", "value": 7539.855393890579, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 116.0, 113.0, 112.0, 111.0, 112.0, 114.0, 114.0, 132.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 117.0, 142.0, 163.0, 115.0, 144.0, 142.0, 160.0, 161.0, 144.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 186.0, 185.0, 185.0, 184.0, 183.0, 183.0, 183.0, 184.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 72.0, 150.0, 55.0, 55.0, 56.0, 64.0, 128.0, 57.0], "value": 78.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 142.0, 79.0, 88.0, 86.0, 126.0, 80.0, 78.0, 124.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 87.0, 89.0, 85.0, 89.0, 86.0, 103.0, 130.0], "value": 93.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 93.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 85.0, 83.0, 84.0, 83.0, 85.0, 84.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 78.0, 58.0, 57.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 66.0, 69.0, 78.0, 98.0, 93.0, 96.0, 94.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 79.0, 78.0, 80.0, 78.0, 78.0, 78.0, 100.0, 79.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 125.0, 125.0, 126.0, 123.0, 132.0, 144.0, 163.0, 157.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 210.0, 180.0, 162.0, 159.0, 158.0, 163.0, 161.0, 164.0, 160.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 83.0, 99.0, 92.0, 72.0, 69.0, 66.0, 66.0, 65.0], "value": 74.6, "unit": "score"}], "name": "kraken", "value": 1495.2999999999997, "alertThreshold": 2.0}]} 09:45:10 INFO - Return code: 0 09:45:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:45:10 ERROR - # TBPL SUCCESS # 09:45:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:45:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:45:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:45:10 INFO - 2016-06-20 09:45:10.169 screenresolution[1680:9752] starting screenresolution argv=screenresolution get 09:45:10 INFO - 2016-06-20 09:45:10.172 screenresolution[1680:9752] Display 0: 1600x1200x32@60 09:45:10 INFO - 2016-06-20 09:45:10.178 screenresolution[1681:9755] starting screenresolution argv=screenresolution list 09:45:10 INFO - Available Modes on Display 0 09:45:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:45:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:45:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:45:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:45:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:45:10 INFO - Intel Iris: 09:45:10 INFO - Chipset Model: Intel Iris 09:45:10 INFO - Type: GPU 09:45:10 INFO - Bus: Built-In 09:45:10 INFO - VRAM (Dynamic, Max): 1536 MB 09:45:10 INFO - Vendor: Intel (0x8086) 09:45:10 INFO - Device ID: 0x0a2e 09:45:10 INFO - Revision ID: 0x0009 09:45:10 INFO - Displays: 09:45:10 INFO - Display: 09:45:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:45:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:45:10 INFO - Display Serial Number: 1600x1200 60 09:45:10 INFO - Main Display: Yes 09:45:10 INFO - Mirror: Off 09:45:10 INFO - Online: Yes 09:45:10 INFO - Rotation: Supported 09:45:10 INFO - Return code: 0 09:45:10 INFO - Running post-action listener: _resource_record_post_action 09:45:10 INFO - Running post-run listener: _resource_record_post_run 09:45:11 INFO - Total resource usage - Wall time: 1195s; CPU: 52.0%; Read bytes: 36623872; Write bytes: 494070272; Read time: 239; Write time: 1510 09:45:11 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 189227520; Write bytes: 187631104; Read time: 17432; Write time: 404 09:45:11 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 34797056; Write bytes: 295654400; Read time: 221; Write time: 1071 09:45:11 INFO - Running post-run listener: _upload_blobber_files 09:45:11 INFO - Blob upload gear active. 09:45:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:45:11 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 09:45:11 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'] 09:45:11 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 09:45:11 INFO - (blobuploader) - INFO - Open directory for files ... 09:45:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:45:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:45:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:12 INFO - (blobuploader) - INFO - Done attempting. 09:45:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:45:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:45:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:13 INFO - (blobuploader) - INFO - Done attempting. 09:45:13 INFO - (blobuploader) - INFO - Iteration through files over. 09:45:13 INFO - Return code: 0 09:45:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:45:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:45:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/40e003e9fb57e88e58bc2e8ac4db8583456cb76949829c16e170c6d8e6250099f9cf071737cf125ea16df552f8b6a15c19dcdc5237bd2b95cf2e0bdced872ca1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12bf1b620b7fd3b7461b55ab9daba21417490161eb38858c9ae5427189f89f9231cc7d31a5dcd3cd095b5d86a6721f3e1537da9516088fccb2fc6a0dd3aaf923"} 09:45:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:45:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:45:13 INFO - Contents: 09:45:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/40e003e9fb57e88e58bc2e8ac4db8583456cb76949829c16e170c6d8e6250099f9cf071737cf125ea16df552f8b6a15c19dcdc5237bd2b95cf2e0bdced872ca1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12bf1b620b7fd3b7461b55ab9daba21417490161eb38858c9ae5427189f89f9231cc7d31a5dcd3cd095b5d86a6721f3e1537da9516088fccb2fc6a0dd3aaf923"} 09:45:13 INFO - Running post-run listener: copy_logs_to_upload_dir 09:45:13 INFO - Copying logs to upload dir... 09:45:13 INFO - mkdir: /builds/slave/test/build/upload/logs 09:45:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.760114 ========= master_lag: 2.65 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-20 09:45:16.560059) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 09:45:16.563518) ========= 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.fo93KodIXq/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.TdlFDi7ffU/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/40e003e9fb57e88e58bc2e8ac4db8583456cb76949829c16e170c6d8e6250099f9cf071737cf125ea16df552f8b6a15c19dcdc5237bd2b95cf2e0bdced872ca1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12bf1b620b7fd3b7461b55ab9daba21417490161eb38858c9ae5427189f89f9231cc7d31a5dcd3cd095b5d86a6721f3e1537da9516088fccb2fc6a0dd3aaf923"} build_url:https://queue.taskcluster.net/v1/task/CY5ymJFDQA6-Yt661TadUQ/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/CY5ymJFDQA6-Yt661TadUQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/40e003e9fb57e88e58bc2e8ac4db8583456cb76949829c16e170c6d8e6250099f9cf071737cf125ea16df552f8b6a15c19dcdc5237bd2b95cf2e0bdced872ca1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12bf1b620b7fd3b7461b55ab9daba21417490161eb38858c9ae5427189f89f9231cc7d31a5dcd3cd095b5d86a6721f3e1537da9516088fccb2fc6a0dd3aaf923"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 09:45:16.594918) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 09:45:16.595322) ========= 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.fo93KodIXq/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.TdlFDi7ffU/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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.005054 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 09:45:16.644365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 09:45:16.644839) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 09:45:16.645345) ========= ========= Total master_lag: 4.14 =========