builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0288 starttime: 1467102354.82 results: success (0) buildid: 20160627053125 builduid: 91d531b5383642ed8679b7f776c5ef70 revision: 8664ad5c52883cb66cb9b46879eb062fb6600756 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:54.819606) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:54.820349) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:54.820683) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:54.846377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:54.847265) ========= 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.iBtIbYAGs9/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.GXDzlouhsd/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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-28 01:25:54-- 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.8M=0.001s 2016-06-28 01:25:54 (18.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127691 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:55.001936) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:55.002387) ========= 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.iBtIbYAGs9/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.GXDzlouhsd/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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.026345 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:55.052159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-28 01:25:55.052658) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8664ad5c52883cb66cb9b46879eb062fb6600756 --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 8664ad5c52883cb66cb9b46879eb062fb6600756 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iBtIbYAGs9/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.GXDzlouhsd/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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-28 01:25:55,136 truncating revision to first 12 chars 2016-06-28 01:25:55,136 Setting DEBUG logging. 2016-06-28 01:25:55,136 attempt 1/10 2016-06-28 01:25:55,136 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8664ad5c5288?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 01:25:56,965 unpacking tar archive at: mozilla-beta-8664ad5c5288/testing/mozharness/ program finished with exit code 0 elapsedTime=2.103212 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-28 01:25:57.181149) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:57.181973) ========= script_repo_revision: 8664ad5c52883cb66cb9b46879eb062fb6600756 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:57.182927) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:57.183573) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:25:57.203938) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 16 secs) (at 2016-06-28 01:25:57.204622) ========= /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.iBtIbYAGs9/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.GXDzlouhsd/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 01:25:57 INFO - MultiFileLogger online at 20160628 01:25:57 in /builds/slave/test 01:25:57 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 01:25:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:25:57 INFO - {'append_to_log': False, 01:25:57 INFO - 'base_work_dir': '/builds/slave/test', 01:25:57 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:25:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:25:57 INFO - 'branch': 'Mozilla-Beta', 01:25:57 INFO - 'buildbot_json_path': 'buildprops.json', 01:25:57 INFO - 'config_files': ('talos/mac_config.py',), 01:25:57 INFO - 'default_actions': ('clobber', 01:25:57 INFO - 'read-buildbot-config', 01:25:57 INFO - 'download-and-extract', 01:25:57 INFO - 'populate-webroot', 01:25:57 INFO - 'create-virtualenv', 01:25:57 INFO - 'install', 01:25:57 INFO - 'run-tests'), 01:25:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:25:57 INFO - 'download_minidump_stackwalk': True, 01:25:57 INFO - 'download_symbols': 'ondemand', 01:25:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:25:57 INFO - 'tooltool.py': '/tools/tooltool.py', 01:25:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:25:57 INFO - '/tools/misc-python/virtualenv.py')}, 01:25:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:25:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:25:57 INFO - 'installer_path': 'installer.exe', 01:25:57 INFO - 'log_level': 'info', 01:25:57 INFO - 'log_name': 'talos', 01:25:57 INFO - 'log_to_console': True, 01:25:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:25:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:25:57 INFO - 'opt_config_files': (), 01:25:57 INFO - 'pip_index': False, 01:25:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:25:57 INFO - 'cmd': ('bash', 01:25:57 INFO - '-c', 01:25:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:25:57 INFO - 'enabled': True, 01:25:57 INFO - 'halt_on_failure': False, 01:25:57 INFO - 'name': 'check_screen_resolution'},), 01:25:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:25:57 INFO - 'cmd': ('bash', 01:25:57 INFO - '-c', 01:25:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:25:57 INFO - 'enabled': True, 01:25:57 INFO - 'halt_on_failure': False, 01:25:57 INFO - 'name': 'check_screen_resolution'},), 01:25:57 INFO - 'run_cmd_checks_enabled': True, 01:25:57 INFO - 'sps_profile': False, 01:25:57 INFO - 'sps_profile_interval': 0, 01:25:57 INFO - 'suite': 'dromaeojs', 01:25:57 INFO - 'system_bits': '32', 01:25:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:25:57 INFO - 'title': 't-yosemite-r7-0288', 01:25:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:25:57 INFO - 'use_talos_json': True, 01:25:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:25:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:25:57 INFO - 'work_dir': 'build'} 01:25:57 INFO - ##### 01:25:57 INFO - ##### Running clobber step. 01:25:57 INFO - ##### 01:25:57 INFO - Running pre-action listener: _resource_record_pre_action 01:25:57 INFO - Running main action method: clobber 01:25:57 INFO - rmtree: /builds/slave/test/build 01:25:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:25:59 INFO - Running post-action listener: _resource_record_post_action 01:25:59 INFO - ##### 01:25:59 INFO - ##### Running read-buildbot-config step. 01:25:59 INFO - ##### 01:25:59 INFO - Running pre-action listener: _resource_record_pre_action 01:25:59 INFO - Running main action method: read_buildbot_config 01:25:59 INFO - Using buildbot properties: 01:25:59 INFO - { 01:25:59 INFO - "project": "", 01:25:59 INFO - "product": "firefox", 01:25:59 INFO - "script_repo_revision": "production", 01:25:59 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 01:25:59 INFO - "repository": "", 01:25:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 01:25:59 INFO - "buildid": "20160627053125", 01:25:59 INFO - "pgo_build": "False", 01:25:59 INFO - "basedir": "/builds/slave/test", 01:25:59 INFO - "buildnumber": 2, 01:25:59 INFO - "slavename": "t-yosemite-r7-0288", 01:25:59 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 01:25:59 INFO - "platform": "yosemite_r7", 01:25:59 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 01:25:59 INFO - "branch": "mozilla-beta", 01:25:59 INFO - "repo_path": "releases/mozilla-beta", 01:25:59 INFO - "revision": "8664ad5c52883cb66cb9b46879eb062fb6600756", 01:25:59 INFO - "stage_platform": "macosx64", 01:25:59 INFO - "builduid": "91d531b5383642ed8679b7f776c5ef70", 01:25:59 INFO - "slavebuilddir": "test" 01:25:59 INFO - } 01:25:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 01:25:59 INFO - Running post-action listener: _resource_record_post_action 01:25:59 INFO - ##### 01:25:59 INFO - ##### Running download-and-extract step. 01:25:59 INFO - ##### 01:25:59 INFO - Running pre-action listener: _resource_record_pre_action 01:25:59 INFO - Running main action method: download_and_extract 01:25:59 INFO - mkdir: /builds/slave/test/build/tests 01:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:59 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:25:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:25:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:25:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/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 01:25:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/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 01:26:00 INFO - Downloaded 1165 bytes. 01:26:00 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:26:00 INFO - Using the following test package requirements: 01:26:00 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:26:00 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:26:00 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 01:26:00 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:26:00 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 01:26:00 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 01:26:00 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:26:00 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 01:26:00 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:26:00 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:26:00 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 01:26:00 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:26:00 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 01:26:00 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:26:00 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 01:26:00 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:26:00 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 01:26:00 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 01:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:00 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:26:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:26:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:26:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/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 01:26:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/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 01:26:01 INFO - Downloaded 18344127 bytes. 01:26:01 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'] 01:26:01 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 01:26:05 INFO - Return code: 0 01:26:05 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 01:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:05 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:26:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:26:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:26:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/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 01:26:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/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 01:26:06 INFO - Downloaded 18344127 bytes. 01:26:06 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'] 01:26:06 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 01:26:09 INFO - Return code: 0 01:26:09 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')]} 01:26:09 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:26:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:26:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:26:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/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 01:26:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/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 01:26:10 INFO - Downloaded 10840145 bytes. 01:26:10 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'] 01:26:10 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 01:26:10 INFO - Return code: 0 01:26: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')]} 01:26:10 INFO - https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 01:26:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:26:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:26:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 01:26:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FO6Gl0R-S5eBjr032mt9RA/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 01:26:13 INFO - Downloaded 86228614 bytes. 01:26:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:26:13 INFO - mkdir: /builds/slave/test/properties 01:26:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:26:13 INFO - Writing to file /builds/slave/test/properties/build_url 01:26:13 INFO - Contents: 01:26:13 INFO - build_url:https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:26:14 INFO - Running post-action listener: _resource_record_post_action 01:26:14 INFO - Running post-action listener: set_extra_try_arguments 01:26:14 INFO - ##### 01:26:14 INFO - ##### Running populate-webroot step. 01:26:14 INFO - ##### 01:26:14 INFO - Running pre-action listener: _resource_record_pre_action 01:26:14 INFO - Running main action method: populate_webroot 01:26:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:26:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:26:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:26:14 INFO - '--tppagecycles', 01:26:14 INFO - '7'], 01:26:14 INFO - 'tests': ['tsvgm']}}, 01:26:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:26:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:26:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:26:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:26:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:26:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:26:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:14 INFO - 'talos_options': ['--disable-e10s'], 01:26:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:26:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:26:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:14 INFO - 'talos_options': ['--disable-e10s'], 01:26:14 INFO - 'tests': ['damp', 'tps']}, 01:26:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:14 INFO - 'tests': ['damp', 'tps']}, 01:26:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:26:14 INFO - 'tests': ['dromaeo_dom']}, 01:26:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:26:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:26:14 INFO - 'tests': ['a11yr', 01:26:14 INFO - 'ts_paint', 01:26:14 INFO - 'tpaint', 01:26:14 INFO - 'sessionrestore', 01:26:14 INFO - 'sessionrestore_no_auto_restore', 01:26:14 INFO - 'tabpaint']}, 01:26:14 INFO - 'other-e10s': {'tests': ['a11yr', 01:26:14 INFO - 'ts_paint', 01:26:14 INFO - 'tpaint', 01:26:14 INFO - 'sessionrestore', 01:26:14 INFO - 'sessionrestore_no_auto_restore', 01:26:14 INFO - 'tabpaint']}, 01:26:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:26:14 INFO - 'ts_paint', 01:26:14 INFO - 'tpaint', 01:26:14 INFO - 'sessionrestore', 01:26:14 INFO - 'sessionrestore_no_auto_restore', 01:26:14 INFO - 'tabpaint']}, 01:26:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:26:14 INFO - 'ts_paint', 01:26:14 INFO - 'tpaint', 01:26:14 INFO - 'sessionrestore', 01:26:14 INFO - 'sessionrestore_no_auto_restore', 01:26:14 INFO - 'tabpaint']}, 01:26:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:26:14 INFO - 'tests': ['a11yr', 01:26:14 INFO - 'ts_paint', 01:26:14 INFO - 'tpaint', 01:26:14 INFO - 'sessionrestore', 01:26:14 INFO - 'sessionrestore_no_auto_restore', 01:26:14 INFO - 'tabpaint']}, 01:26:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:26:14 INFO - 'tests': ['a11yr', 01:26:14 INFO - 'ts_paint', 01:26:14 INFO - 'tpaint', 01:26:14 INFO - 'sessionrestore', 01:26:14 INFO - 'sessionrestore_no_auto_restore', 01:26:14 INFO - 'tabpaint']}, 01:26:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:26:14 INFO - 'tests': ['tsvgx', 01:26:14 INFO - 'tsvgr_opacity', 01:26:14 INFO - 'tart', 01:26:14 INFO - 'tscrollx', 01:26:14 INFO - 'cart']}, 01:26:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:26:14 INFO - 'tsvgr_opacity', 01:26:14 INFO - 'tart', 01:26:14 INFO - 'tscrollx', 01:26:14 INFO - 'cart']}, 01:26:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:14 INFO - 'talos_options': ['--disable-e10s'], 01:26:14 INFO - 'tests': ['tp5o']}, 01:26:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:14 INFO - 'tests': ['tp5o']}, 01:26:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:14 INFO - 'talos_options': ['--disable-e10s', 01:26:14 INFO - '--xperf_path', 01:26:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:26:14 INFO - 'tests': ['tp5n']}, 01:26:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:14 INFO - 'talos_options': ['--xperf_path', 01:26:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:26:14 INFO - 'tests': ['tp5n']}}, 01:26:14 INFO - 'talos.zip': {'path': '', 01:26:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:26:14 INFO - Running post-action listener: _resource_record_post_action 01:26:14 INFO - ##### 01:26:14 INFO - ##### Running create-virtualenv step. 01:26:14 INFO - ##### 01:26:14 INFO - Running pre-action listener: _resource_record_pre_action 01:26:14 INFO - Running main action method: create_virtualenv 01:26:14 INFO - Creating virtualenv /builds/slave/test/build/venv 01:26:14 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 01:26:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:26:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:26:14 INFO - Using real prefix '/tools/python27' 01:26:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:26:15 INFO - Installing distribute.............................................................................................................................................................................................done. 01:26:17 INFO - Installing pip.................done. 01:26:17 INFO - Return code: 0 01:26:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:17 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 0x1101eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101fb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7604adac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008ae00>, '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 0x10fef3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110085b20>, '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.iBtIbYAGs9/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.GXDzlouhsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 01:26:17 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 01:26:17 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 01:26:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iBtIbYAGs9/Render', 01:26:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:17 INFO - 'HOME': '/Users/cltbld', 01:26:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:17 INFO - 'LOGNAME': 'cltbld', 01:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:17 INFO - 'MOZ_NO_REMOTE': '1', 01:26:17 INFO - 'NO_EM_RESTART': '1', 01:26:17 INFO - 'PAGER': '/bin/cat', 01:26:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:17 INFO - 'PWD': '/builds/slave/test', 01:26:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:17 INFO - 'SHELL': '/bin/bash', 01:26:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GXDzlouhsd/Listeners', 01:26:17 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 01:26:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:17 INFO - 'USER': 'cltbld', 01:26:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:17 INFO - 'XPC_FLAGS': '0x0', 01:26:17 INFO - 'XPC_SERVICE_NAME': '0', 01:26:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:18 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 01:26:18 INFO - Cleaning up... 01:26:18 INFO - Return code: 0 01:26:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:18 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 0x1101eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101fb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7604adac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008ae00>, '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 0x10fef3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110085b20>, '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.iBtIbYAGs9/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.GXDzlouhsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 01:26:18 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 01:26:18 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 01:26:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iBtIbYAGs9/Render', 01:26:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:18 INFO - 'HOME': '/Users/cltbld', 01:26:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:18 INFO - 'LOGNAME': 'cltbld', 01:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:18 INFO - 'MOZ_NO_REMOTE': '1', 01:26:18 INFO - 'NO_EM_RESTART': '1', 01:26:18 INFO - 'PAGER': '/bin/cat', 01:26:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:18 INFO - 'PWD': '/builds/slave/test', 01:26:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:18 INFO - 'SHELL': '/bin/bash', 01:26:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GXDzlouhsd/Listeners', 01:26:18 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 01:26:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:18 INFO - 'USER': 'cltbld', 01:26:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:18 INFO - 'XPC_FLAGS': '0x0', 01:26:18 INFO - 'XPC_SERVICE_NAME': '0', 01:26:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:18 INFO - Downloading/unpacking psutil>=0.7.1 01:26:18 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 01:26:18 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 01:26:18 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 01:26:18 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 01:26:18 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 01:26:18 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 01:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:26:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:21 INFO - Installing collected packages: psutil 01:26:21 INFO - Running setup.py install for psutil 01:26:21 INFO - building 'psutil._psutil_osx' extension 01:26:21 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 01:26:21 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 01:26:21 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 01:26:21 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 01:26:21 INFO - building 'psutil._psutil_posix' extension 01:26:21 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 01:26:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:26:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:26:21 INFO - ^ 01:26:21 INFO - 1 warning generated. 01:26:21 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 01:26:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:22 INFO - Successfully installed psutil 01:26:22 INFO - Cleaning up... 01:26:22 INFO - Return code: 0 01:26:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:22 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 0x1101eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101fb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7604adac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008ae00>, '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 0x10fef3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110085b20>, '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.iBtIbYAGs9/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.GXDzlouhsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 01:26:22 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 01:26:22 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 01:26:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iBtIbYAGs9/Render', 01:26:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:22 INFO - 'HOME': '/Users/cltbld', 01:26:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:22 INFO - 'LOGNAME': 'cltbld', 01:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:22 INFO - 'MOZ_NO_REMOTE': '1', 01:26:22 INFO - 'NO_EM_RESTART': '1', 01:26:22 INFO - 'PAGER': '/bin/cat', 01:26:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:22 INFO - 'PWD': '/builds/slave/test', 01:26:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:22 INFO - 'SHELL': '/bin/bash', 01:26:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GXDzlouhsd/Listeners', 01:26:22 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 01:26:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:22 INFO - 'USER': 'cltbld', 01:26:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:22 INFO - 'XPC_FLAGS': '0x0', 01:26:22 INFO - 'XPC_SERVICE_NAME': '0', 01:26:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:26:22 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 01:26:22 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 01:26:22 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 01:26:22 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 01:26:22 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 01:26:22 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 01:26:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:26:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:26:25 INFO - Installing collected packages: mozsystemmonitor 01:26:25 INFO - Running setup.py install for mozsystemmonitor 01:26:25 INFO - Successfully installed mozsystemmonitor 01:26:25 INFO - Cleaning up... 01:26:25 INFO - Return code: 0 01:26:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:25 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 0x1101eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101fb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7604adac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008ae00>, '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 0x10fef3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110085b20>, '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.iBtIbYAGs9/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.GXDzlouhsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 01:26:25 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 01:26:25 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 01:26:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iBtIbYAGs9/Render', 01:26:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:25 INFO - 'HOME': '/Users/cltbld', 01:26:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:25 INFO - 'LOGNAME': 'cltbld', 01:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:25 INFO - 'MOZ_NO_REMOTE': '1', 01:26:25 INFO - 'NO_EM_RESTART': '1', 01:26:25 INFO - 'PAGER': '/bin/cat', 01:26:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:25 INFO - 'PWD': '/builds/slave/test', 01:26:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:25 INFO - 'SHELL': '/bin/bash', 01:26:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GXDzlouhsd/Listeners', 01:26:25 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 01:26:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:25 INFO - 'USER': 'cltbld', 01:26:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:25 INFO - 'XPC_FLAGS': '0x0', 01:26:25 INFO - 'XPC_SERVICE_NAME': '0', 01:26:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:25 INFO - Downloading/unpacking blobuploader==1.2.4 01:26:25 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 01:26:25 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 01:26:25 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 01:26:25 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 01:26:25 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 01:26:25 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 01:26:27 INFO - Downloading blobuploader-1.2.4.tar.gz 01:26:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:26:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:26:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:29 INFO - Downloading docopt-0.6.1.tar.gz 01:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:26:29 INFO - Installing collected packages: blobuploader, requests, docopt 01:26:29 INFO - Running setup.py install for blobuploader 01:26:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:26:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:26:29 INFO - Running setup.py install for requests 01:26:29 INFO - Running setup.py install for docopt 01:26:30 INFO - Successfully installed blobuploader requests docopt 01:26:30 INFO - Cleaning up... 01:26:30 INFO - Return code: 0 01:26:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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')]} 01:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:30 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 0x1101eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101fb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7604adac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008ae00>, '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 0x10fef3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110085b20>, '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.iBtIbYAGs9/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.GXDzlouhsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 01:26:30 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 01:26:30 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 01:26:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iBtIbYAGs9/Render', 01:26:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:30 INFO - 'HOME': '/Users/cltbld', 01:26:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:30 INFO - 'LOGNAME': 'cltbld', 01:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:30 INFO - 'MOZ_NO_REMOTE': '1', 01:26:30 INFO - 'NO_EM_RESTART': '1', 01:26:30 INFO - 'PAGER': '/bin/cat', 01:26:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:30 INFO - 'PWD': '/builds/slave/test', 01:26:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:30 INFO - 'SHELL': '/bin/bash', 01:26:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GXDzlouhsd/Listeners', 01:26:30 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 01:26:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:30 INFO - 'USER': 'cltbld', 01:26:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:30 INFO - 'XPC_FLAGS': '0x0', 01:26:30 INFO - 'XPC_SERVICE_NAME': '0', 01:26:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:26:30 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-LDSHPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:26:30 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-CAGomE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:26:30 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-d7MPxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:26:30 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-bM2Rvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:26:30 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-KosTOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:26:30 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-Msg4JP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:26:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-yPGUvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:26:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-RnwhgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:26:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-gmvD_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:26:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-BYXHq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:26:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-ZiWNnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:26:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-g4Tugk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:26:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-PDSQe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:26:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-EstWpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-iXpdfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:26:31 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-ydIxzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:26:32 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-drgWaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:26:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:26:32 INFO - Running setup.py install for manifestparser 01:26:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:26:32 INFO - Running setup.py install for mozcrash 01:26:32 INFO - Running setup.py install for mozdebug 01:26:32 INFO - Running setup.py install for mozdevice 01:26:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:26:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:26:32 INFO - Running setup.py install for mozfile 01:26:32 INFO - Running setup.py install for mozhttpd 01:26:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:26:33 INFO - Running setup.py install for mozinfo 01:26:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:26:33 INFO - Running setup.py install for mozInstall 01:26:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:26:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:26:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:26:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:26:33 INFO - Running setup.py install for mozleak 01:26:33 INFO - Running setup.py install for mozlog 01:26:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:26:33 INFO - Running setup.py install for moznetwork 01:26:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:26:33 INFO - Running setup.py install for mozprocess 01:26:33 INFO - Running setup.py install for mozprofile 01:26:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:26:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:26:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:26:34 INFO - Running setup.py install for mozrunner 01:26:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:26:34 INFO - Running setup.py install for mozscreenshot 01:26:34 INFO - Running setup.py install for moztest 01:26:34 INFO - Running setup.py install for mozversion 01:26:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:26:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:26:34 INFO - Cleaning up... 01:26:34 INFO - Return code: 0 01:26:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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')]} 01:26:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:34 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 0x1101eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101fb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7604adac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008ae00>, '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 0x10fef3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110085b20>, '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.iBtIbYAGs9/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.GXDzlouhsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 01:26:34 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 01:26:34 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 01:26:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iBtIbYAGs9/Render', 01:26:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:34 INFO - 'HOME': '/Users/cltbld', 01:26:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:34 INFO - 'LOGNAME': 'cltbld', 01:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:34 INFO - 'MOZ_NO_REMOTE': '1', 01:26:34 INFO - 'NO_EM_RESTART': '1', 01:26:34 INFO - 'PAGER': '/bin/cat', 01:26:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:34 INFO - 'PWD': '/builds/slave/test', 01:26:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:34 INFO - 'SHELL': '/bin/bash', 01:26:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GXDzlouhsd/Listeners', 01:26:34 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 01:26:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:34 INFO - 'USER': 'cltbld', 01:26:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:34 INFO - 'XPC_FLAGS': '0x0', 01:26:34 INFO - 'XPC_SERVICE_NAME': '0', 01:26:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:26:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-YxiUpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:26:35 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)) 01:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:26:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-9d2Dif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:26:35 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)) 01:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:26:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-TBIz69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:26:35 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)) 01:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:26:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-qV2Ilr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:26:35 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)) 01:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:26:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-4VM1gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:26:35 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)) 01:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:26:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-mcdZ3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:26:35 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)) 01:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:26:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-wW4n5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:26:35 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)) 01:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:26:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-PVdPkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:26:35 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)) 01:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:26:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-0xkPl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:26:36 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)) 01:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:26:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-Mtd_os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:26:36 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)) 01:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:26:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-814RVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:26:36 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)) 01:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:26:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-OmaNDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:26:36 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)) 01:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:26:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-CFW0Yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:26:36 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)) 01:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:26:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-3lFB6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:26:36 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)) 01:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-rBq6FV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:36 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)) 01:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:26:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-MqLiUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:26:36 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)) 01:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:26:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-D6n4yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:26:36 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)) 01:26:36 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)) 01:26:36 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)) 01:26:36 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)) 01:26:36 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)) 01:26:36 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)) 01:26:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:39 INFO - Downloading blessings-1.6.tar.gz 01:26:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:26:39 INFO - Installing collected packages: blessings 01:26:39 INFO - Running setup.py install for blessings 01:26:39 INFO - Successfully installed blessings 01:26:39 INFO - Cleaning up... 01:26:39 INFO - Return code: 0 01:26:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:26:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:26:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:26:40 INFO - Reading from file tmpfile_stdout 01:26:40 INFO - Current package versions: 01:26:40 INFO - blessings == 1.6 01:26:40 INFO - blobuploader == 1.2.4 01:26:40 INFO - docopt == 0.6.1 01:26:40 INFO - manifestparser == 1.1 01:26:40 INFO - mozInstall == 1.12 01:26:40 INFO - mozcrash == 0.17 01:26:40 INFO - mozdebug == 0.1 01:26:40 INFO - mozdevice == 0.48 01:26:40 INFO - mozfile == 1.2 01:26:40 INFO - mozhttpd == 0.7 01:26:40 INFO - mozinfo == 0.9 01:26:40 INFO - mozleak == 0.1 01:26:40 INFO - mozlog == 3.1 01:26:40 INFO - moznetwork == 0.27 01:26:40 INFO - mozprocess == 0.22 01:26:40 INFO - mozprofile == 0.28 01:26:40 INFO - mozrunner == 6.11 01:26:40 INFO - mozscreenshot == 0.1 01:26:40 INFO - mozsystemmonitor == 0.0 01:26:40 INFO - moztest == 0.7 01:26:40 INFO - mozversion == 1.4 01:26:40 INFO - psutil == 3.1.1 01:26:40 INFO - requests == 1.2.3 01:26:40 INFO - wsgiref == 0.1.2 01:26:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26:40 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')]} 01:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:40 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')]} 01:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:40 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 0x1101eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101fb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7604adac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008ae00>, '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 0x10fef3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110085b20>, '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.iBtIbYAGs9/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.GXDzlouhsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 01:26:40 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 01:26:40 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 01:26:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iBtIbYAGs9/Render', 01:26:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:40 INFO - 'HOME': '/Users/cltbld', 01:26:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:40 INFO - 'LOGNAME': 'cltbld', 01:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:40 INFO - 'MOZ_NO_REMOTE': '1', 01:26:40 INFO - 'NO_EM_RESTART': '1', 01:26:40 INFO - 'PAGER': '/bin/cat', 01:26:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:40 INFO - 'PWD': '/builds/slave/test', 01:26:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:40 INFO - 'SHELL': '/bin/bash', 01:26:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GXDzlouhsd/Listeners', 01:26:40 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 01:26:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:40 INFO - 'USER': 'cltbld', 01:26:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:40 INFO - 'XPC_FLAGS': '0x0', 01:26:40 INFO - 'XPC_SERVICE_NAME': '0', 01:26:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:40 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)) 01:26:40 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)) 01:26:40 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)) 01:26:40 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)) 01:26:40 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)) 01:26:40 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)) 01:26:40 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)) 01:26:40 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)) 01:26:40 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)) 01:26:40 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)) 01:26:40 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)) 01:26:40 INFO - Cleaning up... 01:26:40 INFO - Return code: 0 01:26:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:26:40 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')]} 01:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:40 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')]} 01:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:40 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 0x1101eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101fb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7604adac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008ae00>, '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 0x10fef3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110085b20>, '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.iBtIbYAGs9/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.GXDzlouhsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 01:26:40 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 01:26:40 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 01:26:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iBtIbYAGs9/Render', 01:26:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:40 INFO - 'HOME': '/Users/cltbld', 01:26:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:40 INFO - 'LOGNAME': 'cltbld', 01:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:40 INFO - 'MOZ_NO_REMOTE': '1', 01:26:40 INFO - 'NO_EM_RESTART': '1', 01:26:40 INFO - 'PAGER': '/bin/cat', 01:26:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:40 INFO - 'PWD': '/builds/slave/test', 01:26:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:40 INFO - 'SHELL': '/bin/bash', 01:26:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GXDzlouhsd/Listeners', 01:26:40 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 01:26:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:40 INFO - 'USER': 'cltbld', 01:26:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:40 INFO - 'XPC_FLAGS': '0x0', 01:26:40 INFO - 'XPC_SERVICE_NAME': '0', 01:26:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:40 INFO - Downloading/unpacking jsonschema 01:26:40 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 01:26:40 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 01:26:40 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 01:26:40 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 01:26:40 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 01:26:40 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 01:26:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:26:42 INFO - Downloading/unpacking functools32 (from jsonschema) 01:26:42 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 01:26:42 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 01:26:42 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 01:26:42 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 01:26:42 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 01:26:42 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 01:26:43 INFO - Downloading functools32-3.2.3-2.tar.gz 01:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:26:43 INFO - warning: no files found matching '*.txt' 01:26:43 INFO - no previously-included directories found matching 'build' 01:26:43 INFO - no previously-included directories found matching 'dist' 01:26:43 INFO - no previously-included directories found matching '.git*' 01:26:43 INFO - Installing collected packages: jsonschema, functools32 01:26:43 INFO - Running setup.py install for functools32 01:26:43 INFO - warning: no files found matching '*.txt' 01:26:43 INFO - no previously-included directories found matching 'build' 01:26:43 INFO - no previously-included directories found matching 'dist' 01:26:43 INFO - no previously-included directories found matching '.git*' 01:26:43 INFO - Successfully installed jsonschema functools32 01:26:43 INFO - Cleaning up... 01:26:43 INFO - Return code: 0 01:26:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101fb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7604adac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11008ae00>, '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 0x10fef3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110085b20>, '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.iBtIbYAGs9/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.GXDzlouhsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 01:26:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:26:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iBtIbYAGs9/Render', 01:26:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:43 INFO - 'HOME': '/Users/cltbld', 01:26:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:43 INFO - 'LOGNAME': 'cltbld', 01:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:43 INFO - 'MOZ_NO_REMOTE': '1', 01:26:43 INFO - 'NO_EM_RESTART': '1', 01:26:43 INFO - 'PAGER': '/bin/cat', 01:26:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:43 INFO - 'PWD': '/builds/slave/test', 01:26:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:43 INFO - 'SHELL': '/bin/bash', 01:26:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GXDzlouhsd/Listeners', 01:26:43 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 01:26:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:43 INFO - 'USER': 'cltbld', 01:26:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:43 INFO - 'XPC_FLAGS': '0x0', 01:26:43 INFO - 'XPC_SERVICE_NAME': '0', 01:26:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:43 INFO - Downloading/unpacking flake8 01:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:44 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 01:26:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:26:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:26:46 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 01:26:46 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 01:26:46 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 01:26:46 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 01:26:46 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 01:26:46 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 01:26:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:26:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:26:46 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 01:26:46 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 01:26:46 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 01:26:46 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 01:26:46 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 01:26:46 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 01:26:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:26:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:26:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:26:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:26:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:26:47 INFO - no previously-included directories found matching 'docs/_build' 01:26:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:26:47 INFO - Running setup.py install for pep8 01:26:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:26:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:26:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:26:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:26:47 INFO - no previously-included directories found matching 'docs/_build' 01:26:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:26:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:26:47 INFO - Cleaning up... 01:26:48 INFO - Return code: 0 01:26:48 INFO - Running post-action listener: _resource_record_post_action 01:26:48 INFO - Running post-action listener: _start_resource_monitoring 01:26:48 INFO - Starting resource monitoring. 01:26:48 INFO - ##### 01:26:48 INFO - ##### Running install step. 01:26:48 INFO - ##### 01:26:48 INFO - Running pre-action listener: _resource_record_pre_action 01:26:48 INFO - Running main action method: install 01:26:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:26:48 INFO - Reading from file tmpfile_stdout 01:26:48 INFO - Detecting whether we're running mozinstall >=1.0... 01:26:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:26:48 INFO - Reading from file tmpfile_stdout 01:26:48 INFO - Output received: 01:26:48 INFO - Usage: mozinstall [options] installer 01:26:48 INFO - Options: 01:26:48 INFO - -h, --help show this help message and exit 01:26:48 INFO - -d DEST, --destination=DEST 01:26:48 INFO - Directory to install application into. [default: 01:26:48 INFO - "/builds/slave/test"] 01:26:48 INFO - --app=APP Application being installed. [default: firefox] 01:26:48 INFO - mkdir: /builds/slave/test/build/application 01:26:48 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'] 01:26:48 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 01:27:10 INFO - Reading from file tmpfile_stdout 01:27:10 INFO - Output received: 01:27:10 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 01:27:10 INFO - Running post-action listener: _resource_record_post_action 01:27:10 INFO - ##### 01:27:10 INFO - ##### Running run-tests step. 01:27:10 INFO - ##### 01:27:10 INFO - Running pre-action listener: _resource_record_pre_action 01:27:10 INFO - Running main action method: run_tests 01:27:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:27:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:27:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:27:10 INFO - 2016-06-28 01:27:10.523 screenresolution[1646:7392] starting screenresolution argv=screenresolution get 01:27:10 INFO - 2016-06-28 01:27:10.526 screenresolution[1646:7392] Display 0: 1600x1200x32@60 01:27:10 INFO - 2016-06-28 01:27:10.532 screenresolution[1647:7394] starting screenresolution argv=screenresolution list 01:27:10 INFO - Available Modes on Display 0 01:27:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:27:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:27:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:27:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:27:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:27:10 INFO - Intel Iris: 01:27:10 INFO - Chipset Model: Intel Iris 01:27:10 INFO - Type: GPU 01:27:10 INFO - Bus: Built-In 01:27:10 INFO - VRAM (Dynamic, Max): 1536 MB 01:27:10 INFO - Vendor: Intel (0x8086) 01:27:10 INFO - Device ID: 0x0a2e 01:27:10 INFO - Revision ID: 0x0009 01:27:10 INFO - Displays: 01:27:10 INFO - Display: 01:27:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:27:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:27:10 INFO - Display Serial Number: 1600x1200 60 01:27:10 INFO - Main Display: Yes 01:27:10 INFO - Mirror: Off 01:27:10 INFO - Online: Yes 01:27:10 INFO - Rotation: Supported 01:27:10 INFO - Return code: 0 01:27:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:27:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:27:10 INFO - Python 2.7.3 01:27:10 INFO - Return code: 0 01:27:10 INFO - grabbing minidump binary from tooltool 01:27: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')]} 01:27:10 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 0x11008ae00>, '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 0x10fef3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110085b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:27:10 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 01:27:10 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 01:27:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:27:10 INFO - Return code: 0 01:27:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:27:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:27:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:27:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:27:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:27:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:27:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:27:11 INFO - Return code: 0 01:27:11 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/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0288', '--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 01:27:11 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/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0288 --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 01:27:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iBtIbYAGs9/Render', 01:27:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:27:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:27:11 INFO - 'HOME': '/Users/cltbld', 01:27:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:27:11 INFO - 'LOGNAME': 'cltbld', 01:27:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:27:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:11 INFO - 'MOZ_NO_REMOTE': '1', 01:27:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:27:11 INFO - 'NO_EM_RESTART': '1', 01:27:11 INFO - 'PAGER': '/bin/cat', 01:27:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:11 INFO - 'PWD': '/builds/slave/test', 01:27:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:27:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:27:11 INFO - 'SHELL': '/bin/bash', 01:27:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GXDzlouhsd/Listeners', 01:27:11 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 01:27:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:27:11 INFO - 'USER': 'cltbld', 01:27:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:27:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:11 INFO - 'XPC_FLAGS': '0x0', 01:27:11 INFO - 'XPC_SERVICE_NAME': '0', 01:27:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:27:11 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/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0288', '--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 01:27:12 INFO - mozversion application_buildid: 20160627053125 01:27:12 INFO - mozversion application_changeset: 8664ad5c52883cb66cb9b46879eb062fb6600756 01:27:12 INFO - mozversion application_display_name: Firefox 01:27:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:27:12 INFO - mozversion application_name: Firefox 01:27:12 INFO - mozversion application_remotingname: firefox 01:27:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:27:12 INFO - mozversion application_vendor: Mozilla 01:27:12 INFO - mozversion application_version: 48.0 01:27:12 INFO - mozversion platform_buildid: 20160627053125 01:27:12 INFO - mozversion platform_changeset: 8664ad5c52883cb66cb9b46879eb062fb6600756 01:27:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:27:12 INFO - mozversion platform_version: 48.0 01:27:12 INFO - using testdate: 1467102432 01:27:12 INFO - actual date: 1467102432 01:27:12 INFO - starting webserver on 'localhost:49277' 01:27:12 INFO - SUITE-START | Running 2 tests 01:27:12 INFO - TEST-START | dromaeo_css 01:27:12 INFO - operating with platform_type : mac_ 01:27:12 INFO - Initialising browser for dromaeo_css test... 01:27:12 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpUXrqAv/profile http://localhost:49277/getInfo.html) 01:27:14 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 01:27:14 INFO - PROCESS | 1665 | colorDepth:24 01:27:14 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 01:27:14 INFO - PROCESS | 1665 | __metrics 01:27:14 INFO - PROCESS | 1665 | 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" 01:27:14 ERROR - PROCESS | 1665 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:27:15 INFO - TEST-INFO | 1665: exit 0 01:27:15 INFO - Browser initialized. 01:27:15 INFO - Running cycle 1/1 for dromaeo_css test... 01:27:15 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpUXrqAv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:27:27 INFO - PROCESS | 1669 | RSS: Main: 161837056 01:27:27 INFO - PROCESS | 1669 | 01:28:18 INFO - PROCESS | 1669 | 1467102498412 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] 01:30:28 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 01:30:29 INFO - PROCESS | 1669 | RSS: Main: 298070016 01:30:29 INFO - PROCESS | 1669 | 01:33:32 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 01:33:33 INFO - PROCESS | 1669 | RSS: Main: 288677888 01:33:33 INFO - PROCESS | 1669 | 01:36:35 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 01:36:36 INFO - PROCESS | 1669 | RSS: Main: 305254400 01:36:36 INFO - PROCESS | 1669 | 01:39:38 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 01:39:38 INFO - PROCESS | 1669 | RSS: Main: 300011520 01:39:38 INFO - PROCESS | 1669 | 01:42:41 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 01:42:42 INFO - PROCESS | 1669 | RSS: Main: 268152832 01:42:42 INFO - PROCESS | 1669 | 01:45:44 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 01:45:45 INFO - PROCESS | 1669 | RSS: Main: 312406016 01:45:45 INFO - PROCESS | 1669 | 01:45:45 INFO - PROCESS | 1669 | __start_tp_report 01:45:45 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 01:45:45 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 01:45:45 INFO - PROCESS | 1669 | |i|pagename|runs| 01:45:45 INFO - PROCESS | 1669 | |0;dojo.html;3029.3335466197436;3642.3079614873154;3642.836072376741;3645.598984111748;3716.461113138595;6011.849703757408;6032.396760323976;6037.0340745480735;6054.606450580714;6095.116208149816;5639.577031722617;5793.391693872146;6007.098935159728;6073.089036644495;6080.0575910733905;4690.929636055462;5324.094903866352;5378.784848606061;5472.98749731299;5540.002799496089;5354.063038968185;5520.723963801814;5531.944680553183;5541.944580554204;5554.19464177696;5441.455854414547;5495.780168793263;5502.697351645678;5505.752241149158;5525.834224973257;5511.58663100267;5521.420250873681;5539.833804985857;5545.500904918536;5547.972260138714;5341.973290133564;5377.838664840061;5439.918401223985;5449.073657478239;5488.807891723811;5767.365589785162;5824.854378640568;5859.35547089824;5881.441263080001;5900.822975310747;6290.056491526308;6313.968430157865;6320.778772742932;6321.936780632181;6324.272708638519;6034.758609655609;6233.719482623293;6340.841478963062;6382.968085159545;6384.361563843625;6023.096535519663;6121.755129794758;6125.632462052291;6140.0789881517685;6144.539159563006;6441.32366101562;6455.709493072823;6457.4511166551365;6461.676916154268;6468.708908099147;6167.136600875881;6244.37556244381;6320.62076275425;6337.176167098248;6337.746490140435;6313.621182729051;6337.809865704036;6344.270408902943;6350.523710721714;6361.427471527585;6228.532860035515;6244.344343843922;6305.684715764193;6307.873842523124;6313.968430157912;6264;6302.527310451735;6319.020551814476;6329.493640508748;6346.9682651586445;5019.6737212081825;5033.345665063518;5059.367579052619;5069;5069.619778516626;4537.2059889519205;4567.36056952027;4575.931361029588;4581.633469322446;4628.467726211529;5999.340072592011;6005.909911351333;6006.309274433496;6015.879682406327;6022.879542409128;6222.564420490522;6263.029230469285;6318.241810982711;6319.368063193736;6350.269718982284;5915.940840591625;6000.579959402888;6013;6050.183225264621;6067.453929146398;5580.637258578179;5593.888122237614;5604.32748070226;5609.775608975677;5610;6376.39424254695;6423.839404014937;6510.218773747086;6552.410283074546;6563.573367730986;5590.748416321194;6341.968290158519;6378.425941665272;6387.489000879826;6412.551121421456;6604.5046621502615;6625.4699624029;6628.270890201978;6635.834104147435;6645.368689974444;6203.2556093269095;6252.874942501034;6302.243730752339;6306.779262725782;6334.049892516159;6332.271788744353;6338.207724034496;6342.207224096988;6347.365263473615;6352.047192921099;6273.52948528853;6277.121203031488;6284.497240220863;6290;6290.308066112632;6171.84570385744;6200.844978875564;6205.22434695663;6229.501639868709;6278.277998030285;6026.337102918763;6266.060090986389;6276.340984196594;6276.74893004293;6283.403076707706;6226.097215903578;6247.812565623039;6268.905966410416;6278.246610406781;6296.5592408530965;6109.43503133753;6192.071189321638;6193.102000210034;6234.15838861766;6234.501239900887 01:45:45 INFO - PROCESS | 1669 | |1;ext.html;555.5638823523534;561.4189314059948;565.9963371439572;569.345252959097;601.9976738730014;33813.661863381356;34275.314493710175;34310.14224644382;34358.65641343589;34378.48432273518;30267.091987240365;35896;36343.09142271438;40969.59030409695;42060.57939420613;9863.802723945517;10126.696199114038;10157.28898977072;10159.034891685278;10169.135623472013;10034.096931276184;10129.189664826834;10133.645322413717;10161.644342448017;10176.440295783728;9314.487703176323;9535.666251681192;9536.28477864163;9545.043266130426;12013.699657508589;11846.348450835201;11992.280463172237;12021.459034343476;12023.759524809455;12042.879571204263;10488.842667359995;11621.489206403197;11815.527378904919;11935.343556104412;11967.880321196764;39523.60476395228;40015.59984400177;40051.99870003244;40117.59882401168;40263.39604905929;3359.5968483781858;3450.6894379505716;3598.5861625913094;3612.1692010837655;3908.7068469864876;27800.860995695093;28556.85721571379;28595.57106643402;28698.426031479252;28954.855225723735;2784.373515958893;2788.1496143676172;2790.316372488733;2852.957205641917;2867.5985362049328;479285;479662;481602.59198704135;481870;482028;36964.63035369612;37276.62723372786;37282.62717372792;37307.44038839419;37382;36061.91814245577;36294.27411451756;36463.63536364656;36465.453018204746;36528.63471365305;16193.757093643604;16364;16376.836231637531;16397.83602163987;16447.424340148038;14228.359723812453;14290;14316.28418579067;14479.565613031626;14502.969584258211;8406;8442.704505342406;8457.407981441364;8465.788355291166;8525.14748525155;3060.556219348182;3089.3203495231464;3500.4749287607065;3563.055790215595;3604.2070744436182;825.9463134896333;874.4010352908278;936.8594710793299;947.4362754161263;1021.2646894236138;30010.099697009126;30588.929387471333;30709.23226919345;31139.532907006414;31253.218669533442;931.6832277025844;1009.5709323537467;1142.6686260984222;1228.8095345221327;1243.6517775023008;10479.771970586064;14288.428462861577;15319;15386.44353121742;15682.215889205494;637100;638254;640017;644993;646290.7685461543;48600.7569962155;55869.441305587236;62875.74248515004;63455.730885382036;63552.36447635557;1526.221626970253;1561.289613226002;1572.6618776963007;1580.6917651058163;1582.0428640672458;28769.85615071911;29177.85411072931;29615.111546653636;30072.24819379533;30158.547621785252;47422.525774741815;47562;47971;48114.31599894127;48133.518664814306;435997;437409;441229;613046;662182;26312.8684356577;26944.86527567428;26998.785054672193;27061;27121.72878271192;37285.25429491449;47427;47713.52286477091;48326.79183020453;48701.7824554389;35131.824340878135;36476.45285320775;36691.81654091713;36691.81654091713;37171.62828371682;35810.462843057896;35981;35991;36485;36596.81701591475;35800.64199358077;36133;36275.63724362828;37072.629273706916;37112.443313350865;31462.370752585277;32319.35361292808;32481.875736453818;32506.01120759048;32743.017709468753;24146.87926560356;25176.874115629304;25395.746042539336;25518.362040949123;25679.844407002103 01:45:45 INFO - PROCESS | 1669 | |2;jquery.html;423.48546515983077;424.3782858112864;424.6581501890976;425.6148185891769;435.74944406966;20159;20690.96545172741;20942.581148377063;20981.16075356984;21414;16871.493855184333;20433.18267269311;20753.377398678025;22386.21648242312;22388.776112238913;5882.911756323648;5886.676232807194;6164.445199932005;6173.845653858667;6177.320494745574;5410.567154627621;5954.077118046688;6099.146119543268;6107.328193898667;6113.999999999978;4191.455110835587;4382.649388048949;4390.40729501518;5975.462208401243;6262.906056409135;6146.508279337642;6231.968840155793;6234.501239900797;6245.18812554365;6248.1564988726395;6124.540659450515;6171.9691401542705;6189.102580125857;6206.410391012847;6215.098810672427;13615.046946713734;13923.234222117779;14164.645883852883;14171.645708857259;14202.50291239812;2213.50196205854;2250.7411647660565;2272.329662749493;2453.7423570525193;2700.527407703664;9922.305438619227;9999.150072243869;10188.49057547127;10359.015893490181;10454.32046916948;1691.7716108325342;1783.0728021428913;1783.8662100342397;1829.4420201838434;1852.6665200263947;78139;89895;135823.32088339594;138184;149596.25201874028;19715.901420492806;20507.58984820295;21560.892195538923;21738.565228695337;22374.10503579871;36169.81915090408;36844.63155368466;37242.8137859309;37363.252734945694;37398.62601374006;11451.312921224753;11963.282203067844;11982.880171198176;11999.700007499709;12047;7739.1873853245725;8297.875531867026;9164.6792362267;10025.649102281384;10084.546195421224;8518.957405212934;9158;9596.328257021942;10361.274710770174;10451.111655509214;3593.2454184621;3958.3270843956598;3964.900877478086;4013.678905687538;4073.044938429511;948.4783369146942;992.8609994600762;1030.2067408095875;1041.193075366597;1078.1859695929522;20002.59994800125;21066.946652667306;21380.465488362915;21733.891330543564;21777.128914843546;846.784863720563;971.4656938683696;1023.7389465686351;1056.572088304238;1059.4014381874217;8917.866232006525;10706;10916.31358575495;11036.172287078341;11122.555097795997;654577;656835;658602;667032;675766;95379;107729.4613526943;118538.40730796463;135577.28845423035;139584;968.4286271099944;1062.2192688373884;1098.0392156862745;1098.961536346224;1099.373357186396;15263.694726105194;16632.83367166361;18003.18985645623;18599.628007440046;19380.8061919379;50270.4918852435;51528.96942061213;51933.740331298104;53146;53297.46702532925;76948;78636.60681696555;79067.20932790599;81293.59353203195;82644;8215.958920205361;8243.299319557906;8331.791705207419;8385.66457341724;8423.70517031901;10973.780524389307;11334.886651133384;11438.428078596204;12287.139900207258;12752.171108877894;9956.352837065568;9991.900080999389;10023.148032417326;11266.267692599955;11329;10307.536160872929;10564.84152737725;10884.292520986111;10905.182111341523;11139.27594706374;10863.511141998471;11274.718132046437;11347.546098156312;11633.185677002528;11730.178887477794;8202.917970820215;8316.584170791315;8424.83150337002;8445.87331190045;8591.355648326275;9585.320515695692;11076.944615276872;11228.88771112311;11329.546818127183;11423.029042531478 01:45:45 INFO - PROCESS | 1669 | |3;mootools.html;1498;1629.853313201812;1653.710600644887;1943.4364034430016;2035.338514982631;7499.662515186816;7519.360854327382;8194.672213111477;8671.39300248982;8843.602037908293;8476.91523084769;8777.122287771235;8781.165789250026;8790;8801.295896328294;2509.134348649713;2549.069589599792;2550.426154115328;2551.5024570208816;2551.7703406693395;2501.7998560115147;2577.6391305217285;2578.149210760454;2583.664123663921;2584.935376615581;2510.5230006298834;2525.8863351149153;2549;2549.7450254974538;2551.2728872271405;2532.4048848520492;2539.200151952138;2556.6931968163753;2573.884175212101;2574.871256437171;2565.815188082265;2583.625374320713;2587.2109006752935;2598.623199636042;2606.452644944564;8727.170918762708;8913.242374398184;8979.551022448852;8983.416077954977;8985.101489850962;5517.337919449692;5670.092785154397;5705.800296989627;5707;5714.342850572154;3613.8735144270086;3655.3785856404475;3707.721920855947;3710.7588006779474;3724.553053633554;1034.3690348887174;1044.1333693034762;1050.2648146297545;1052.5474046160148;1063.016709543669;11802.291862488279;12022.63932082039;12162.878371216262;12188.329641869694;12230.510779568807;4945.530174633404;4946.579540739078;5052.797888084436;5061.696298222045;5062.265971434122;10463.267571270091;10494.737631559272;10502.317349372419;10512.526936287886;10523.315984460985;5691.886162276731;5730.885382292331;5745.3105627324985;5749.396313387034;5754.424557544212;4576.359309696645;4748.240281555004;5020.874478138076;5055.317532133188;5168.948310516922;4120.855770048094;4124.390112076844;4195.160967806451;4200.390943313202;4202.390653355307;1380.061558140474;1410.6825964157983;1410.9647258818406;1424.8503907089607;1427.6145440731152;899.8515244984635;947.4410098042188;963.7638778499313;971.9076687714655;993.4536005197112;5848.181254624356;5930.080837470199;6084;6106;6123.601965872204;983.7343917142332;988.9258305627106;998.4109375468508;1040.552562398176;1053.647028245531;3313.5029745538363;3884.5921178275876;3945.1715139820385;3976.3041467743606;4012.6990475714438;10563.471826408802;10880.347179169275;10892.945535272273;10946.179036572288;11016.339019658846;10795.730106747395;10815.40515271652;10862.402567858686;10888.346699198073;10946.890531094747;8085.272325490734;8366.58167091643;8475.364347673825;8504.064552899175;8648.351373647001;5317.803494213771;5882.029465138205;5913.763449461973;5957.523398128226;5987.31145918225;9106.317026222927;9651.083147101013;9666.75833104178;9683.854742178732;9692.806143877224;9036.277097832026;9233.630654773733;9885.308028438229;10018.549165287433;10128.442935638315;5809.883802323845;6776.949572816221;6868.381845633917;7015.158181018311;7153.284671532805;8308.376871734523;8332.666693332441;8394.496330220207;8399.49603023796;8417.83164336722;6339.841503962438;7495.36289415384;7521.736739214101;7582.090149182133;7695.846083078195;7237.312455316736;7353.227911069261;7360.77917662471;7414.518056326321;7476.476646634684;6907.516473846783;6908.481863860331;6996.440284777307;6999.650017499206;7010.193827709879;4873.51264873524;4898.069366820293;4917.508249175054;4976.054549635558;5025.623078269071;4482.529334419839;4931.802727890988;4954.950450495449;5001.299818025552;5196.272521846869 01:45:45 INFO - PROCESS | 1669 | |4;prototype.html;291.77679075507234;295.1852886034545;332.08510553425316;334.5280764635603;348.219987228608;6764.425023872971;6788.9321106788975;6803.129139486644;6809.2169400519015;6871.072405225293;5431.972840135803;6761.2900645432255;6769.796906092813;6805.659717014154;6814.216365118013;4809.350737650408;4886.193778026622;4928.841722195281;4985.825496107637;5032.949670503303;4940;5005.1491246488185;5008.824691135811;5016.072026675059;5042.243663450475;4954.405471343443;4965.677230979993;4967.105920934248;4975.427825800025;4995.200767877141;4778.832740854088;4846.660733748639;4941.382327209099;4965.950340496585;4975.8258460953875;4262.147570485915;4266.296061149907;4270.996315865769;4279.743215407086;4282.229198744225;6399.712012959428;6402.103705481236;6457.257415397243;6476.093346931433;6490.188726409199;5947.494462970652;5952.791652292149;5956.463918247378;5974.074018527135;5974.312954010301;6946.756863509803;7188.496805223636;7212.098487689039;7216.170140433865;7219.169795473483;4819.566239038469;4828.95171048292;4839.758012099381;4847.503535679128;4848.563629273347;6157.7536898524;6824.703306371823;6860.451163906826;7534.246575342477;7608.467407281492;4139.8965025873995;4907.337509436252;4921.8523444296015;4923.655344125877;4923.926141107886;4990.700557966461;4993.350864387607;4996.1007018736245;5003.499650034967;5007.524285192901;5922.911156332572;5949;5952.607014001977;5955.255593050869;5963.135345374983;6805.353491418307;6964.408025317804;7268.418526517866;7278.163011253668;7286.781396558112;1398.7132637809225;1524.4054818620746;1557.5249548887698;1630.1930544380607;1670.9164541773107;999.7500624843789;1043.3009883378154;1046.2048842879315;1070.9518071686637;1072.7318170457386;6522.673866306665;6576.0793488911595;6589.374009469093;6635.966820165868;6640.933590664128;6103.542234332443;7320.9267907320245;7493.925060749323;7494.6627401767055;7566.432517561205;5768.913466298009;6546.7561163378805;6760.864782704417;6766.391024807791;6783.253842077367;3961.069148750099;4016.6786657067364;4019.598040195957;4023.195360927826;4023.7384570002855;6996.825079373057;7709.113451953097;7779.572123533147;7968.800779980431;8164.795880102926;7828.373730101578;7844.411669124838;7845.333146682482;7856.057273127147;7859.371250299962;7881.172476889844;7949.682012719427;7955.2840244378285;7955.2840244378285;7961.36309095271;7221.891671624825;7467.850642987001;7575.924240757742;7577.772666820004;7590.0891892970985;7225.4580906433275;7285.198628151005;7287;7299.598522081124;7399.001134846727;6425.293217746138;7928;7942.245486678757;7946.721864734706;7952.403569732409;3942.9408558872215;4307.698461107692;4617.676762626584;4768.713877167381;4776;7202.567845929261;7538.924610754042;7542.773716788505;7546.320831125225;7549.584772837547;6411.4870810336;6796.640671865745;7152.249013853679;7220.350168484862;7260.528065675925;5922.55580831448;7208.27917208275;7225.024621676217;7237.746678866214;7239.457040721862;7090;7096.787096387116;7097.325754053357;7119.572825630479;7127.536710113826;6945;7249.456290778107;7251.8187045324285;7268.236835132235;7270.709171633075;6845.247022827584;6903.723851045902;7034;7039.19049309336;7102.751403700846 01:45:45 INFO - PROCESS | 1669 | |5;yui.html;694.6214313199307;696.1156745360887;710.7938697777648;743.3569961982885;750.740994356947;15314.770278445818;15750.684986300266;15758.212089395527;15759;15788.526344209664;14266.643333916658;14361.066530675498;14436;14448.349824257908;14518.274086295696;773.9961300193492;783.4320117914523;785.579714852554;786.7049856303886;932.2402242172625;787.0044393841795;936.2416442681416;960.6829746183743;960.8558716192557;962.4995002598645;993.3493561717087;1004.8643433136506;1005.3515482513774;1007.2999265510473;1010.206987514801;820.2084987986561;1000.1148983149892;1003.9598416063349;1004.2367800471658;1015.223354134088;749.8162950077266;773.0761739721036;773.3349319585152;773.7794728502349;773.8220209351881;15402.3839046438;15477.922610386877;15487.303071361815;15489;15527.767083493756;12967.546135885199;13015.414306356237;13057.477700891954;13337;13464.798028029587;10026.64906728261;10058.245631577587;10266.332688375232;10286.588536458532;10398.480075996169;3544.8936531904083;3606.2246616977213;3650.3976843820737;3656.213914008501;3798.1454172811173;81836.59081704613;82560.58719706423;83300.58349708273;84124.57937710272;84427.15572844255;9529.857052144223;9659.98570150124;9795.265355098254;9862;9963.402195868272;21758.891205544187;21818.563628727337;21843.781562184176;21845.344639660834;21890.452738681342;7395.297446742551;7584.734534291273;7674.53952762836;7688.730894418781;7711.575863327571;4076.6534844537955;4096.9795151024055;4158.688098392633;4269.210196113729;4271.017665936852;3708.147126160998;3757.6993840492696;3763.9247215055548;3767.03940495172;3787.6401741834484;681.9659017049128;698.9021536984826;699.8495323505471;705.6048612776862;721.7365661533503;539.5279130760584;603.9969800150972;609.4941198804981;617.8292136401584;623.2044418201983;8787.497252033449;8809.988178195052;8906.198442140238;8965.327600429864;8974.775630609156;590.5128269177945;593.5637306579661;616.2697203813406;628.355935166458;630.1536498060634;3861.710371722132;3931;3995.9400608990886;4013.9197216055513;4149.419081328617;83039;85595.14404855996;86164.56917715496;86179;86209.56895215609;71593.28406715866;72103;72324.63837680883;72568;74869.62565187139;63789.681051594445;64189;64465.35534644687;64537.35462645407;65400.672996635665;7259.709611615476;7838.568878711726;7977.800554986172;8059.637316320897;8067.959660201662;45645.54354456413;46023.53976460193;46033.539664602926;46222;47032.52967470281;57786.71106644608;61723.691381542805;61800.38199618126;62420;63705.36294636994;10200.0819926207;10261.076503114755;10275.537600808131;10290.897091028994;10336.224783141144;10792.784144317227;10934.343939363664;11048.723781905517;11121.443927803739;11700.010998130509;9535.332526723063;9719.46542940145;9967.202623790225;10619.469026548797;10969.286996345212;10115.696529103845;10367.377957322586;10425.322354046963;10724.195685323475;10739.731506712395;10218.080372766486;10230.181585472996;10343.275970682282;10376.636817711646;10472.319299245524;9028.277737781093;9043.005269420228;9163.49600771964;9209.309301802257;9302;8974.86537701922;9033.457992520469;9067.818643627223;9078.591463384031;9082.863757043517 01:45:45 INFO - PROCESS | 1669 | __end_tp_report 01:45:45 INFO - PROCESS | 1669 | __start_cc_report 01:45:45 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1152 01:45:45 INFO - PROCESS | 1669 | __end_cc_report 01:45:45 INFO - PROCESS | 1669 | __startTimestamp1467103545171__endTimestamp 01:45:45 INFO - PROCESS | 1669 | 01:45:45 INFO - PROCESS | 1669 | ------- Summary: start ------- 01:45:45 INFO - PROCESS | 1669 | Number of tests: 6 01:45:45 INFO - PROCESS | 1669 | 01:45:45 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5928.21 Median:6193.10 stddev:628.74 (10.2%) stddev-sans-first:588.11 01:45:45 INFO - PROCESS | 1669 | Values: 3029.3 3642.3 3642.8 3645.6 3716.5 6011.8 6032.4 6037.0 6054.6 6095.1 5639.6 5793.4 6007.1 6073.1 6080.1 4690.9 5324.1 5378.8 5473.0 5540.0 5354.1 5520.7 5531.9 5541.9 5554.2 5441.5 5495.8 5502.7 5505.8 5525.8 5511.6 5521.4 5539.8 5545.5 5548.0 5342.0 5377.8 5439.9 5449.1 5488.8 5767.4 5824.9 5859.4 5881.4 5900.8 6290.1 6314.0 6320.8 6321.9 6324.3 6034.8 6233.7 6340.8 6383.0 6384.4 6023.1 6121.8 6125.6 6140.1 6144.5 6441.3 6455.7 6457.5 6461.7 6468.7 6167.1 6244.4 6320.6 6337.2 6337.7 6313.6 6337.8 6344.3 6350.5 6361.4 6228.5 6244.3 6305.7 6307.9 6314.0 6264.0 6302.5 6319.0 6329.5 6347.0 5019.7 5033.3 5059.4 5069.0 5069.6 4537.2 4567.4 4575.9 4581.6 4628.5 5999.3 6005.9 6006.3 6015.9 6022.9 6222.6 6263.0 6318.2 6319.4 6350.3 5915.9 6000.6 6013.0 6050.2 6067.5 5580.6 5593.9 5604.3 5609.8 5610.0 6376.4 6423.8 6510.2 6552.4 6563.6 5590.7 6342.0 6378.4 6387.5 6412.6 6604.5 6625.5 6628.3 6635.8 6645.4 6203.3 6252.9 6302.2 6306.8 6334.0 6332.3 6338.2 6342.2 6347.4 6352.0 6273.5 6277.1 6284.5 6290.0 6290.3 6171.8 6200.8 6205.2 6229.5 6278.3 6026.3 6266.1 6276.3 6276.7 6283.4 6226.1 6247.8 6268.9 6278.2 6296.6 6109.4 6192.1 6193.1 6234.2 6234.5 01:45:45 INFO - PROCESS | 1669 | 01:45:45 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:66142.08 Median:19316.15 stddev:148392.49 (768.2%) stddev-sans-first:148727.07 01:45:45 INFO - PROCESS | 1669 | Values: 555.6 561.4 566.0 569.3 602.0 33813.7 34275.3 34310.1 34358.7 34378.5 30267.1 35896.0 36343.1 40969.6 42060.6 9863.8 10126.7 10157.3 10159.0 10169.1 10034.1 10129.2 10133.6 10161.6 10176.4 9314.5 9535.7 9536.3 9545.0 12013.7 11846.3 11992.3 12021.5 12023.8 12042.9 10488.8 11621.5 11815.5 11935.3 11967.9 39523.6 40015.6 40052.0 40117.6 40263.4 3359.6 3450.7 3598.6 3612.2 3908.7 27800.9 28556.9 28595.6 28698.4 28954.9 2784.4 2788.1 2790.3 2853.0 2867.6 479285.0 479662.0 481602.6 481870.0 482028.0 36964.6 37276.6 37282.6 37307.4 37382.0 36061.9 36294.3 36463.6 36465.5 36528.6 16193.8 16364.0 16376.8 16397.8 16447.4 14228.4 14290.0 14316.3 14479.6 14503.0 8406.0 8442.7 8457.4 8465.8 8525.1 3060.6 3089.3 3500.5 3563.1 3604.2 825.9 874.4 936.9 947.4 1021.3 30010.1 30588.9 30709.2 31139.5 31253.2 931.7 1009.6 1142.7 1228.8 1243.7 10479.8 14288.4 15319.0 15386.4 15682.2 637100.0 638254.0 640017.0 644993.0 646290.8 48600.8 55869.4 62875.7 63455.7 63552.4 1526.2 1561.3 1572.7 1580.7 1582.0 28769.9 29177.9 29615.1 30072.2 30158.5 47422.5 47562.0 47971.0 48114.3 48133.5 435997.0 437409.0 441229.0 613046.0 662182.0 26312.9 26944.9 26998.8 27061.0 27121.7 37285.3 47427.0 47713.5 48326.8 48701.8 35131.8 36476.5 36691.8 36691.8 37171.6 35810.5 35981.0 35991.0 36485.0 36596.8 35800.6 36133.0 36275.6 37072.6 37112.4 31462.4 32319.4 32481.9 32506.0 32743.0 24146.9 25176.9 25395.7 25518.4 25679.8 01:45:45 INFO - PROCESS | 1669 | 01:45:45 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:37465.02 Median:12319.76 stddev:109857.80 (891.7%) stddev-sans-first:110130.77 01:45:45 INFO - PROCESS | 1669 | Values: 423.5 424.4 424.7 425.6 435.7 20159.0 20691.0 20942.6 20981.2 21414.0 16871.5 20433.2 20753.4 22386.2 22388.8 5882.9 5886.7 6164.4 6173.8 6177.3 5410.6 5954.1 6099.1 6107.3 6114.0 4191.5 4382.6 4390.4 5975.5 6262.9 6146.5 6232.0 6234.5 6245.2 6248.2 6124.5 6172.0 6189.1 6206.4 6215.1 13615.0 13923.2 14164.6 14171.6 14202.5 2213.5 2250.7 2272.3 2453.7 2700.5 9922.3 9999.2 10188.5 10359.0 10454.3 1691.8 1783.1 1783.9 1829.4 1852.7 78139.0 89895.0 135823.3 138184.0 149596.3 19715.9 20507.6 21560.9 21738.6 22374.1 36169.8 36844.6 37242.8 37363.3 37398.6 11451.3 11963.3 11982.9 11999.7 12047.0 7739.2 8297.9 9164.7 10025.6 10084.5 8519.0 9158.0 9596.3 10361.3 10451.1 3593.2 3958.3 3964.9 4013.7 4073.0 948.5 992.9 1030.2 1041.2 1078.2 20002.6 21066.9 21380.5 21733.9 21777.1 846.8 971.5 1023.7 1056.6 1059.4 8917.9 10706.0 10916.3 11036.2 11122.6 654577.0 656835.0 658602.0 667032.0 675766.0 95379.0 107729.5 118538.4 135577.3 139584.0 968.4 1062.2 1098.0 1099.0 1099.4 15263.7 16632.8 18003.2 18599.6 19380.8 50270.5 51529.0 51933.7 53146.0 53297.5 76948.0 78636.6 79067.2 81293.6 82644.0 8216.0 8243.3 8331.8 8385.7 8423.7 10973.8 11334.9 11438.4 12287.1 12752.2 9956.4 9991.9 10023.1 11266.3 11329.0 10307.5 10564.8 10884.3 10905.2 11139.3 10863.5 11274.7 11347.5 11633.2 11730.2 8202.9 8316.6 8424.8 8445.9 8591.4 9585.3 11076.9 11228.9 11329.5 11423.0 01:45:45 INFO - PROCESS | 1669 | 01:45:45 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:5781.54 Median:5011.09 stddev:3165.38 (63.2%) stddev-sans-first:3157.89 01:45:45 INFO - PROCESS | 1669 | Values: 1498.0 1629.9 1653.7 1943.4 2035.3 7499.7 7519.4 8194.7 8671.4 8843.6 8476.9 8777.1 8781.2 8790.0 8801.3 2509.1 2549.1 2550.4 2551.5 2551.8 2501.8 2577.6 2578.1 2583.7 2584.9 2510.5 2525.9 2549.0 2549.7 2551.3 2532.4 2539.2 2556.7 2573.9 2574.9 2565.8 2583.6 2587.2 2598.6 2606.5 8727.2 8913.2 8979.6 8983.4 8985.1 5517.3 5670.1 5705.8 5707.0 5714.3 3613.9 3655.4 3707.7 3710.8 3724.6 1034.4 1044.1 1050.3 1052.5 1063.0 11802.3 12022.6 12162.9 12188.3 12230.5 4945.5 4946.6 5052.8 5061.7 5062.3 10463.3 10494.7 10502.3 10512.5 10523.3 5691.9 5730.9 5745.3 5749.4 5754.4 4576.4 4748.2 5020.9 5055.3 5168.9 4120.9 4124.4 4195.2 4200.4 4202.4 1380.1 1410.7 1411.0 1424.9 1427.6 899.9 947.4 963.8 971.9 993.5 5848.2 5930.1 6084.0 6106.0 6123.6 983.7 988.9 998.4 1040.6 1053.6 3313.5 3884.6 3945.2 3976.3 4012.7 10563.5 10880.3 10892.9 10946.2 11016.3 10795.7 10815.4 10862.4 10888.3 10946.9 8085.3 8366.6 8475.4 8504.1 8648.4 5317.8 5882.0 5913.8 5957.5 5987.3 9106.3 9651.1 9666.8 9683.9 9692.8 9036.3 9233.6 9885.3 10018.5 10128.4 5809.9 6776.9 6868.4 7015.2 7153.3 8308.4 8332.7 8394.5 8399.5 8417.8 6339.8 7495.4 7521.7 7582.1 7695.8 7237.3 7353.2 7360.8 7414.5 7476.5 6907.5 6908.5 6996.4 6999.7 7010.2 4873.5 4898.1 4917.5 4976.1 5025.6 4482.5 4931.8 4955.0 5001.3 5196.3 01:45:45 INFO - PROCESS | 1669 | 01:45:45 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:5888.67 Median:6638.45 stddev:1884.19 (28.4%) stddev-sans-first:1842.05 01:45:45 INFO - PROCESS | 1669 | Values: 291.8 295.2 332.1 334.5 348.2 6764.4 6788.9 6803.1 6809.2 6871.1 5432.0 6761.3 6769.8 6805.7 6814.2 4809.4 4886.2 4928.8 4985.8 5032.9 4940.0 5005.1 5008.8 5016.1 5042.2 4954.4 4965.7 4967.1 4975.4 4995.2 4778.8 4846.7 4941.4 4966.0 4975.8 4262.1 4266.3 4271.0 4279.7 4282.2 6399.7 6402.1 6457.3 6476.1 6490.2 5947.5 5952.8 5956.5 5974.1 5974.3 6946.8 7188.5 7212.1 7216.2 7219.2 4819.6 4829.0 4839.8 4847.5 4848.6 6157.8 6824.7 6860.5 7534.2 7608.5 4139.9 4907.3 4921.9 4923.7 4923.9 4990.7 4993.4 4996.1 5003.5 5007.5 5922.9 5949.0 5952.6 5955.3 5963.1 6805.4 6964.4 7268.4 7278.2 7286.8 1398.7 1524.4 1557.5 1630.2 1670.9 999.8 1043.3 1046.2 1071.0 1072.7 6522.7 6576.1 6589.4 6636.0 6640.9 6103.5 7320.9 7493.9 7494.7 7566.4 5768.9 6546.8 6760.9 6766.4 6783.3 3961.1 4016.7 4019.6 4023.2 4023.7 6996.8 7709.1 7779.6 7968.8 8164.8 7828.4 7844.4 7845.3 7856.1 7859.4 7881.2 7949.7 7955.3 7955.3 7961.4 7221.9 7467.9 7575.9 7577.8 7590.1 7225.5 7285.2 7287.0 7299.6 7399.0 6425.3 7928.0 7942.2 7946.7 7952.4 3942.9 4307.7 4617.7 4768.7 4776.0 7202.6 7538.9 7542.8 7546.3 7549.6 6411.5 6796.6 7152.2 7220.4 7260.5 5922.6 7208.3 7225.0 7237.7 7239.5 7090.0 7096.8 7097.3 7119.6 7127.5 6945.0 7249.5 7251.8 7268.2 7270.7 6845.2 6903.7 7034.0 7039.2 7102.8 01:45:45 INFO - PROCESS | 1669 | 01:45:45 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:17545.40 Median:612.88 stddev:24239.24 (3955.0%) stddev-sans-first:24274.21 01:45:45 INFO - PROCESS | 1669 | Values: 694.6 696.1 710.8 743.4 750.7 15314.8 15750.7 15758.2 15759.0 15788.5 14266.6 14361.1 14436.0 14448.3 14518.3 774.0 783.4 785.6 786.7 932.2 787.0 936.2 960.7 960.9 962.5 993.3 1004.9 1005.4 1007.3 1010.2 820.2 1000.1 1004.0 1004.2 1015.2 749.8 773.1 773.3 773.8 773.8 15402.4 15477.9 15487.3 15489.0 15527.8 12967.5 13015.4 13057.5 13337.0 13464.8 10026.6 10058.2 10266.3 10286.6 10398.5 3544.9 3606.2 3650.4 3656.2 3798.1 81836.6 82560.6 83300.6 84124.6 84427.2 9529.9 9660.0 9795.3 9862.0 9963.4 21758.9 21818.6 21843.8 21845.3 21890.5 7395.3 7584.7 7674.5 7688.7 7711.6 4076.7 4097.0 4158.7 4269.2 4271.0 3708.1 3757.7 3763.9 3767.0 3787.6 682.0 698.9 699.8 705.6 721.7 539.5 604.0 609.5 617.8 623.2 8787.5 8810.0 8906.2 8965.3 8974.8 590.5 593.6 616.3 628.4 630.2 3861.7 3931.0 3995.9 4013.9 4149.4 83039.0 85595.1 86164.6 86179.0 86209.6 71593.3 72103.0 72324.6 72568.0 74869.6 63789.7 64189.0 64465.4 64537.4 65400.7 7259.7 7838.6 7977.8 8059.6 8068.0 45645.5 46023.5 46033.5 46222.0 47032.5 57786.7 61723.7 61800.4 62420.0 63705.4 10200.1 10261.1 10275.5 10290.9 10336.2 10792.8 10934.3 11048.7 11121.4 11700.0 9535.3 9719.5 9967.2 10619.5 10969.3 10115.7 10367.4 10425.3 10724.2 10739.7 10218.1 10230.2 10343.3 10376.6 10472.3 9028.3 9043.0 9163.5 9209.3 9302.0 8974.9 9033.5 9067.8 9078.6 9082.9 01:45:45 INFO - PROCESS | 1669 | -------- Summary: end -------- 01:45:45 INFO - PROCESS | 1669 | 01:45:45 INFO - TEST-INFO | 1669: exit 0 01:45:45 INFO - TEST-OK | dromaeo_css | took 1113498ms 01:45:45 INFO - TEST-START | kraken 01:45:45 INFO - operating with platform_type : mac_ 01:45:45 INFO - Initialising browser for kraken test... 01:45:45 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpkbjB5h/profile http://localhost:49277/getInfo.html) 01:45:47 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 01:45:47 INFO - PROCESS | 1680 | colorDepth:24 01:45:47 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 01:45:47 INFO - PROCESS | 1680 | __metrics 01:45:47 INFO - PROCESS | 1680 | 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" 01:45:47 ERROR - PROCESS | 1680 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:45:48 INFO - TEST-INFO | 1680: exit 0 01:45:48 INFO - Browser initialized. 01:45:48 INFO - Running cycle 1/1 for kraken test... 01:45:48 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpkbjB5h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:46:00 INFO - PROCESS | 1683 | RSS: Main: 161828864 01:46:00 INFO - PROCESS | 1683 | 01:46:02 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 01:46:03 INFO - PROCESS | 1683 | RSS: Main: 223846400 01:46:03 INFO - PROCESS | 1683 | 01:46:06 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 01:46:06 INFO - PROCESS | 1683 | RSS: Main: 239595520 01:46:06 INFO - PROCESS | 1683 | 01:46:10 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 01:46:10 INFO - PROCESS | 1683 | RSS: Main: 325627904 01:46:10 INFO - PROCESS | 1683 | 01:46:12 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 01:46:13 INFO - PROCESS | 1683 | RSS: Main: 230772736 01:46:13 INFO - PROCESS | 1683 | 01:46:15 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:46:16 INFO - PROCESS | 1683 | RSS: Main: 230973440 01:46:16 INFO - PROCESS | 1683 | 01:46:18 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 01:46:19 INFO - PROCESS | 1683 | RSS: Main: 270147584 01:46:19 INFO - PROCESS | 1683 | 01:46:22 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 01:46:22 INFO - PROCESS | 1683 | RSS: Main: 269963264 01:46:22 INFO - PROCESS | 1683 | 01:46:25 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 01:46:26 INFO - PROCESS | 1683 | RSS: Main: 269762560 01:46:26 INFO - PROCESS | 1683 | 01:46:28 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:46:28 INFO - PROCESS | 1683 | RSS: Main: 260546560 01:46:28 INFO - PROCESS | 1683 | 01:46:30 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:46:31 INFO - PROCESS | 1683 | RSS: Main: 268312576 01:46:31 INFO - PROCESS | 1683 | 01:46:33 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:46:33 INFO - PROCESS | 1683 | RSS: Main: 271343616 01:46:33 INFO - PROCESS | 1683 | 01:46:36 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:46:37 INFO - PROCESS | 1683 | RSS: Main: 278188032 01:46:37 INFO - PROCESS | 1683 | 01:46:39 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:46:40 INFO - PROCESS | 1683 | RSS: Main: 275480576 01:46:40 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 01:46:42 INFO - PROCESS | 1683 | RSS: Main: 336277504 01:46:42 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | __start_tp_report 01:46:42 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 01:46:42 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 01:46:42 INFO - PROCESS | 1683 | |i|pagename|runs| 01:46:42 INFO - PROCESS | 1683 | |0;ai-astar;115;113;119;113;112;113;113;111;114;133 01:46:42 INFO - PROCESS | 1683 | |1;audio-beat-detection;159;119;141;164;119;139;117;155;154;118 01:46:42 INFO - PROCESS | 1683 | |2;audio-dft;188;184;186;184;184;185;184;197;258;195 01:46:42 INFO - PROCESS | 1683 | |3;audio-fft;68;78;73;154;55;55;58;63;155;45 01:46:42 INFO - PROCESS | 1683 | |4;audio-oscillator;89;88;139;78;78;90;122;77;92;164 01:46:42 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;89;86;89;87;89;87;90;88;89;85 01:46:42 INFO - PROCESS | 1683 | |6;imaging-darkroom;93;94;94;94;94;95;95;94;93;94 01:46:42 INFO - PROCESS | 1683 | |7;imaging-desaturate;86;84;85;93;143;83;97;131;119;84 01:46:42 INFO - PROCESS | 1683 | |8;json-parse-financial;59;59;64;62;64;63;63;76;57;56 01:46:42 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;60;61;67;75;72;66;68;66;64;64 01:46:42 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;79;79;80;77;80;80;78;79;79;83 01:46:42 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;130;118;127;162;114;134;140;143;163;143 01:46:42 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;161;165;163;158;164;163;163;161;162;158 01:46:42 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;67;67;68;66;66;67;66;69;65;67 01:46:42 INFO - PROCESS | 1683 | __end_tp_report 01:46:42 INFO - PROCESS | 1683 | __start_cc_report 01:46:42 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1915 01:46:42 INFO - PROCESS | 1683 | __end_cc_report 01:46:42 INFO - PROCESS | 1683 | __startTimestamp1467103602506__endTimestamp 01:46:42 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | ------- Summary: start ------- 01:46:42 INFO - PROCESS | 1683 | Number of tests: 14 01:46:42 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:115.60 Median:113.50 stddev:6.48 (5.7%) stddev-sans-first:6.87 01:46:42 INFO - PROCESS | 1683 | Values: 115.0 113.0 119.0 113.0 112.0 113.0 113.0 111.0 114.0 133.0 01:46:42 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:147.50 stddev:18.95 (12.8%) stddev-sans-first:18.59 01:46:42 INFO - PROCESS | 1683 | Values: 159.0 119.0 141.0 164.0 119.0 139.0 117.0 155.0 154.0 118.0 01:46:42 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:194.50 Median:187.00 stddev:22.81 (12.2%) stddev-sans-first:24.08 01:46:42 INFO - PROCESS | 1683 | Values: 188.0 184.0 186.0 184.0 184.0 185.0 184.0 197.0 258.0 195.0 01:46:42 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:80.40 Median:60.50 stddev:40.20 (66.4%) stddev-sans-first:42.39 01:46:42 INFO - PROCESS | 1683 | Values: 68.0 78.0 73.0 154.0 55.0 55.0 58.0 63.0 155.0 45.0 01:46:42 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:83.00 stddev:29.81 (35.9%) stddev-sans-first:31.26 01:46:42 INFO - PROCESS | 1683 | Values: 89.0 88.0 139.0 78.0 78.0 90.0 122.0 77.0 92.0 164.0 01:46:42 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:89.00 stddev:1.60 (1.8%) stddev-sans-first:1.64 01:46:42 INFO - PROCESS | 1683 | Values: 89.0 86.0 89.0 87.0 89.0 87.0 90.0 88.0 89.0 85.0 01:46:42 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 01:46:42 INFO - PROCESS | 1683 | Values: 93.0 94.0 94.0 94.0 94.0 95.0 95.0 94.0 93.0 94.0 01:46:42 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:100.50 Median:84.50 stddev:22.23 (26.3%) stddev-sans-first:22.95 01:46:42 INFO - PROCESS | 1683 | Values: 86.0 84.0 85.0 93.0 143.0 83.0 97.0 131.0 119.0 84.0 01:46:42 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:63.00 stddev:5.62 (8.9%) stddev-sans-first:5.83 01:46:42 INFO - PROCESS | 1683 | Values: 59.0 59.0 64.0 62.0 64.0 63.0 63.0 76.0 57.0 56.0 01:46:42 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.50 stddev:4.60 (6.9%) stddev-sans-first:4.27 01:46:42 INFO - PROCESS | 1683 | Values: 60.0 61.0 67.0 75.0 72.0 66.0 68.0 66.0 64.0 64.0 01:46:42 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.50 stddev:1.58 (2.0%) stddev-sans-first:1.67 01:46:42 INFO - PROCESS | 1683 | Values: 79.0 79.0 80.0 77.0 80.0 80.0 78.0 79.0 79.0 83.0 01:46:42 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:141.50 stddev:16.43 (11.6%) stddev-sans-first:17.20 01:46:42 INFO - PROCESS | 1683 | Values: 130.0 118.0 127.0 162.0 114.0 134.0 140.0 143.0 163.0 143.0 01:46:42 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:163.00 stddev:2.35 (1.4%) stddev-sans-first:2.47 01:46:42 INFO - PROCESS | 1683 | Values: 161.0 165.0 163.0 158.0 164.0 163.0 163.0 161.0 162.0 158.0 01:46:42 INFO - PROCESS | 1683 | 01:46:42 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 01:46:42 INFO - PROCESS | 1683 | Values: 67.0 67.0 68.0 66.0 66.0 67.0 66.0 69.0 65.0 67.0 01:46:42 INFO - PROCESS | 1683 | -------- Summary: end -------- 01:46:42 INFO - PROCESS | 1683 | 01:46:43 INFO - TEST-INFO | 1683: exit 0 01:46:43 INFO - TEST-OK | kraken | took 57719ms 01:46:43 INFO - SUITE-END | took 1171s 01:46:43 INFO - Completed test suite (00:19:31) 01:46:43 INFO - javascript benchmark 01:46:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3029.3335466197436, 3642.3079614873154, 3642.836072376741, 3645.598984111748, 3716.461113138595, 6011.849703757408, 6032.396760323976, 6037.0340745480735, 6054.606450580714, 6095.116208149816, 5639.577031722617, 5793.391693872146, 6007.098935159728, 6073.089036644495, 6080.0575910733905, 4690.929636055462, 5324.094903866352, 5378.784848606061, 5472.98749731299, 5540.002799496089, 5354.063038968185, 5520.723963801814, 5531.944680553183, 5541.944580554204, 5554.19464177696, 5441.455854414547, 5495.780168793263, 5502.697351645678, 5505.752241149158, 5525.834224973257, 5511.58663100267, 5521.420250873681, 5539.833804985857, 5545.500904918536, 5547.972260138714, 5341.973290133564, 5377.838664840061, 5439.918401223985, 5449.073657478239, 5488.807891723811, 5767.365589785162, 5824.854378640568, 5859.35547089824, 5881.441263080001, 5900.822975310747, 6290.056491526308, 6313.968430157865, 6320.778772742932, 6321.936780632181, 6324.272708638519, 6034.758609655609, 6233.719482623293, 6340.841478963062, 6382.968085159545, 6384.361563843625, 6023.096535519663, 6121.755129794758, 6125.632462052291, 6140.0789881517685, 6144.539159563006, 6441.32366101562, 6455.709493072823, 6457.4511166551365, 6461.676916154268, 6468.708908099147, 6167.136600875881, 6244.37556244381, 6320.62076275425, 6337.176167098248, 6337.746490140435, 6313.621182729051, 6337.809865704036, 6344.270408902943, 6350.523710721714, 6361.427471527585, 6228.532860035515, 6244.344343843922, 6305.684715764193, 6307.873842523124, 6313.968430157912, 6264.0, 6302.527310451735, 6319.020551814476, 6329.493640508748, 6346.9682651586445, 5019.6737212081825, 5033.345665063518, 5059.367579052619, 5069.0, 5069.619778516626, 4537.2059889519205, 4567.36056952027, 4575.931361029588, 4581.633469322446, 4628.467726211529, 5999.340072592011, 6005.909911351333, 6006.309274433496, 6015.879682406327, 6022.879542409128, 6222.564420490522, 6263.029230469285, 6318.241810982711, 6319.368063193736, 6350.269718982284, 5915.940840591625, 6000.579959402888, 6013.0, 6050.183225264621, 6067.453929146398, 5580.637258578179, 5593.888122237614, 5604.32748070226, 5609.775608975677, 5610.0, 6376.39424254695, 6423.839404014937, 6510.218773747086, 6552.410283074546, 6563.573367730986, 5590.748416321194, 6341.968290158519, 6378.425941665272, 6387.489000879826, 6412.551121421456, 6604.5046621502615, 6625.4699624029, 6628.270890201978, 6635.834104147435, 6645.368689974444, 6203.2556093269095, 6252.874942501034, 6302.243730752339, 6306.779262725782, 6334.049892516159, 6332.271788744353, 6338.207724034496, 6342.207224096988, 6347.365263473615, 6352.047192921099, 6273.52948528853, 6277.121203031488, 6284.497240220863, 6290.0, 6290.308066112632, 6171.84570385744, 6200.844978875564, 6205.22434695663, 6229.501639868709, 6278.277998030285, 6026.337102918763, 6266.060090986389, 6276.340984196594, 6276.74893004293, 6283.403076707706, 6226.097215903578, 6247.812565623039, 6268.905966410416, 6278.246610406781, 6296.5592408530965, 6109.43503133753, 6192.071189321638, 6193.102000210034, 6234.15838861766, 6234.501239900887], "value": 5889.4813710857325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.5638823523534, 561.4189314059948, 565.9963371439572, 569.345252959097, 601.9976738730014, 33813.661863381356, 34275.314493710175, 34310.14224644382, 34358.65641343589, 34378.48432273518, 30267.091987240365, 35896.0, 36343.09142271438, 40969.59030409695, 42060.57939420613, 9863.802723945517, 10126.696199114038, 10157.28898977072, 10159.034891685278, 10169.135623472013, 10034.096931276184, 10129.189664826834, 10133.645322413717, 10161.644342448017, 10176.440295783728, 9314.487703176323, 9535.666251681192, 9536.28477864163, 9545.043266130426, 12013.699657508589, 11846.348450835201, 11992.280463172237, 12021.459034343476, 12023.759524809455, 12042.879571204263, 10488.842667359995, 11621.489206403197, 11815.527378904919, 11935.343556104412, 11967.880321196764, 39523.60476395228, 40015.59984400177, 40051.99870003244, 40117.59882401168, 40263.39604905929, 3359.5968483781858, 3450.6894379505716, 3598.5861625913094, 3612.1692010837655, 3908.7068469864876, 27800.860995695093, 28556.85721571379, 28595.57106643402, 28698.426031479252, 28954.855225723735, 2784.373515958893, 2788.1496143676172, 2790.316372488733, 2852.957205641917, 2867.5985362049328, 479285.0, 479662.0, 481602.59198704135, 481870.0, 482028.0, 36964.63035369612, 37276.62723372786, 37282.62717372792, 37307.44038839419, 37382.0, 36061.91814245577, 36294.27411451756, 36463.63536364656, 36465.453018204746, 36528.63471365305, 16193.757093643604, 16364.0, 16376.836231637531, 16397.83602163987, 16447.424340148038, 14228.359723812453, 14290.0, 14316.28418579067, 14479.565613031626, 14502.969584258211, 8406.0, 8442.704505342406, 8457.407981441364, 8465.788355291166, 8525.14748525155, 3060.556219348182, 3089.3203495231464, 3500.4749287607065, 3563.055790215595, 3604.2070744436182, 825.9463134896333, 874.4010352908278, 936.8594710793299, 947.4362754161263, 1021.2646894236138, 30010.099697009126, 30588.929387471333, 30709.23226919345, 31139.532907006414, 31253.218669533442, 931.6832277025844, 1009.5709323537467, 1142.6686260984222, 1228.8095345221327, 1243.6517775023008, 10479.771970586064, 14288.428462861577, 15319.0, 15386.44353121742, 15682.215889205494, 637100.0, 638254.0, 640017.0, 644993.0, 646290.7685461543, 48600.7569962155, 55869.441305587236, 62875.74248515004, 63455.730885382036, 63552.36447635557, 1526.221626970253, 1561.289613226002, 1572.6618776963007, 1580.6917651058163, 1582.0428640672458, 28769.85615071911, 29177.85411072931, 29615.111546653636, 30072.24819379533, 30158.547621785252, 47422.525774741815, 47562.0, 47971.0, 48114.31599894127, 48133.518664814306, 435997.0, 437409.0, 441229.0, 613046.0, 662182.0, 26312.8684356577, 26944.86527567428, 26998.785054672193, 27061.0, 27121.72878271192, 37285.25429491449, 47427.0, 47713.52286477091, 48326.79183020453, 48701.7824554389, 35131.824340878135, 36476.45285320775, 36691.81654091713, 36691.81654091713, 37171.62828371682, 35810.462843057896, 35981.0, 35991.0, 36485.0, 36596.81701591475, 35800.64199358077, 36133.0, 36275.63724362828, 37072.629273706916, 37112.443313350865, 31462.370752585277, 32319.35361292808, 32481.875736453818, 32506.01120759048, 32743.017709468753, 24146.87926560356, 25176.874115629304, 25395.746042539336, 25518.362040949123, 25679.844407002103], "value": 18578.62351117867, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.48546515983077, 424.3782858112864, 424.6581501890976, 425.6148185891769, 435.74944406966, 20159.0, 20690.96545172741, 20942.581148377063, 20981.16075356984, 21414.0, 16871.493855184333, 20433.18267269311, 20753.377398678025, 22386.21648242312, 22388.776112238913, 5882.911756323648, 5886.676232807194, 6164.445199932005, 6173.845653858667, 6177.320494745574, 5410.567154627621, 5954.077118046688, 6099.146119543268, 6107.328193898667, 6113.999999999978, 4191.455110835587, 4382.649388048949, 4390.40729501518, 5975.462208401243, 6262.906056409135, 6146.508279337642, 6231.968840155793, 6234.501239900797, 6245.18812554365, 6248.1564988726395, 6124.540659450515, 6171.9691401542705, 6189.102580125857, 6206.410391012847, 6215.098810672427, 13615.046946713734, 13923.234222117779, 14164.645883852883, 14171.645708857259, 14202.50291239812, 2213.50196205854, 2250.7411647660565, 2272.329662749493, 2453.7423570525193, 2700.527407703664, 9922.305438619227, 9999.150072243869, 10188.49057547127, 10359.015893490181, 10454.32046916948, 1691.7716108325342, 1783.0728021428913, 1783.8662100342397, 1829.4420201838434, 1852.6665200263947, 78139.0, 89895.0, 135823.32088339594, 138184.0, 149596.25201874028, 19715.901420492806, 20507.58984820295, 21560.892195538923, 21738.565228695337, 22374.10503579871, 36169.81915090408, 36844.63155368466, 37242.8137859309, 37363.252734945694, 37398.62601374006, 11451.312921224753, 11963.282203067844, 11982.880171198176, 11999.700007499709, 12047.0, 7739.1873853245725, 8297.875531867026, 9164.6792362267, 10025.649102281384, 10084.546195421224, 8518.957405212934, 9158.0, 9596.328257021942, 10361.274710770174, 10451.111655509214, 3593.2454184621, 3958.3270843956598, 3964.900877478086, 4013.678905687538, 4073.044938429511, 948.4783369146942, 992.8609994600762, 1030.2067408095875, 1041.193075366597, 1078.1859695929522, 20002.59994800125, 21066.946652667306, 21380.465488362915, 21733.891330543564, 21777.128914843546, 846.784863720563, 971.4656938683696, 1023.7389465686351, 1056.572088304238, 1059.4014381874217, 8917.866232006525, 10706.0, 10916.31358575495, 11036.172287078341, 11122.555097795997, 654577.0, 656835.0, 658602.0, 667032.0, 675766.0, 95379.0, 107729.4613526943, 118538.40730796463, 135577.28845423035, 139584.0, 968.4286271099944, 1062.2192688373884, 1098.0392156862745, 1098.961536346224, 1099.373357186396, 15263.694726105194, 16632.83367166361, 18003.18985645623, 18599.628007440046, 19380.8061919379, 50270.4918852435, 51528.96942061213, 51933.740331298104, 53146.0, 53297.46702532925, 76948.0, 78636.60681696555, 79067.20932790599, 81293.59353203195, 82644.0, 8215.958920205361, 8243.299319557906, 8331.791705207419, 8385.66457341724, 8423.70517031901, 10973.780524389307, 11334.886651133384, 11438.428078596204, 12287.139900207258, 12752.171108877894, 9956.352837065568, 9991.900080999389, 10023.148032417326, 11266.267692599955, 11329.0, 10307.536160872929, 10564.84152737725, 10884.292520986111, 10905.182111341523, 11139.27594706374, 10863.511141998471, 11274.718132046437, 11347.546098156312, 11633.185677002528, 11730.178887477794, 8202.917970820215, 8316.584170791315, 8424.83150337002, 8445.87331190045, 8591.355648326275, 9585.320515695692, 11076.944615276872, 11228.88771112311, 11329.546818127183, 11423.029042531478], "value": 10438.560144064542, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.0, 1629.853313201812, 1653.710600644887, 1943.4364034430016, 2035.338514982631, 7499.662515186816, 7519.360854327382, 8194.672213111477, 8671.39300248982, 8843.602037908293, 8476.91523084769, 8777.122287771235, 8781.165789250026, 8790.0, 8801.295896328294, 2509.134348649713, 2549.069589599792, 2550.426154115328, 2551.5024570208816, 2551.7703406693395, 2501.7998560115147, 2577.6391305217285, 2578.149210760454, 2583.664123663921, 2584.935376615581, 2510.5230006298834, 2525.8863351149153, 2549.0, 2549.7450254974538, 2551.2728872271405, 2532.4048848520492, 2539.200151952138, 2556.6931968163753, 2573.884175212101, 2574.871256437171, 2565.815188082265, 2583.625374320713, 2587.2109006752935, 2598.623199636042, 2606.452644944564, 8727.170918762708, 8913.242374398184, 8979.551022448852, 8983.416077954977, 8985.101489850962, 5517.337919449692, 5670.092785154397, 5705.800296989627, 5707.0, 5714.342850572154, 3613.8735144270086, 3655.3785856404475, 3707.721920855947, 3710.7588006779474, 3724.553053633554, 1034.3690348887174, 1044.1333693034762, 1050.2648146297545, 1052.5474046160148, 1063.016709543669, 11802.291862488279, 12022.63932082039, 12162.878371216262, 12188.329641869694, 12230.510779568807, 4945.530174633404, 4946.579540739078, 5052.797888084436, 5061.696298222045, 5062.265971434122, 10463.267571270091, 10494.737631559272, 10502.317349372419, 10512.526936287886, 10523.315984460985, 5691.886162276731, 5730.885382292331, 5745.3105627324985, 5749.396313387034, 5754.424557544212, 4576.359309696645, 4748.240281555004, 5020.874478138076, 5055.317532133188, 5168.948310516922, 4120.855770048094, 4124.390112076844, 4195.160967806451, 4200.390943313202, 4202.390653355307, 1380.061558140474, 1410.6825964157983, 1410.9647258818406, 1424.8503907089607, 1427.6145440731152, 899.8515244984635, 947.4410098042188, 963.7638778499313, 971.9076687714655, 993.4536005197112, 5848.181254624356, 5930.080837470199, 6084.0, 6106.0, 6123.601965872204, 983.7343917142332, 988.9258305627106, 998.4109375468508, 1040.552562398176, 1053.647028245531, 3313.5029745538363, 3884.5921178275876, 3945.1715139820385, 3976.3041467743606, 4012.6990475714438, 10563.471826408802, 10880.347179169275, 10892.945535272273, 10946.179036572288, 11016.339019658846, 10795.730106747395, 10815.40515271652, 10862.402567858686, 10888.346699198073, 10946.890531094747, 8085.272325490734, 8366.58167091643, 8475.364347673825, 8504.064552899175, 8648.351373647001, 5317.803494213771, 5882.029465138205, 5913.763449461973, 5957.523398128226, 5987.31145918225, 9106.317026222927, 9651.083147101013, 9666.75833104178, 9683.854742178732, 9692.806143877224, 9036.277097832026, 9233.630654773733, 9885.308028438229, 10018.549165287433, 10128.442935638315, 5809.883802323845, 6776.949572816221, 6868.381845633917, 7015.158181018311, 7153.284671532805, 8308.376871734523, 8332.666693332441, 8394.496330220207, 8399.49603023796, 8417.83164336722, 6339.841503962438, 7495.36289415384, 7521.736739214101, 7582.090149182133, 7695.846083078195, 7237.312455316736, 7353.227911069261, 7360.77917662471, 7414.518056326321, 7476.476646634684, 6907.516473846783, 6908.481863860331, 6996.440284777307, 6999.650017499206, 7010.193827709879, 4873.51264873524, 4898.069366820293, 4917.508249175054, 4976.054549635558, 5025.623078269071, 4482.529334419839, 4931.802727890988, 4954.950450495449, 5001.299818025552, 5196.272521846869], "value": 4711.511337757119, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.77679075507234, 295.1852886034545, 332.08510553425316, 334.5280764635603, 348.219987228608, 6764.425023872971, 6788.9321106788975, 6803.129139486644, 6809.2169400519015, 6871.072405225293, 5431.972840135803, 6761.2900645432255, 6769.796906092813, 6805.659717014154, 6814.216365118013, 4809.350737650408, 4886.193778026622, 4928.841722195281, 4985.825496107637, 5032.949670503303, 4940.0, 5005.1491246488185, 5008.824691135811, 5016.072026675059, 5042.243663450475, 4954.405471343443, 4965.677230979993, 4967.105920934248, 4975.427825800025, 4995.200767877141, 4778.832740854088, 4846.660733748639, 4941.382327209099, 4965.950340496585, 4975.8258460953875, 4262.147570485915, 4266.296061149907, 4270.996315865769, 4279.743215407086, 4282.229198744225, 6399.712012959428, 6402.103705481236, 6457.257415397243, 6476.093346931433, 6490.188726409199, 5947.494462970652, 5952.791652292149, 5956.463918247378, 5974.074018527135, 5974.312954010301, 6946.756863509803, 7188.496805223636, 7212.098487689039, 7216.170140433865, 7219.169795473483, 4819.566239038469, 4828.95171048292, 4839.758012099381, 4847.503535679128, 4848.563629273347, 6157.7536898524, 6824.703306371823, 6860.451163906826, 7534.246575342477, 7608.467407281492, 4139.8965025873995, 4907.337509436252, 4921.8523444296015, 4923.655344125877, 4923.926141107886, 4990.700557966461, 4993.350864387607, 4996.1007018736245, 5003.499650034967, 5007.524285192901, 5922.911156332572, 5949.0, 5952.607014001977, 5955.255593050869, 5963.135345374983, 6805.353491418307, 6964.408025317804, 7268.418526517866, 7278.163011253668, 7286.781396558112, 1398.7132637809225, 1524.4054818620746, 1557.5249548887698, 1630.1930544380607, 1670.9164541773107, 999.7500624843789, 1043.3009883378154, 1046.2048842879315, 1070.9518071686637, 1072.7318170457386, 6522.673866306665, 6576.0793488911595, 6589.374009469093, 6635.966820165868, 6640.933590664128, 6103.542234332443, 7320.9267907320245, 7493.925060749323, 7494.6627401767055, 7566.432517561205, 5768.913466298009, 6546.7561163378805, 6760.864782704417, 6766.391024807791, 6783.253842077367, 3961.069148750099, 4016.6786657067364, 4019.598040195957, 4023.195360927826, 4023.7384570002855, 6996.825079373057, 7709.113451953097, 7779.572123533147, 7968.800779980431, 8164.795880102926, 7828.373730101578, 7844.411669124838, 7845.333146682482, 7856.057273127147, 7859.371250299962, 7881.172476889844, 7949.682012719427, 7955.2840244378285, 7955.2840244378285, 7961.36309095271, 7221.891671624825, 7467.850642987001, 7575.924240757742, 7577.772666820004, 7590.0891892970985, 7225.4580906433275, 7285.198628151005, 7287.0, 7299.598522081124, 7399.001134846727, 6425.293217746138, 7928.0, 7942.245486678757, 7946.721864734706, 7952.403569732409, 3942.9408558872215, 4307.698461107692, 4617.676762626584, 4768.713877167381, 4776.0, 7202.567845929261, 7538.924610754042, 7542.773716788505, 7546.320831125225, 7549.584772837547, 6411.4870810336, 6796.640671865745, 7152.249013853679, 7220.350168484862, 7260.528065675925, 5922.55580831448, 7208.27917208275, 7225.024621676217, 7237.746678866214, 7239.457040721862, 7090.0, 7096.787096387116, 7097.325754053357, 7119.572825630479, 7127.536710113826, 6945.0, 7249.456290778107, 7251.8187045324285, 7268.236835132235, 7270.709171633075, 6845.247022827584, 6903.723851045902, 7034.0, 7039.19049309336, 7102.751403700846], "value": 5244.319617940696, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.6214313199307, 696.1156745360887, 710.7938697777648, 743.3569961982885, 750.740994356947, 15314.770278445818, 15750.684986300266, 15758.212089395527, 15759.0, 15788.526344209664, 14266.643333916658, 14361.066530675498, 14436.0, 14448.349824257908, 14518.274086295696, 773.9961300193492, 783.4320117914523, 785.579714852554, 786.7049856303886, 932.2402242172625, 787.0044393841795, 936.2416442681416, 960.6829746183743, 960.8558716192557, 962.4995002598645, 993.3493561717087, 1004.8643433136506, 1005.3515482513774, 1007.2999265510473, 1010.206987514801, 820.2084987986561, 1000.1148983149892, 1003.9598416063349, 1004.2367800471658, 1015.223354134088, 749.8162950077266, 773.0761739721036, 773.3349319585152, 773.7794728502349, 773.8220209351881, 15402.3839046438, 15477.922610386877, 15487.303071361815, 15489.0, 15527.767083493756, 12967.546135885199, 13015.414306356237, 13057.477700891954, 13337.0, 13464.798028029587, 10026.64906728261, 10058.245631577587, 10266.332688375232, 10286.588536458532, 10398.480075996169, 3544.8936531904083, 3606.2246616977213, 3650.3976843820737, 3656.213914008501, 3798.1454172811173, 81836.59081704613, 82560.58719706423, 83300.58349708273, 84124.57937710272, 84427.15572844255, 9529.857052144223, 9659.98570150124, 9795.265355098254, 9862.0, 9963.402195868272, 21758.891205544187, 21818.563628727337, 21843.781562184176, 21845.344639660834, 21890.452738681342, 7395.297446742551, 7584.734534291273, 7674.53952762836, 7688.730894418781, 7711.575863327571, 4076.6534844537955, 4096.9795151024055, 4158.688098392633, 4269.210196113729, 4271.017665936852, 3708.147126160998, 3757.6993840492696, 3763.9247215055548, 3767.03940495172, 3787.6401741834484, 681.9659017049128, 698.9021536984826, 699.8495323505471, 705.6048612776862, 721.7365661533503, 539.5279130760584, 603.9969800150972, 609.4941198804981, 617.8292136401584, 623.2044418201983, 8787.497252033449, 8809.988178195052, 8906.198442140238, 8965.327600429864, 8974.775630609156, 590.5128269177945, 593.5637306579661, 616.2697203813406, 628.355935166458, 630.1536498060634, 3861.710371722132, 3931.0, 3995.9400608990886, 4013.9197216055513, 4149.419081328617, 83039.0, 85595.14404855996, 86164.56917715496, 86179.0, 86209.56895215609, 71593.28406715866, 72103.0, 72324.63837680883, 72568.0, 74869.62565187139, 63789.681051594445, 64189.0, 64465.35534644687, 64537.35462645407, 65400.672996635665, 7259.709611615476, 7838.568878711726, 7977.800554986172, 8059.637316320897, 8067.959660201662, 45645.54354456413, 46023.53976460193, 46033.539664602926, 46222.0, 47032.52967470281, 57786.71106644608, 61723.691381542805, 61800.38199618126, 62420.0, 63705.36294636994, 10200.0819926207, 10261.076503114755, 10275.537600808131, 10290.897091028994, 10336.224783141144, 10792.784144317227, 10934.343939363664, 11048.723781905517, 11121.443927803739, 11700.010998130509, 9535.332526723063, 9719.46542940145, 9967.202623790225, 10619.469026548797, 10969.286996345212, 10115.696529103845, 10367.377957322586, 10425.322354046963, 10724.195685323475, 10739.731506712395, 10218.080372766486, 10230.181585472996, 10343.275970682282, 10376.636817711646, 10472.319299245524, 9028.277737781093, 9043.005269420228, 9163.49600771964, 9209.309301802257, 9302.0, 8974.86537701922, 9033.457992520469, 9067.818643627223, 9078.591463384031, 9082.863757043517], "value": 6854.858495993095, "unit": "score"}], "name": "dromaeo_css", "value": 7605.053067114533, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 119.0, 113.0, 112.0, 113.0, 113.0, 111.0, 114.0, 133.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 119.0, 141.0, 164.0, 119.0, 139.0, 117.0, 155.0, 154.0, 118.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 184.0, 186.0, 184.0, 184.0, 185.0, 184.0, 197.0, 258.0, 195.0], "value": 194.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 78.0, 73.0, 154.0, 55.0, 55.0, 58.0, 63.0, 155.0, 45.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 139.0, 78.0, 78.0, 90.0, 122.0, 77.0, 92.0, 164.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 89.0, 87.0, 90.0, 88.0, 89.0, 85.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 93.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 93.0, 143.0, 83.0, 97.0, 131.0, 119.0, 84.0], "value": 100.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 64.0, 62.0, 64.0, 63.0, 63.0, 76.0, 57.0, 56.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 67.0, 75.0, 72.0, 66.0, 68.0, 66.0, 64.0, 64.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 77.0, 80.0, 80.0, 78.0, 79.0, 79.0, 83.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 118.0, 127.0, 162.0, 114.0, 134.0, 140.0, 143.0, 163.0, 143.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 163.0, 158.0, 164.0, 163.0, 163.0, 161.0, 162.0, 158.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 66.0, 67.0, 66.0, 69.0, 65.0, 67.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1487.1000000000001, "alertThreshold": 2.0}]} 01:46:43 INFO - Return code: 0 01:46:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:46:43 ERROR - # TBPL SUCCESS # 01:46:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:46:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:46:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:46:43 INFO - 2016-06-28 01:46:43.804 screenresolution[1687:9788] starting screenresolution argv=screenresolution get 01:46:43 INFO - 2016-06-28 01:46:43.807 screenresolution[1687:9788] Display 0: 1600x1200x32@60 01:46:43 INFO - 2016-06-28 01:46:43.814 screenresolution[1688:9791] starting screenresolution argv=screenresolution list 01:46:43 INFO - Available Modes on Display 0 01:46:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:46:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:46:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:46:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:46:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:46:44 INFO - Intel Iris: 01:46:44 INFO - Chipset Model: Intel Iris 01:46:44 INFO - Type: GPU 01:46:44 INFO - Bus: Built-In 01:46:44 INFO - VRAM (Dynamic, Max): 1536 MB 01:46:44 INFO - Vendor: Intel (0x8086) 01:46:44 INFO - Device ID: 0x0a2e 01:46:44 INFO - Revision ID: 0x0009 01:46:44 INFO - Displays: 01:46:44 INFO - Display: 01:46:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:46:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:46:44 INFO - Display Serial Number: 1600x1200 60 01:46:44 INFO - Main Display: Yes 01:46:44 INFO - Mirror: Off 01:46:44 INFO - Online: Yes 01:46:44 INFO - Rotation: Supported 01:46:44 INFO - Return code: 0 01:46:44 INFO - Running post-action listener: _resource_record_post_action 01:46:44 INFO - Running post-run listener: _resource_record_post_run 01:46:45 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 37025280; Write bytes: 493801984; Read time: 242; Write time: 1552 01:46:45 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 189223424; Write bytes: 184721408; Read time: 17535; Write time: 418 01:46:45 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 35243520; Write bytes: 298291712; Read time: 227; Write time: 1098 01:46:45 INFO - Running post-run listener: _upload_blobber_files 01:46:45 INFO - Blob upload gear active. 01:46:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:46:45 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 01:46:45 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'] 01:46:45 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 01:46:45 INFO - (blobuploader) - INFO - Open directory for files ... 01:46:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:46:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:46:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:46 INFO - (blobuploader) - INFO - Done attempting. 01:46:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:46:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:46:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:47 INFO - (blobuploader) - INFO - Done attempting. 01:46:47 INFO - (blobuploader) - INFO - Iteration through files over. 01:46:47 INFO - Return code: 0 01:46:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:46:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:46:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ed209236ed548c183961448fbac9797f02513dcecff76e789ba8016d6796a0ec308ba3a58b4c39fa3d339698342292634e0e90a05290b157d8f226f6872385e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef4fe150c0044a4714712de9055a4daa407fbbd5441948e83f3282c73e14f340b9796150837f59e6102f3b65885495b5393b67a0b08db792ed4439d32f71e4d5"} 01:46:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:46:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:46:47 INFO - Contents: 01:46:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ed209236ed548c183961448fbac9797f02513dcecff76e789ba8016d6796a0ec308ba3a58b4c39fa3d339698342292634e0e90a05290b157d8f226f6872385e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef4fe150c0044a4714712de9055a4daa407fbbd5441948e83f3282c73e14f340b9796150837f59e6102f3b65885495b5393b67a0b08db792ed4439d32f71e4d5"} 01:46:47 INFO - Running post-run listener: copy_logs_to_upload_dir 01:46:47 INFO - Copying logs to upload dir... 01:46:47 INFO - mkdir: /builds/slave/test/build/upload/logs 01:46:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.512615 ========= master_lag: 266.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 16 secs) (at 2016-06-28 01:51:13.880090) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-06-28 01:51:13.884760) ========= 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.iBtIbYAGs9/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.GXDzlouhsd/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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/ed209236ed548c183961448fbac9797f02513dcecff76e789ba8016d6796a0ec308ba3a58b4c39fa3d339698342292634e0e90a05290b157d8f226f6872385e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef4fe150c0044a4714712de9055a4daa407fbbd5441948e83f3282c73e14f340b9796150837f59e6102f3b65885495b5393b67a0b08db792ed4439d32f71e4d5"} build_url:https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011546 build_url: 'https://queue.taskcluster.net/v1/task/FO6Gl0R-S5eBjr032mt9RA/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/ed209236ed548c183961448fbac9797f02513dcecff76e789ba8016d6796a0ec308ba3a58b4c39fa3d339698342292634e0e90a05290b157d8f226f6872385e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef4fe150c0044a4714712de9055a4daa407fbbd5441948e83f3282c73e14f340b9796150837f59e6102f3b65885495b5393b67a0b08db792ed4439d32f71e4d5"}' ========= master_lag: 3.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-06-28 01:51:16.951697) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:16.952011) ========= 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.iBtIbYAGs9/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.GXDzlouhsd/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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.005168 ========= master_lag: 0.80 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:17.757229) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-06-28 01:51:17.757534) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-06-28 01:51:20.221603) ========= ========= Total master_lag: 270.09 =========