builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0036 starttime: 1467321272.11 results: success (0) buildid: 20160630115927 builduid: 8f95a183e1694b9ab8d7f9f5101de05a revision: bcb69c8427d315b1d9c993493b2baf639761dd86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:32.107223) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:32.107633) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:32.107937) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:32.132554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:32.132904) ========= 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.ssFRsknrJk/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.peGEah51PS/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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-30 14:14:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 181M=0s 2016-06-30 14:14:32 (181 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164802 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:32.320642) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:32.321048) ========= 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.ssFRsknrJk/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.peGEah51PS/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.027135 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:32.369833) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:32.370223) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bcb69c8427d315b1d9c993493b2baf639761dd86 --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 bcb69c8427d315b1d9c993493b2baf639761dd86 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ssFRsknrJk/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.peGEah51PS/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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-30 14:14:32,443 truncating revision to first 12 chars 2016-06-30 14:14:32,443 Setting DEBUG logging. 2016-06-30 14:14:32,443 attempt 1/10 2016-06-30 14:14:32,443 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bcb69c8427d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 14:14:33,136 unpacking tar archive at: mozilla-beta-bcb69c8427d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.951397 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:33.342546) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:33.343920) ========= script_repo_revision: bcb69c8427d315b1d9c993493b2baf639761dd86 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:33.344296) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:33.344559) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:33.363106) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-30 14:14:33.363423) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ssFRsknrJk/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.peGEah51PS/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 14:14:33 INFO - MultiFileLogger online at 20160630 14:14:33 in /builds/slave/test 14:14:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:14:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:14:33 INFO - {'append_to_log': False, 14:14:33 INFO - 'base_work_dir': '/builds/slave/test', 14:14:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:14:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:14:33 INFO - 'branch': 'Mozilla-Beta', 14:14:33 INFO - 'buildbot_json_path': 'buildprops.json', 14:14:33 INFO - 'config_files': ('talos/mac_config.py',), 14:14:33 INFO - 'default_actions': ('clobber', 14:14:33 INFO - 'read-buildbot-config', 14:14:33 INFO - 'download-and-extract', 14:14:33 INFO - 'populate-webroot', 14:14:33 INFO - 'create-virtualenv', 14:14:33 INFO - 'install', 14:14:33 INFO - 'run-tests'), 14:14:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:14:33 INFO - 'download_minidump_stackwalk': True, 14:14:33 INFO - 'download_symbols': 'ondemand', 14:14:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:14:33 INFO - 'tooltool.py': '/tools/tooltool.py', 14:14:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:14:33 INFO - '/tools/misc-python/virtualenv.py')}, 14:14:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:14:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:14:33 INFO - 'installer_path': 'installer.exe', 14:14:33 INFO - 'log_level': 'info', 14:14:33 INFO - 'log_name': 'talos', 14:14:33 INFO - 'log_to_console': True, 14:14:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:14:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:14:33 INFO - 'opt_config_files': (), 14:14:33 INFO - 'pip_index': False, 14:14:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:14:33 INFO - 'cmd': ('bash', 14:14:33 INFO - '-c', 14:14:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:14:33 INFO - 'enabled': True, 14:14:33 INFO - 'halt_on_failure': False, 14:14:33 INFO - 'name': 'check_screen_resolution'},), 14:14:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:14:33 INFO - 'cmd': ('bash', 14:14:33 INFO - '-c', 14:14:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:14:33 INFO - 'enabled': True, 14:14:33 INFO - 'halt_on_failure': False, 14:14:33 INFO - 'name': 'check_screen_resolution'},), 14:14:33 INFO - 'run_cmd_checks_enabled': True, 14:14:33 INFO - 'sps_profile': False, 14:14:33 INFO - 'sps_profile_interval': 0, 14:14:33 INFO - 'suite': 'dromaeojs-e10s', 14:14:33 INFO - 'system_bits': '32', 14:14:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:14:33 INFO - 'title': 't-yosemite-r7-0036', 14:14:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:14:33 INFO - 'use_talos_json': True, 14:14:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:14:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:14:33 INFO - 'work_dir': 'build'} 14:14:33 INFO - ##### 14:14:33 INFO - ##### Running clobber step. 14:14:33 INFO - ##### 14:14:33 INFO - Running pre-action listener: _resource_record_pre_action 14:14:33 INFO - Running main action method: clobber 14:14:33 INFO - rmtree: /builds/slave/test/build 14:14:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:14:34 INFO - Running post-action listener: _resource_record_post_action 14:14:34 INFO - ##### 14:14:34 INFO - ##### Running read-buildbot-config step. 14:14:34 INFO - ##### 14:14:34 INFO - Running pre-action listener: _resource_record_pre_action 14:14:34 INFO - Running main action method: read_buildbot_config 14:14:34 INFO - Using buildbot properties: 14:14:34 INFO - { 14:14:34 INFO - "project": "", 14:14:34 INFO - "product": "firefox", 14:14:34 INFO - "script_repo_revision": "production", 14:14:34 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:14:34 INFO - "repository": "", 14:14:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:14:34 INFO - "buildid": "20160630115927", 14:14:34 INFO - "pgo_build": "False", 14:14:34 INFO - "basedir": "/builds/slave/test", 14:14:34 INFO - "buildnumber": 10, 14:14:34 INFO - "slavename": "t-yosemite-r7-0036", 14:14:34 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 14:14:34 INFO - "platform": "yosemite_r7", 14:14:34 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:14:34 INFO - "branch": "mozilla-beta", 14:14:34 INFO - "repo_path": "releases/mozilla-beta", 14:14:34 INFO - "revision": "bcb69c8427d315b1d9c993493b2baf639761dd86", 14:14:34 INFO - "stage_platform": "macosx64", 14:14:34 INFO - "builduid": "8f95a183e1694b9ab8d7f9f5101de05a", 14:14:34 INFO - "slavebuilddir": "test" 14:14:34 INFO - } 14:14:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 14:14:34 INFO - Running post-action listener: _resource_record_post_action 14:14:34 INFO - ##### 14:14:34 INFO - ##### Running download-and-extract step. 14:14:34 INFO - ##### 14:14:34 INFO - Running pre-action listener: _resource_record_pre_action 14:14:34 INFO - Running main action method: download_and_extract 14:14:34 INFO - mkdir: /builds/slave/test/build/tests 14:14: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')]} 14:14:34 INFO - https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:14:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 14:14:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 14:14:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/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 14:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/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 14:14:36 INFO - Downloaded 1165 bytes. 14:14:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 14:14:36 INFO - Using the following test package requirements: 14:14:36 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 14:14:36 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:14:36 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 14:14:36 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:14:36 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 14:14:36 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:14:36 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:14:36 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 14:14:36 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 14:14:36 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:14:36 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 14:14:36 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:14:36 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 14:14:36 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:14:36 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 14:14:36 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:14:36 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 14:14:36 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 14:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:36 INFO - https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:14:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:14:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:14:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/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 14:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/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 14:14:37 INFO - Downloaded 18350407 bytes. 14:14:37 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'] 14:14:37 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 14:14:40 INFO - Return code: 0 14:14:40 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 14:14: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')]} 14:14:40 INFO - https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:14:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:14:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:14:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/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 14:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/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 14:14:41 INFO - Downloaded 18350407 bytes. 14:14:41 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'] 14:14:41 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 14:14:45 INFO - Return code: 0 14:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:45 INFO - https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:14:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 14:14:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 14:14:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/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 14:14:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/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 14:14:46 INFO - Downloaded 10840145 bytes. 14:14:46 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'] 14:14:46 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 14:14:46 INFO - Return code: 0 14:14:46 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')]} 14:14:46 INFO - https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 14:14:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:14:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:14:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 14:14:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/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 14:14:49 INFO - Downloaded 86202402 bytes. 14:14:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:14:49 INFO - mkdir: /builds/slave/test/properties 14:14:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:14:49 INFO - Writing to file /builds/slave/test/properties/build_url 14:14:49 INFO - Contents: 14:14:49 INFO - build_url:https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:14:50 INFO - Running post-action listener: _resource_record_post_action 14:14:50 INFO - Running post-action listener: set_extra_try_arguments 14:14:50 INFO - ##### 14:14:50 INFO - ##### Running populate-webroot step. 14:14:50 INFO - ##### 14:14:50 INFO - Running pre-action listener: _resource_record_pre_action 14:14:50 INFO - Running main action method: populate_webroot 14:14:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:14:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:14:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:14:50 INFO - '--tppagecycles', 14:14:50 INFO - '7'], 14:14:50 INFO - 'tests': ['tsvgm']}}, 14:14:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:14:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:14:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:14:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:14:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:14:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:14:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:50 INFO - 'talos_options': ['--disable-e10s'], 14:14:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:14:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:14:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:50 INFO - 'talos_options': ['--disable-e10s'], 14:14:50 INFO - 'tests': ['damp', 'tps']}, 14:14:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:50 INFO - 'tests': ['damp', 'tps']}, 14:14:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:14:50 INFO - 'tests': ['dromaeo_dom']}, 14:14:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:14:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:14:50 INFO - 'tests': ['a11yr', 14:14:50 INFO - 'ts_paint', 14:14:50 INFO - 'tpaint', 14:14:50 INFO - 'sessionrestore', 14:14:50 INFO - 'sessionrestore_no_auto_restore', 14:14:50 INFO - 'tabpaint']}, 14:14:50 INFO - 'other-e10s': {'tests': ['a11yr', 14:14:50 INFO - 'ts_paint', 14:14:50 INFO - 'tpaint', 14:14:50 INFO - 'sessionrestore', 14:14:50 INFO - 'sessionrestore_no_auto_restore', 14:14:50 INFO - 'tabpaint']}, 14:14:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:14:50 INFO - 'ts_paint', 14:14:50 INFO - 'tpaint', 14:14:50 INFO - 'sessionrestore', 14:14:50 INFO - 'sessionrestore_no_auto_restore', 14:14:50 INFO - 'tabpaint']}, 14:14:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:14:50 INFO - 'ts_paint', 14:14:50 INFO - 'tpaint', 14:14:50 INFO - 'sessionrestore', 14:14:50 INFO - 'sessionrestore_no_auto_restore', 14:14:50 INFO - 'tabpaint']}, 14:14:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:14:50 INFO - 'tests': ['a11yr', 14:14:50 INFO - 'ts_paint', 14:14:50 INFO - 'tpaint', 14:14:50 INFO - 'sessionrestore', 14:14:50 INFO - 'sessionrestore_no_auto_restore', 14:14:50 INFO - 'tabpaint']}, 14:14:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:14:50 INFO - 'tests': ['a11yr', 14:14:50 INFO - 'ts_paint', 14:14:50 INFO - 'tpaint', 14:14:50 INFO - 'sessionrestore', 14:14:50 INFO - 'sessionrestore_no_auto_restore', 14:14:50 INFO - 'tabpaint']}, 14:14:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:14:50 INFO - 'tests': ['tsvgx', 14:14:50 INFO - 'tsvgr_opacity', 14:14:50 INFO - 'tart', 14:14:50 INFO - 'tscrollx', 14:14:50 INFO - 'cart']}, 14:14:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:14:50 INFO - 'tsvgr_opacity', 14:14:50 INFO - 'tart', 14:14:50 INFO - 'tscrollx', 14:14:50 INFO - 'cart']}, 14:14:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:50 INFO - 'talos_options': ['--disable-e10s'], 14:14:50 INFO - 'tests': ['tp5o']}, 14:14:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:50 INFO - 'tests': ['tp5o']}, 14:14:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:50 INFO - 'talos_options': ['--disable-e10s', 14:14:50 INFO - '--xperf_path', 14:14:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:14:50 INFO - 'tests': ['tp5n']}, 14:14:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:50 INFO - 'talos_options': ['--xperf_path', 14:14:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:14:50 INFO - 'tests': ['tp5n']}}, 14:14:50 INFO - 'talos.zip': {'path': '', 14:14:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:14:50 INFO - Running post-action listener: _resource_record_post_action 14:14:50 INFO - ##### 14:14:50 INFO - ##### Running create-virtualenv step. 14:14:50 INFO - ##### 14:14:50 INFO - Running pre-action listener: _resource_record_pre_action 14:14:50 INFO - Running main action method: create_virtualenv 14:14:50 INFO - Creating virtualenv /builds/slave/test/build/venv 14:14:50 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 14:14:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:14:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:14:50 INFO - Using real prefix '/tools/python27' 14:14:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:14:51 INFO - Installing distribute.............................................................................................................................................................................................done. 14:14:53 INFO - Installing pip.................done. 14:14:53 INFO - Return code: 0 14:14:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:14:53 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')]} 14:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:53 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')]} 14:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:53 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 0x10735ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1434920e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071fbe00>, '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 0x107064db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071f6b20>, '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.ssFRsknrJk/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.peGEah51PS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 14:14:53 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 14:14:53 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 14:14:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssFRsknrJk/Render', 14:14:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:53 INFO - 'HOME': '/Users/cltbld', 14:14:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:53 INFO - 'LOGNAME': 'cltbld', 14:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:53 INFO - 'MOZ_NO_REMOTE': '1', 14:14:53 INFO - 'NO_EM_RESTART': '1', 14:14:53 INFO - 'PAGER': '/bin/cat', 14:14:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:53 INFO - 'PWD': '/builds/slave/test', 14:14:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:53 INFO - 'SHELL': '/bin/bash', 14:14:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.peGEah51PS/Listeners', 14:14:53 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 14:14:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:53 INFO - 'USER': 'cltbld', 14:14:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:53 INFO - 'XPC_FLAGS': '0x0', 14:14:53 INFO - 'XPC_SERVICE_NAME': '0', 14:14:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:54 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 14:14:54 INFO - Cleaning up... 14:14:54 INFO - Return code: 0 14:14:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10735ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1434920e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071fbe00>, '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 0x107064db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071f6b20>, '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.ssFRsknrJk/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.peGEah51PS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 14:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:14:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssFRsknrJk/Render', 14:14:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:54 INFO - 'HOME': '/Users/cltbld', 14:14:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:54 INFO - 'LOGNAME': 'cltbld', 14:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:54 INFO - 'MOZ_NO_REMOTE': '1', 14:14:54 INFO - 'NO_EM_RESTART': '1', 14:14:54 INFO - 'PAGER': '/bin/cat', 14:14:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:54 INFO - 'PWD': '/builds/slave/test', 14:14:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:54 INFO - 'SHELL': '/bin/bash', 14:14:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.peGEah51PS/Listeners', 14:14:54 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 14:14:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:54 INFO - 'USER': 'cltbld', 14:14:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:54 INFO - 'XPC_FLAGS': '0x0', 14:14:54 INFO - 'XPC_SERVICE_NAME': '0', 14:14:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:54 INFO - Downloading/unpacking psutil>=0.7.1 14:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:14:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:14:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:14:57 INFO - Installing collected packages: psutil 14:14:57 INFO - Running setup.py install for psutil 14:14:57 INFO - building 'psutil._psutil_osx' extension 14:14:57 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 14:14:57 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 14:14:57 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 14:14:57 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 14:14:57 INFO - building 'psutil._psutil_posix' extension 14:14:57 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 14:14:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:14:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:14:58 INFO - ^ 14:14:58 INFO - 1 warning generated. 14:14:58 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 14:14:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:14:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:14:58 INFO - Successfully installed psutil 14:14:58 INFO - Cleaning up... 14:14:58 INFO - Return code: 0 14:14:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:14:58 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')]} 14:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:58 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')]} 14:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:58 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 0x10735ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1434920e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071fbe00>, '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 0x107064db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071f6b20>, '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.ssFRsknrJk/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.peGEah51PS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 14:14:58 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 14:14:58 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 14:14:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssFRsknrJk/Render', 14:14:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:58 INFO - 'HOME': '/Users/cltbld', 14:14:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:58 INFO - 'LOGNAME': 'cltbld', 14:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:58 INFO - 'MOZ_NO_REMOTE': '1', 14:14:58 INFO - 'NO_EM_RESTART': '1', 14:14:58 INFO - 'PAGER': '/bin/cat', 14:14:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:58 INFO - 'PWD': '/builds/slave/test', 14:14:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:58 INFO - 'SHELL': '/bin/bash', 14:14:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.peGEah51PS/Listeners', 14:14:58 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 14:14:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:58 INFO - 'USER': 'cltbld', 14:14:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:58 INFO - 'XPC_FLAGS': '0x0', 14:14:58 INFO - 'XPC_SERVICE_NAME': '0', 14:14:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:15:02 INFO - Installing collected packages: mozsystemmonitor 14:15:02 INFO - Running setup.py install for mozsystemmonitor 14:15:02 INFO - Successfully installed mozsystemmonitor 14:15:02 INFO - Cleaning up... 14:15:02 INFO - Return code: 0 14:15:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:15:02 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')]} 14:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:02 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')]} 14:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:02 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 0x10735ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1434920e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071fbe00>, '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 0x107064db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071f6b20>, '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.ssFRsknrJk/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.peGEah51PS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 14:15:02 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 14:15:02 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 14:15:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssFRsknrJk/Render', 14:15:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:02 INFO - 'HOME': '/Users/cltbld', 14:15:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:02 INFO - 'LOGNAME': 'cltbld', 14:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:02 INFO - 'MOZ_NO_REMOTE': '1', 14:15:02 INFO - 'NO_EM_RESTART': '1', 14:15:02 INFO - 'PAGER': '/bin/cat', 14:15:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:02 INFO - 'PWD': '/builds/slave/test', 14:15:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:02 INFO - 'SHELL': '/bin/bash', 14:15:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.peGEah51PS/Listeners', 14:15:02 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 14:15:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:02 INFO - 'USER': 'cltbld', 14:15:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:02 INFO - 'XPC_FLAGS': '0x0', 14:15:02 INFO - 'XPC_SERVICE_NAME': '0', 14:15:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:02 INFO - Downloading/unpacking blobuploader==1.2.4 14:15:02 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 14:15:02 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 14:15:02 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 14:15:02 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 14:15:02 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 14:15:02 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 14:15:05 INFO - Downloading blobuploader-1.2.4.tar.gz 14:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:15:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:15:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:06 INFO - Downloading docopt-0.6.1.tar.gz 14:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:15:06 INFO - Installing collected packages: blobuploader, requests, docopt 14:15:06 INFO - Running setup.py install for blobuploader 14:15:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:15:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:15:06 INFO - Running setup.py install for requests 14:15:07 INFO - Running setup.py install for docopt 14:15:07 INFO - Successfully installed blobuploader requests docopt 14:15:07 INFO - Cleaning up... 14:15:07 INFO - Return code: 0 14:15:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:07 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')]} 14:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:07 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')]} 14:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:07 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 0x10735ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1434920e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071fbe00>, '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 0x107064db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071f6b20>, '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.ssFRsknrJk/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.peGEah51PS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 14:15:07 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 14:15:07 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 14:15:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssFRsknrJk/Render', 14:15:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:07 INFO - 'HOME': '/Users/cltbld', 14:15:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:07 INFO - 'LOGNAME': 'cltbld', 14:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:07 INFO - 'MOZ_NO_REMOTE': '1', 14:15:07 INFO - 'NO_EM_RESTART': '1', 14:15:07 INFO - 'PAGER': '/bin/cat', 14:15:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:07 INFO - 'PWD': '/builds/slave/test', 14:15:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:07 INFO - 'SHELL': '/bin/bash', 14:15:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.peGEah51PS/Listeners', 14:15:07 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 14:15:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:07 INFO - 'USER': 'cltbld', 14:15:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:07 INFO - 'XPC_FLAGS': '0x0', 14:15:07 INFO - 'XPC_SERVICE_NAME': '0', 14:15:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Icmn9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-tZhNqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-JdRnbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-biCx2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-RAEkeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-3Nd_ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-gkk7FZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-o3kNrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-LtL5aX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-f1fTCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-wbeqqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-_mqQwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-vbeJyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-rxrnHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-RgabUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:09 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-IA4gvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:09 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-T7qIiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:15:09 INFO - Running setup.py install for manifestparser 14:15:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:15:09 INFO - Running setup.py install for mozcrash 14:15:09 INFO - Running setup.py install for mozdebug 14:15:09 INFO - Running setup.py install for mozdevice 14:15:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:15:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:15:09 INFO - Running setup.py install for mozfile 14:15:10 INFO - Running setup.py install for mozhttpd 14:15:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:15:10 INFO - Running setup.py install for mozinfo 14:15:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:15:10 INFO - Running setup.py install for mozInstall 14:15:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:15:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:15:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:15:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:15:10 INFO - Running setup.py install for mozleak 14:15:10 INFO - Running setup.py install for mozlog 14:15:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:15:10 INFO - Running setup.py install for moznetwork 14:15:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:15:10 INFO - Running setup.py install for mozprocess 14:15:11 INFO - Running setup.py install for mozprofile 14:15:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:15:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:15:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:15:11 INFO - Running setup.py install for mozrunner 14:15:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:15:11 INFO - Running setup.py install for mozscreenshot 14:15:11 INFO - Running setup.py install for moztest 14:15:11 INFO - Running setup.py install for mozversion 14:15:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:15:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:15:11 INFO - Cleaning up... 14:15:11 INFO - Return code: 0 14:15:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:11 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')]} 14:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:11 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')]} 14:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:11 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 0x10735ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1434920e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071fbe00>, '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 0x107064db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071f6b20>, '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.ssFRsknrJk/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.peGEah51PS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 14:15:11 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 14:15:11 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 14:15:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssFRsknrJk/Render', 14:15:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:11 INFO - 'HOME': '/Users/cltbld', 14:15:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:11 INFO - 'LOGNAME': 'cltbld', 14:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:11 INFO - 'MOZ_NO_REMOTE': '1', 14:15:11 INFO - 'NO_EM_RESTART': '1', 14:15:11 INFO - 'PAGER': '/bin/cat', 14:15:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:11 INFO - 'PWD': '/builds/slave/test', 14:15:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:11 INFO - 'SHELL': '/bin/bash', 14:15:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.peGEah51PS/Listeners', 14:15:11 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 14:15:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:11 INFO - 'USER': 'cltbld', 14:15:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:11 INFO - 'XPC_FLAGS': '0x0', 14:15:11 INFO - 'XPC_SERVICE_NAME': '0', 14:15:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-b6Vl78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:12 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)) 14:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-5wqdX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:12 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)) 14:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-WCGdGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:12 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)) 14:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-C9y4tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:12 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)) 14:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-neLN1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:12 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)) 14:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Un6y0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:12 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)) 14:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Ot7NVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:12 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)) 14:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-0QPLB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:12 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)) 14:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-WRG3mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:13 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)) 14:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-g8_cfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:13 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)) 14:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-9u1usu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:13 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)) 14:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-YbuNEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:13 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)) 14:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-pIfljv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:13 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)) 14:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-429ubW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:13 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)) 14:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-K1DOsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:13 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)) 14:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-QjtLqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:13 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)) 14:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:13 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-hxt0YF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:13 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)) 14:15:13 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)) 14:15:13 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)) 14:15:13 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)) 14:15:13 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)) 14:15:13 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)) 14:15:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:16 INFO - Downloading blessings-1.6.tar.gz 14:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:15:16 INFO - Installing collected packages: blessings 14:15:16 INFO - Running setup.py install for blessings 14:15:16 INFO - Successfully installed blessings 14:15:16 INFO - Cleaning up... 14:15:16 INFO - Return code: 0 14:15:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:15:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:16 INFO - Reading from file tmpfile_stdout 14:15:16 INFO - Current package versions: 14:15:16 INFO - blessings == 1.6 14:15:16 INFO - blobuploader == 1.2.4 14:15:16 INFO - docopt == 0.6.1 14:15:16 INFO - manifestparser == 1.1 14:15:16 INFO - mozInstall == 1.12 14:15:16 INFO - mozcrash == 0.17 14:15:16 INFO - mozdebug == 0.1 14:15:16 INFO - mozdevice == 0.48 14:15:16 INFO - mozfile == 1.2 14:15:16 INFO - mozhttpd == 0.7 14:15:16 INFO - mozinfo == 0.9 14:15:16 INFO - mozleak == 0.1 14:15:16 INFO - mozlog == 3.1 14:15:16 INFO - moznetwork == 0.27 14:15:16 INFO - mozprocess == 0.22 14:15:16 INFO - mozprofile == 0.28 14:15:16 INFO - mozrunner == 6.11 14:15:16 INFO - mozscreenshot == 0.1 14:15:16 INFO - mozsystemmonitor == 0.0 14:15:16 INFO - moztest == 0.7 14:15:16 INFO - mozversion == 1.4 14:15:16 INFO - psutil == 3.1.1 14:15:16 INFO - requests == 1.2.3 14:15:17 INFO - wsgiref == 0.1.2 14:15:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15: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')]} 14:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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')]} 14:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:17 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 0x10735ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1434920e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071fbe00>, '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 0x107064db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071f6b20>, '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.ssFRsknrJk/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.peGEah51PS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 14:15:17 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 14:15:17 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 14:15:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssFRsknrJk/Render', 14:15:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:17 INFO - 'HOME': '/Users/cltbld', 14:15:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:17 INFO - 'LOGNAME': 'cltbld', 14:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:17 INFO - 'MOZ_NO_REMOTE': '1', 14:15:17 INFO - 'NO_EM_RESTART': '1', 14:15:17 INFO - 'PAGER': '/bin/cat', 14:15:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:17 INFO - 'PWD': '/builds/slave/test', 14:15:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:17 INFO - 'SHELL': '/bin/bash', 14:15:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.peGEah51PS/Listeners', 14:15:17 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 14:15:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:17 INFO - 'USER': 'cltbld', 14:15:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:17 INFO - 'XPC_FLAGS': '0x0', 14:15:17 INFO - 'XPC_SERVICE_NAME': '0', 14:15:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:17 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)) 14:15:17 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)) 14:15:17 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)) 14:15:17 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)) 14:15:17 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)) 14:15:17 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)) 14:15:17 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)) 14:15:17 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)) 14:15:17 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)) 14:15:17 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)) 14:15:17 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)) 14:15:17 INFO - Cleaning up... 14:15:17 INFO - Return code: 0 14:15:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:15: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')]} 14:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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')]} 14:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10735ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1434920e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071fbe00>, '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 0x107064db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071f6b20>, '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.ssFRsknrJk/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.peGEah51PS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 14:15: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', 'jsonschema'] in /builds/slave/test/build 14:15: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 jsonschema 14:15:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssFRsknrJk/Render', 14:15:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:17 INFO - 'HOME': '/Users/cltbld', 14:15:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:17 INFO - 'LOGNAME': 'cltbld', 14:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:17 INFO - 'MOZ_NO_REMOTE': '1', 14:15:17 INFO - 'NO_EM_RESTART': '1', 14:15:17 INFO - 'PAGER': '/bin/cat', 14:15:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:17 INFO - 'PWD': '/builds/slave/test', 14:15:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:17 INFO - 'SHELL': '/bin/bash', 14:15:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.peGEah51PS/Listeners', 14:15:17 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 14:15:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:17 INFO - 'USER': 'cltbld', 14:15:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:17 INFO - 'XPC_FLAGS': '0x0', 14:15:17 INFO - 'XPC_SERVICE_NAME': '0', 14:15:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:17 INFO - Downloading/unpacking jsonschema 14:15:17 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 14:15:17 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 14:15:17 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 14:15:17 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 14:15:17 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 14:15:17 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 14:15:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:15:19 INFO - Downloading/unpacking functools32 (from jsonschema) 14:15:19 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 14:15:19 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 14:15:19 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 14:15:19 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 14:15:19 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 14:15:19 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 14:15:20 INFO - Downloading functools32-3.2.3-2.tar.gz 14:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:15:20 INFO - warning: no files found matching '*.txt' 14:15:20 INFO - no previously-included directories found matching 'build' 14:15:20 INFO - no previously-included directories found matching 'dist' 14:15:20 INFO - no previously-included directories found matching '.git*' 14:15:20 INFO - Installing collected packages: jsonschema, functools32 14:15:20 INFO - Running setup.py install for functools32 14:15:20 INFO - warning: no files found matching '*.txt' 14:15:20 INFO - no previously-included directories found matching 'build' 14:15:20 INFO - no previously-included directories found matching 'dist' 14:15:20 INFO - no previously-included directories found matching '.git*' 14:15:20 INFO - Successfully installed jsonschema functools32 14:15:20 INFO - Cleaning up... 14:15:20 INFO - Return code: 0 14:15:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:15:20 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')]} 14:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:20 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')]} 14:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:20 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 0x10735ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1434920e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071fbe00>, '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 0x107064db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071f6b20>, '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.ssFRsknrJk/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.peGEah51PS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 14:15:20 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 14:15:20 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 14:15:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssFRsknrJk/Render', 14:15:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:20 INFO - 'HOME': '/Users/cltbld', 14:15:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:20 INFO - 'LOGNAME': 'cltbld', 14:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:20 INFO - 'MOZ_NO_REMOTE': '1', 14:15:20 INFO - 'NO_EM_RESTART': '1', 14:15:20 INFO - 'PAGER': '/bin/cat', 14:15:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:20 INFO - 'PWD': '/builds/slave/test', 14:15:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:20 INFO - 'SHELL': '/bin/bash', 14:15:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.peGEah51PS/Listeners', 14:15:20 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 14:15:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:20 INFO - 'USER': 'cltbld', 14:15:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:20 INFO - 'XPC_FLAGS': '0x0', 14:15:20 INFO - 'XPC_SERVICE_NAME': '0', 14:15:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:20 INFO - Downloading/unpacking flake8 14:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:15:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:15:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:15:24 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 14:15:24 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 14:15:24 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 14:15:24 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 14:15:24 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 14:15:24 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 14:15:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:15:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:15:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:15:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:15:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:15:24 INFO - no previously-included directories found matching 'docs/_build' 14:15:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:15:24 INFO - Running setup.py install for pep8 14:15:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:15:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:15:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:15:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:15:24 INFO - no previously-included directories found matching 'docs/_build' 14:15:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:15:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:15:24 INFO - Cleaning up... 14:15:25 INFO - Return code: 0 14:15:25 INFO - Running post-action listener: _resource_record_post_action 14:15:25 INFO - Running post-action listener: _start_resource_monitoring 14:15:25 INFO - Starting resource monitoring. 14:15:25 INFO - ##### 14:15:25 INFO - ##### Running install step. 14:15:25 INFO - ##### 14:15:25 INFO - Running pre-action listener: _resource_record_pre_action 14:15:25 INFO - Running main action method: install 14:15:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:25 INFO - Reading from file tmpfile_stdout 14:15:25 INFO - Detecting whether we're running mozinstall >=1.0... 14:15:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:15:25 INFO - Reading from file tmpfile_stdout 14:15:25 INFO - Output received: 14:15:25 INFO - Usage: mozinstall [options] installer 14:15:25 INFO - Options: 14:15:25 INFO - -h, --help show this help message and exit 14:15:25 INFO - -d DEST, --destination=DEST 14:15:25 INFO - Directory to install application into. [default: 14:15:25 INFO - "/builds/slave/test"] 14:15:25 INFO - --app=APP Application being installed. [default: firefox] 14:15:25 INFO - mkdir: /builds/slave/test/build/application 14:15:25 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'] 14:15:25 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 14:15:47 INFO - Reading from file tmpfile_stdout 14:15:47 INFO - Output received: 14:15:47 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:15:47 INFO - Running post-action listener: _resource_record_post_action 14:15:47 INFO - ##### 14:15:47 INFO - ##### Running run-tests step. 14:15:47 INFO - ##### 14:15:47 INFO - Running pre-action listener: _resource_record_pre_action 14:15:47 INFO - Running main action method: run_tests 14:15:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:15:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:15:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:15:47 INFO - 2016-06-30 14:15:47.348 screenresolution[1638:7403] starting screenresolution argv=screenresolution get 14:15:47 INFO - 2016-06-30 14:15:47.350 screenresolution[1638:7403] Display 0: 1600x1200x32@60 14:15:47 INFO - 2016-06-30 14:15:47.355 screenresolution[1639:7406] starting screenresolution argv=screenresolution list 14:15:47 INFO - Available Modes on Display 0 14:15:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:15:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:15:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:15:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:15:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:15:47 INFO - Intel Iris: 14:15:47 INFO - Chipset Model: Intel Iris 14:15:47 INFO - Type: GPU 14:15:47 INFO - Bus: Built-In 14:15:47 INFO - VRAM (Dynamic, Max): 1536 MB 14:15:47 INFO - Vendor: Intel (0x8086) 14:15:47 INFO - Device ID: 0x0a2e 14:15:47 INFO - Revision ID: 0x0009 14:15:47 INFO - Displays: 14:15:47 INFO - Display: 14:15:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:15:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:15:47 INFO - Display Serial Number: 1600x1200 60 14:15:47 INFO - Main Display: Yes 14:15:47 INFO - Mirror: Off 14:15:47 INFO - Online: Yes 14:15:47 INFO - Rotation: Supported 14:15:47 INFO - Return code: 0 14:15:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:15:47 INFO - Python 2.7.3 14:15:47 INFO - Return code: 0 14:15:47 INFO - grabbing minidump binary from tooltool 14:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:47 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 0x1071fbe00>, '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 0x107064db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071f6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:15:47 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 14:15:47 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 14:15:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:15:47 INFO - Return code: 0 14:15:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:15:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:15:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:15:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:15:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:15:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:15:48 INFO - Return code: 0 14:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:15:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssFRsknrJk/Render', 14:15:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:48 INFO - 'HOME': '/Users/cltbld', 14:15:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:48 INFO - 'LOGNAME': 'cltbld', 14:15:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:15:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:48 INFO - 'MOZ_NO_REMOTE': '1', 14:15:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:15:48 INFO - 'NO_EM_RESTART': '1', 14:15:48 INFO - 'PAGER': '/bin/cat', 14:15:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:48 INFO - 'PWD': '/builds/slave/test', 14:15:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:15:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:48 INFO - 'SHELL': '/bin/bash', 14:15:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.peGEah51PS/Listeners', 14:15:48 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 14:15:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:48 INFO - 'USER': 'cltbld', 14:15:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:48 INFO - 'XPC_FLAGS': '0x0', 14:15:48 INFO - 'XPC_SERVICE_NAME': '0', 14:15:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:15:48 INFO - mozversion application_buildid: 20160630115927 14:15:48 INFO - mozversion application_changeset: bcb69c8427d315b1d9c993493b2baf639761dd86 14:15:48 INFO - mozversion application_display_name: Firefox 14:15:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:15:48 INFO - mozversion application_name: Firefox 14:15:48 INFO - mozversion application_remotingname: firefox 14:15:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:15:48 INFO - mozversion application_vendor: Mozilla 14:15:48 INFO - mozversion application_version: 48.0 14:15:48 INFO - mozversion platform_buildid: 20160630115927 14:15:48 INFO - mozversion platform_changeset: bcb69c8427d315b1d9c993493b2baf639761dd86 14:15:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:15:48 INFO - mozversion platform_version: 48.0 14:15:48 INFO - using testdate: 1467321348 14:15:48 INFO - actual date: 1467321348 14:15:48 INFO - starting webserver on 'localhost:49278' 14:15:48 INFO - SUITE-START | Running 2 tests 14:15:48 INFO - TEST-START | dromaeo_css 14:15:48 INFO - operating with platform_type : mac_ 14:15:48 INFO - Initialising browser for dromaeo_css test... 14:15:48 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp4rcN1o/profile http://localhost:49278/getInfo.html) 14:15:51 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 14:15:51 INFO - PROCESS | 1657 | colorDepth:24 14:15:51 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 14:15:51 INFO - PROCESS | 1657 | __metrics 14:15:52 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 14:15:52 INFO - TEST-INFO | 1657: exit 0 14:15:52 INFO - Browser initialized. 14:15:52 INFO - Running cycle 1/1 for dromaeo_css test... 14:15:52 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp4rcN1o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:16:04 INFO - PROCESS | 1661 | RSS: Main: 171433984 14:16:04 INFO - PROCESS | 1661 | 14:16:54 INFO - PROCESS | 1661 | 1467321414107 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] 14:19:04 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 14:19:05 INFO - PROCESS | 1661 | RSS: Main: 181649408 14:19:05 INFO - PROCESS | 1661 | 14:22:07 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 14:22:08 INFO - PROCESS | 1661 | RSS: Main: 192569344 14:22:08 INFO - PROCESS | 1661 | 14:25:10 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 14:25:10 INFO - PROCESS | 1661 | RSS: Main: 194510848 14:25:10 INFO - PROCESS | 1661 | 14:28:12 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 14:28:13 INFO - PROCESS | 1661 | RSS: Main: 198410240 14:28:13 INFO - PROCESS | 1661 | 14:31:15 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 14:31:16 INFO - PROCESS | 1661 | RSS: Main: 197562368 14:31:16 INFO - PROCESS | 1661 | 14:34:18 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 14:34:18 INFO - PROCESS | 1661 | RSS: Main: 203141120 14:34:18 INFO - PROCESS | 1661 | 14:34:18 INFO - PROCESS | 1661 | __start_tp_report 14:34:18 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 14:34:18 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 14:34:18 INFO - PROCESS | 1661 | |i|pagename|runs| 14:34:18 INFO - PROCESS | 1661 | |0;dojo.html;3031.8029328093676;3656.213914008488;3698.9075273118187;3721.3487639663053;3726.441033844924;5582.944170558293;5783.98780213462;5812.564057695668;6000.039993601019;6033.698315084239;4691.695039822409;5849.2980842298875;5958.49352805011;5994.250718660168;6062.272527296731;4493.595576398124;4956.7769450374635;5448.346198456171;5465.398806131322;5470.234167216593;5366.087765079946;5435.2934118564535;5450.427705090968;5518.365387980373;5562.666240025591;5479.123340265558;5494.752736126864;5510.669359838423;5515.586331025189;5525.723713814314;4303.182395344875;5275.446078161776;5422.701751403672;5435.701036442994;5498.395176530578;5317.946820531823;5343.251944727741;5367.141257398836;5369.5972802040005;5430.864228394283;5674.773009079632;5806.1000544915605;5809.2738407699035;5862.912056319158;5872.882542349129;6194.25668919728;6201.534884883652;6261.812145635638;6292.2134733158355;6298.433141017331;6243.125962365272;6280.905786413207;6290.276618188921;6300.621962682254;6325.778597749057;5856.941430585683;5884.58807883444;5902.114682797572;5935;5943.910841337383;5305.336832895888;6313.779017734358;6335.334789847092;6362.713677884506;6372.044193370939;6304;6323.399277068671;6332.430081292706;6344.49244060474;6348.301686814447;6347.270063942613;6349.238091428966;6352.333005034498;6359.459445947054;6372.330905254974;6119.472088496329;6249.937500625027;6291.056341548804;6297.685115744194;6312.905306420407;5324.41431442541;6272.686365681698;6286.277078136073;6298.401651843067;6300.59046161998;4972.105021096238;5063.924041139386;5077.619178561623;5078.771455284447;5083.135866902636;4096.91806163875;4475.731456112644;4535.274356103074;4566.4063671723125;4849.563539281482;4376.7811609419405;5997.610155339889;6056.788012419544;6060.787872424444;6081.391860813972;5362.329708786402;5605.80379686709;6303.401176888188;6309.62142271456;6341.746330146742;5845.064789633723;5999.850003749942;6045.455908968214;6069.605475644069;6085.786997455068;5523.475269849358;5545.279113715191;5557.221988921554;5566.666000040011;5573.972130139405;6568.277489476058;6577.243616984012;6579.1447111874195;6588.505862060365;6589.077529145923;6222.128901953821;6248.937510624835;6287.842803929939;6328.683565821782;6350.428461438492;6531.9020214695865;6560.409563139149;6572.539922205591;6615.834604134935;6712.228093769084;6200.193974783249;6227.844303892439;6323.715432805627;6324.177856878577;6324.747010119728;6241.812745617639;6248.12526246335;6259.874802504016;6283.685815709105;6304.810855674154;6245.96877015612;6250.499960003098;6266.091416744638;6280.9685951569945;6283.74865005413;6238;6242.1261023455845;6285.811425657238;6302.054691796267;6309.179806625109;4655.9301610475195;6116.8836339025665;6209.472194863487;6228.875422491616;6249.406306400884;5145.742712864267;6292.276388215414;6297.842553936188;6310.52671049664;6335.461485773577;6080.118382834376;6130.184124957687;6197.03945888388;6208.4722798562625;6235.906461402992 14:34:18 INFO - PROCESS | 1661 | |1;ext.html;536.627044204278;540.370468404309;574.7126436781609;581.3779256195869;589.2075158911264;32149.67850321499;41266.79366603171;41306;41334.7933260334;41357.759267221954;42340;42361.364579531335;42885.57114428855;42900.57099429005;43009;9555.904440955588;9637.90362096377;9707.514624268793;9768.413895166314;9806.656767013155;9635.903640963606;9759.707208783713;9784.21726261901;9795;9842.655507057254;9826.606935722562;9843.360181588174;9882.962288959663;9899.010098990115;9911.553980070878;9810.754731131707;9847.90152098477;9868.654597089138;9873.753156171082;9906.009399060109;9734.318597698164;9841.409515429097;9850.60597576096;9850.704478865646;9865.753356166082;40738;40752.79623601893;41404.964875878046;41479.58520414818;41480.962975925846;3308.040668206217;3332.6500717424806;3349.7822641528464;3490.9127271818406;3496.5454490916272;27691.307717307027;27897.442051159065;27961.300967475774;29087.41825163506;29686.851565742032;2757.7793776497833;2782.4713304472084;2822.252103192656;2823.774098072149;2835.702251263608;335096;338116;338414;341360;342599.28700356587;37759.62240377616;38682.80658596745;65717;66082.33917660858;66131;36212;37184.814075929986;37435.81282093626;37509.81245093757;37679;16230.350785968665;16354.10052447103;16390.67218655644;16432.424865129662;16454;12724.618261452171;13073.346332683328;13108.147970381895;13147.53983610569;13170.47318107265;8184.427090103635;8258.25675689191;8505.489670619783;8554.272886804567;8624.784380390414;3085.41377138343;3533.452314891196;3544.7873127612424;3574.267275208576;3578.302231064917;997.4514017290461;1038.6105210546045;1047.2667734898603;1077.6120596585224;1202.5490441084594;24880;30687;31052.68947310498;31434.68565314363;32224.38878056135;1156.7281688803125;1164.6331405607207;1200.5857978997233;1246.2584762066738;1274.5973839312962;15902.966307189996;16087.597810054609;16100.838991610168;16219.756703649455;16297.59256018609;619141;619143.9042804848;627017;629216.8539157367;629774;64138;64220;64351.35648643454;64942.35057649457;65193;1362.7819548872133;1495.274791726012;1527.5341020988706;1537.3927298717167;1555.4633651390252;30837.383252334377;30854.382912342076;30954.833161678467;31611;32303.51544726784;54029.729851352065;55127;55604.16593751016;55758.442415576945;55949.72025139848;546824.265878668;547748;550927;551055;552475;26087.869560652074;27436;27486;27544.58683119795;27971;47461.7626911877;48069.75965120152;48839.267410988155;49352.75323623359;49367.753161233966;31883.52174717335;32601.18497037593;39920.80039599783;39968.60031399649;40312.39531406973;31772;38685.419718704805;39275.41086883756;39594.80202599084;39870;39620.405693914036;39759.80120099381;40771;40834.79582602068;40955.795221023705;25239.61182135;26211.73788262093;31025.534616981215;31949;32869.17827054343;18738.906305468387;23975.640365394185;23986.760132398453;25168.74831251664;25235.621465678396 14:34:18 INFO - PROCESS | 1661 | |2;jquery.html;376.3808534959991;416.79368712487303;419.86354434808686;419.9370094485825;430.0796295926717;18048.368307109253;20554.280600178998;21227;21237.893810530946;21455.249066282682;20113;20143.89208593527;20936.47658808527;22831.08675652976;22895.31314060581;5332.680039197641;5855.151003104558;5984.640921544721;6183.350748171445;6188.319284878659;5971.164037034797;5985.88028239435;6038.0942858571125;6117.2659280886355;6158.56890017699;5826.650400975934;5956.821295361146;6118.204633397652;6130.417610327012;6130.785422510213;5941.197938278342;5970.701464926737;6041.607295525799;6094.116353128771;6141.416565426277;4383.780810959439;5251.579873610102;5613.624661957806;5907.1434641976675;5999.100134979788;13722.970777191751;15201.771973420296;24826.751732482626;25221.873890630613;25607.871960640077;2093.4033800366824;2162.610730068587;2167.794059564339;2379.9643005354933;2664.227374061539;9614.855777163348;9975.301728878982;10051.396916185053;10251;10473.319234249826;1650.4718490083058;1811.194018661696;1827.570520927581;1878.3989123480492;1912.4549503391606;110660.89339106587;112231.43884280608;115176;115963;116779;11669.76660466803;11820.349880756641;11901.940490297666;11984.041276697842;12034.939825300817;12344.75310493803;14716.484923027643;15145.62135946588;15486.922565387102;15493.612659683373;8978.775530611656;9142.268618510503;9258.009527951388;9292.581833817494;9363.953180234055;9121.67735678323;9293.814123717488;9355.906440935503;9384.67153649619;9434.811303773886;3945.6646185074014;4723.362346083303;4760.309755085494;4783.784729687172;4848.248521479177;2029.3506078055175;2121.915123395047;2122.734658167729;2149.1946764717713;2167.8048975592274;970.6117552978865;983.6655537117272;1067.631667074858;1069.5294070608907;1078.4661592511757;20087;20574;20676.966151692355;21259;21298.148074076864;1006.1799633298838;1035.2597892506894;1037.4913913978305;1048.6853943816825;1079.5142186016324;10857.185711071701;11027.779444411068;11032.724181895357;11046.33721976684;11046.392448415414;621966;634499;640283;645633;646479;85270.29459410776;113288.30067548994;122465;123738;125147;1032.3341444768082;1033.6975410982366;1035.808375450529;1055.0873494427265;1076.6178006807627;16298.674026519166;16950.321987120376;17082.82917170862;18604.627907442045;18624.348147814762;36792.113261877974;42502.362464563674;49029.26456103232;49373;50321.49678503168;69622.30377696158;72280.63859680668;74411;75305;76182.6190869042;6586.979018252178;8153.8369232616205;8215.219554142346;8305.875411868707;8480.024797148408;10700.785984280115;11699.415029248674;12150.878491214975;12356.3821808911;12654.240745555297;10762.192835537522;10795.892041079489;10839.295445795999;10905.454727263765;10970;9828.213742900407;10078.445685487368;10574.788504230026;10615.256932014685;10984.06635435965;10677.94661026721;11003.559857605605;11241.38172400493;11251.156163287622;11289.7742045157;7074.842173137243;8115.391345648982;8226.506409615442;8274.627641756015;8285.80426187049;9513.809723805623;10928.672139835817;10957.780844383227;10959.397233152253;11072.612458563912 14:34:18 INFO - PROCESS | 1661 | |3;mootools.html;1648.472488803583;1677.2787701288446;1960.1571324330541;2004.9699254511186;2117.9258725944596;8156.143604921472;8862.246709029723;8933.597988090536;9147.542622868856;9172.587233574488;8899.644014239422;8937.776555586113;9039.141281578239;9074.954625226881;9115.68095116671;2511.4977004599064;2511.7362676918933;2527.3302574817735;2551.706553746315;2555.718870924197;2494.2267896952003;2513.5349960257317;2516.4086439686657;2527.4818662174303;2554.476332351863;2513.3465299022296;2521.596544552872;2531.632913227581;2532.3795670060863;2567.935801604956;2189.2228258968;2479.0703486192588;2510.159096702607;2539.5809691400896;2551.2983929419374;2109.9367018989456;2513.987430062856;2533.0121252711456;2545.083769842855;2547.5669136246884;9144.679936202267;9164.175224229852;9167.587458564314;9198.954005229998;9209.723708288695;5526;5608.186812912105;5678.261825962599;5724.284464441945;5832.533397328203;3619.348517266891;3697.611750766158;3707.7775333480076;3755.6995440364976;3767.7174211934216;1057.5716834681966;1080.1089101491302;1081.7187531241934;1081.7343707861821;1084.322298563398;12085.939570302093;12119.93940030303;12428.937855310665;12434.689132771662;12449.190802597803;4885.193942999436;4921.360223170965;4957.677750946177;4974.701517908937;5034.8237811677145;10413.687589372332;10616.946915265375;10630.415327157081;10659.520321585547;10661.147108231324;5485.753141108659;5531.778728850801;5538;5629.268195134607;5694.686792226385;4556.043230921544;4966.304717339575;5026.723530205873;5077.720725360066;5108.208227724708;4235.8093885775215;4240.575942405796;4271.526323418416;4276.486821581368;4295.420118284054;1269.2447993443886;1345.7779466388133;1379.4137491566044;1407.429990853706;1410.9365078571489;823.2878560045517;884.6107712606432;902.8149229407956;913.4610579757974;973.6689525561343;6143.078538219303;6152.230971128609;6153.2000839890525;6234.407731265523;6304.8423789404715;769.926856948589;948.5257371314343;998.9200863931013;1018.0379541333369;1044.2742294105524;3950;4016.5380981187536;4025.4766880305374;4089.1208390196252;4143.8964025899595;10829.512671929624;10872;10962.123030157569;11211.271267367758;11268.661940141808;10894.509747061402;10941.945290273497;11007.284526505751;11082;11240.100791936626;8251;8448.281896038905;8487.830243395098;8646.351523635753;8722.34582406322;5215.843524694265;5908.202392676933;5965.791197308074;6057.575969682256;6171.981623032149;9713.56288966984;9813.85279220798;10043.246756493147;10155.289129760846;10292;10026.097651211427;10099.848502272618;10242.692719218436;10456.947715261374;10499.580016799242;6663.566868153554;7317.195108538163;7329.9267007329245;8225.054118776177;8471.279941205066;8427.5786210688;8530.573471326285;8532.658693652433;8562.357823163164;8564.400491965502;7466.216047314953;7466.887996679946;7703.383729301754;7717.1896950819355;7745.728899488491;7435.293647103516;7472.215417381314;7500.549967001997;7610.238976102345;7632.122305934889;6069.635821850703;6098.634081955097;7198.7840364789145;7208.531445456028;7281.854362912818;4956.727379994135;4999.525045120708;5012.47369026247;5142.922856157235;5152.896942061213;5085.4406015337545;5104.642675012714;5116.7441627917715;5167.121589329748;5322.627416080992 14:34:18 INFO - PROCESS | 1661 | |4;prototype.html;295.7545237452914;339.6094491334963;342.46746309488736;346.4422280128992;353.27049642488277;6941.618210998393;7012.929870701291;7013.3337332953415;7028.718851245951;7043.859122817541;6936.965315173417;7008.088948436696;7023.40301074408;7040.6127662978515;7055.717771289155;4944.283078953549;5046.419661738892;5205.16717325228;5207.791688332462;5218.347706536683;5141.228815677659;5218.8695282617855;5218.973905130469;5226.294450249225;5238.842834714965;5152.098382783017;5154.716490593016;5160.896782064357;5163.044836705221;5167.509086636764;5154.896902061956;5180;5188.688678679272;5194.92207616886;5198.194279886624;4429.069895321986;4429.357743127229;4430.715092623168;4444.2222611042935;4451.043025749447;6606.60360378374;6756.797296081077;6797.966010169967;6808.557443766139;6815.625140617264;6020.066889632114;6056.576039677225;6069.848253793646;6079.422454866781;6093.177421048191;6463.192100987377;7527.134379546367;7528.397728181732;7530.28462296081;7558.281963213486;4689.718616882998;4929;4931.728754918478;4936.333594964705;4940.580050695695;7130.893036604455;7137.464690148259;7851.293383595446;7933.761987140338;7957.721479748239;4933.6299777516115;5045.091883461012;5045.697258164522;5045.8738531537;5050.823221187241;4260.360945858084;5097.668651537638;5143.485651434901;5152.995165942605;5340.985212809632;5929.902967950943;6006.039033754579;6020.157177995085;6036.396360363929;6041.909371359433;6314.463270621956;7526.059242594676;7542.736004239825;7575.166731659513;7580.507267027626;1709.1710520397596;1727.5940154063785;1751.798543167552;1803.386848471526;1803.9368622098164;1030.9587316810075;1064.7391389109562;1095.085603521053;1115.3530952047954;1141.5319718915205;6952.895706564405;6965.756198533129;6979.720811167598;6988.8951665724035;6998.68505917235;7690.653920573475;7708.113566939762;7713.614319284014;7717.22827717235;7717.57553334572;6968.895466568006;6975.651217439107;6986.755463558751;6995.26549712283;7001.544899581511;3998.8000599969887;4056.6815784869445;4111.9177616447505;4115.156392939441;4123.010477485382;6527.8694426111215;8153.836923261501;8181.427300088937;8209.630566624517;8219.83560328802;8015.238552337519;8045.115037345888;8048.557329346942;8106.432549721463;8144.75565733029;8265.297449716842;8274.338052955749;8280.378971577156;8321.66713331472;8325.209105135002;6312.936870631235;7659.310662040443;7841.764747057598;7920.643571039202;7972.760817175494;6840.48696347766;7153.892691609526;7691.5769632670745;7760.68957241704;7784.610769461391;8221.260086592236;8286.46138001028;8287;8311.002679678477;8338.749837504885;4614.238650622609;4925.187344088328;4929.274753836129;4936.3829521309835;4947.084789313988;6324.810255692337;7638.197989211053;7799.9220007799195;7910.841783164189;7926.088499822594;7548.905408715816;7558.735444259424;7560.848783024198;7588.430867684835;7597.240275972579;6083.878322433615;7533.54798712079;7584.12782529994;7608.31525162738;7618.504797188165;7127.287271272831;7347.889781653173;7356.264373562601;7367.963160184165;7382.630868456663;7521.210272921265;7579.734709285149;7584.772456826304;7586.506877053194;7597;7325.01112349826;7353.338199562065;7379.8155046124275;7391.40868730511;7413.518121322097 14:34:18 INFO - PROCESS | 1661 | |5;yui.html;681.8056853796669;715.1596873673434;757.1973707869655;777.7316825695135;790.7825348029291;15351.232438378092;15518.612034699125;15663.451779187744;15678;15719.449819256328;13881.93059034706;14288.214148221843;14382.208978506178;14407.567772966802;14492.420303187886;843.4939036578065;925.0518218825707;938.6198589571235;943.7687766497218;945.2013048973606;895.494045864088;944.1927152284801;952.8237276103908;958.4488918871642;961;959.649727849337;993.3344659078434;997.9051990060968;999.9050090241416;1000.8448690452991;838.8364268967554;960.7117864640614;962.9133377995979;969.0406497567358;998.241336584194;700.0304578159236;730.6565914020401;753.5930597477355;755.3353049316621;756.9280918312752;13297.86702132976;13401.86598134016;13603.86396136036;13645.590632281048;13716.3827627756;11425.200235983484;11665.591704290395;11828;12352.38238088092;12476.688082797911;9150.954245228731;11089.889101108967;11180.944095279552;11499.716584293838;11551.768964620745;3421.8118003510044;3482.564679415073;3532.275883443888;3559.288142371536;3610;76560;79496.20503794946;81647.7752833708;84657.30685386258;88301;9631.470269135265;9636.614535418645;9731.075547822946;9780.070893265129;9844.310898237054;20658;21362.359129226148;21409.250676226256;21629.891850540647;21663.35009949704;7595.468317217742;7641.159472458025;7663.655135518804;7734.651940662684;7902.446828721934;4132.33882578792;4199.538050814408;4215.156968606291;4230.534641189467;4231.217224813419;3186.8247246401206;3696;3719.1445967427103;3763.5671897731563;3767.811609419518;672.9334005601177;676.3608390071433;681.2438193605094;688.0745397440435;693.3551796828998;499.7950840155519;545.8226076525145;574.764346617893;621.2575971713759;622.8256088295285;7735.9613201933635;8030.277275045274;8193.79515512117;8203.30271926893;8258.380621453414;563.9041362968305;584.1442287049493;589.3958692340385;593.4391999560374;628.2994461175756;3844.692424606025;3874.4769456123627;3995.0212198011673;4014.9197016059516;4031.7580945143386;95998;98366;98996.50501747445;99396;100178.99821001843;64209.67895160494;70211.59576808436;71255.93116103263;71878.28121718716;80526;66427.66786166135;70669;70846;74977;76131.47737045339;8353.707620233263;8356.289715374018;8413.284870786052;8429.957850210709;8716.520591367282;39179.804100979316;47683;49565.50434495609;49914.750426247636;50600.48198554049;68356;69154.65422672854;69407.65296173487;69983;71078;10889.782204356026;10963.56145754161;11145.442727863412;11304.43477826089;11509.654710358367;9581.904180958101;10096.141827944706;11522.020628246693;12019.459124339252;12082.45628946717;11109.388983605655;11237.55049797999;11239.943800280946;11367.20429569922;11668.766624667629;10142.898571014195;10913.781724365626;11174;11248.26886252391;11636.767264654829;7785.338246248905;10847;11227.55089796399;11292.661220163409;11310.660680179608;9639;9719.514024298898;9859.704208873745;9901.603935842773;9999;9718.514074296398;9826.606935722491;9877.012298770065;9981.700548983543;10031.29780915358 14:34:18 INFO - PROCESS | 1661 | __end_tp_report 14:34:18 INFO - PROCESS | 1661 | __start_cc_report 14:34:18 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,391 14:34:18 INFO - PROCESS | 1661 | __end_cc_report 14:34:18 INFO - PROCESS | 1661 | __startTimestamp1467322458621__endTimestamp 14:34:18 INFO - PROCESS | 1661 | 14:34:18 INFO - PROCESS | 1661 | ------- Summary: start ------- 14:34:18 INFO - PROCESS | 1661 | Number of tests: 6 14:34:18 INFO - PROCESS | 1661 | 14:34:18 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5840.93 Median:6116.88 stddev:673.87 (11.0%) stddev-sans-first:638.89 14:34:18 INFO - PROCESS | 1661 | Values: 3031.8 3656.2 3698.9 3721.3 3726.4 5582.9 5784.0 5812.6 6000.0 6033.7 4691.7 5849.3 5958.5 5994.3 6062.3 4493.6 4956.8 5448.3 5465.4 5470.2 5366.1 5435.3 5450.4 5518.4 5562.7 5479.1 5494.8 5510.7 5515.6 5525.7 4303.2 5275.4 5422.7 5435.7 5498.4 5317.9 5343.3 5367.1 5369.6 5430.9 5674.8 5806.1 5809.3 5862.9 5872.9 6194.3 6201.5 6261.8 6292.2 6298.4 6243.1 6280.9 6290.3 6300.6 6325.8 5856.9 5884.6 5902.1 5935.0 5943.9 5305.3 6313.8 6335.3 6362.7 6372.0 6304.0 6323.4 6332.4 6344.5 6348.3 6347.3 6349.2 6352.3 6359.5 6372.3 6119.5 6249.9 6291.1 6297.7 6312.9 5324.4 6272.7 6286.3 6298.4 6300.6 4972.1 5063.9 5077.6 5078.8 5083.1 4096.9 4475.7 4535.3 4566.4 4849.6 4376.8 5997.6 6056.8 6060.8 6081.4 5362.3 5605.8 6303.4 6309.6 6341.7 5845.1 5999.9 6045.5 6069.6 6085.8 5523.5 5545.3 5557.2 5566.7 5574.0 6568.3 6577.2 6579.1 6588.5 6589.1 6222.1 6248.9 6287.8 6328.7 6350.4 6531.9 6560.4 6572.5 6615.8 6712.2 6200.2 6227.8 6323.7 6324.2 6324.7 6241.8 6248.1 6259.9 6283.7 6304.8 6246.0 6250.5 6266.1 6281.0 6283.7 6238.0 6242.1 6285.8 6302.1 6309.2 4655.9 6116.9 6209.5 6228.9 6249.4 5145.7 6292.3 6297.8 6310.5 6335.5 6080.1 6130.2 6197.0 6208.5 6235.9 14:34:18 INFO - PROCESS | 1661 | 14:34:18 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:63885.24 Median:38980.42 stddev:138902.60 (356.3%) stddev-sans-first:139210.83 14:34:18 INFO - PROCESS | 1661 | Values: 536.6 540.4 574.7 581.4 589.2 32149.7 41266.8 41306.0 41334.8 41357.8 42340.0 42361.4 42885.6 42900.6 43009.0 9555.9 9637.9 9707.5 9768.4 9806.7 9635.9 9759.7 9784.2 9795.0 9842.7 9826.6 9843.4 9883.0 9899.0 9911.6 9810.8 9847.9 9868.7 9873.8 9906.0 9734.3 9841.4 9850.6 9850.7 9865.8 40738.0 40752.8 41405.0 41479.6 41481.0 3308.0 3332.7 3349.8 3490.9 3496.5 27691.3 27897.4 27961.3 29087.4 29686.9 2757.8 2782.5 2822.3 2823.8 2835.7 335096.0 338116.0 338414.0 341360.0 342599.3 37759.6 38682.8 65717.0 66082.3 66131.0 36212.0 37184.8 37435.8 37509.8 37679.0 16230.4 16354.1 16390.7 16432.4 16454.0 12724.6 13073.3 13108.1 13147.5 13170.5 8184.4 8258.3 8505.5 8554.3 8624.8 3085.4 3533.5 3544.8 3574.3 3578.3 997.5 1038.6 1047.3 1077.6 1202.5 24880.0 30687.0 31052.7 31434.7 32224.4 1156.7 1164.6 1200.6 1246.3 1274.6 15903.0 16087.6 16100.8 16219.8 16297.6 619141.0 619143.9 627017.0 629216.9 629774.0 64138.0 64220.0 64351.4 64942.4 65193.0 1362.8 1495.3 1527.5 1537.4 1555.5 30837.4 30854.4 30954.8 31611.0 32303.5 54029.7 55127.0 55604.2 55758.4 55949.7 546824.3 547748.0 550927.0 551055.0 552475.0 26087.9 27436.0 27486.0 27544.6 27971.0 47461.8 48069.8 48839.3 49352.8 49367.8 31883.5 32601.2 39920.8 39968.6 40312.4 31772.0 38685.4 39275.4 39594.8 39870.0 39620.4 39759.8 40771.0 40834.8 40955.8 25239.6 26211.7 31025.5 31949.0 32869.2 18738.9 23975.6 23986.8 25168.7 25235.6 14:34:18 INFO - PROCESS | 1661 | 14:34:18 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:35195.59 Median:21376.70 stddev:105676.90 (494.4%) stddev-sans-first:105941.01 14:34:18 INFO - PROCESS | 1661 | Values: 376.4 416.8 419.9 419.9 430.1 18048.4 20554.3 21227.0 21237.9 21455.2 20113.0 20143.9 20936.5 22831.1 22895.3 5332.7 5855.2 5984.6 6183.4 6188.3 5971.2 5985.9 6038.1 6117.3 6158.6 5826.7 5956.8 6118.2 6130.4 6130.8 5941.2 5970.7 6041.6 6094.1 6141.4 4383.8 5251.6 5613.6 5907.1 5999.1 13723.0 15201.8 24826.8 25221.9 25607.9 2093.4 2162.6 2167.8 2380.0 2664.2 9614.9 9975.3 10051.4 10251.0 10473.3 1650.5 1811.2 1827.6 1878.4 1912.5 110660.9 112231.4 115176.0 115963.0 116779.0 11669.8 11820.3 11901.9 11984.0 12034.9 12344.8 14716.5 15145.6 15486.9 15493.6 8978.8 9142.3 9258.0 9292.6 9364.0 9121.7 9293.8 9355.9 9384.7 9434.8 3945.7 4723.4 4760.3 4783.8 4848.2 2029.4 2121.9 2122.7 2149.2 2167.8 970.6 983.7 1067.6 1069.5 1078.5 20087.0 20574.0 20677.0 21259.0 21298.1 1006.2 1035.3 1037.5 1048.7 1079.5 10857.2 11027.8 11032.7 11046.3 11046.4 621966.0 634499.0 640283.0 645633.0 646479.0 85270.3 113288.3 122465.0 123738.0 125147.0 1032.3 1033.7 1035.8 1055.1 1076.6 16298.7 16950.3 17082.8 18604.6 18624.3 36792.1 42502.4 49029.3 49373.0 50321.5 69622.3 72280.6 74411.0 75305.0 76182.6 6587.0 8153.8 8215.2 8305.9 8480.0 10700.8 11699.4 12150.9 12356.4 12654.2 10762.2 10795.9 10839.3 10905.5 10970.0 9828.2 10078.4 10574.8 10615.3 10984.1 10677.9 11003.6 11241.4 11251.2 11289.8 7074.8 8115.4 8226.5 8274.6 8285.8 9513.8 10928.7 10957.8 10959.4 11072.6 14:34:18 INFO - PROCESS | 1661 | 14:34:18 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5915.10 Median:4970.50 stddev:3286.53 (66.1%) stddev-sans-first:3280.11 14:34:18 INFO - PROCESS | 1661 | Values: 1648.5 1677.3 1960.2 2005.0 2117.9 8156.1 8862.2 8933.6 9147.5 9172.6 8899.6 8937.8 9039.1 9075.0 9115.7 2511.5 2511.7 2527.3 2551.7 2555.7 2494.2 2513.5 2516.4 2527.5 2554.5 2513.3 2521.6 2531.6 2532.4 2567.9 2189.2 2479.1 2510.2 2539.6 2551.3 2109.9 2514.0 2533.0 2545.1 2547.6 9144.7 9164.2 9167.6 9199.0 9209.7 5526.0 5608.2 5678.3 5724.3 5832.5 3619.3 3697.6 3707.8 3755.7 3767.7 1057.6 1080.1 1081.7 1081.7 1084.3 12085.9 12119.9 12428.9 12434.7 12449.2 4885.2 4921.4 4957.7 4974.7 5034.8 10413.7 10616.9 10630.4 10659.5 10661.1 5485.8 5531.8 5538.0 5629.3 5694.7 4556.0 4966.3 5026.7 5077.7 5108.2 4235.8 4240.6 4271.5 4276.5 4295.4 1269.2 1345.8 1379.4 1407.4 1410.9 823.3 884.6 902.8 913.5 973.7 6143.1 6152.2 6153.2 6234.4 6304.8 769.9 948.5 998.9 1018.0 1044.3 3950.0 4016.5 4025.5 4089.1 4143.9 10829.5 10872.0 10962.1 11211.3 11268.7 10894.5 10941.9 11007.3 11082.0 11240.1 8251.0 8448.3 8487.8 8646.4 8722.3 5215.8 5908.2 5965.8 6057.6 6172.0 9713.6 9813.9 10043.2 10155.3 10292.0 10026.1 10099.8 10242.7 10456.9 10499.6 6663.6 7317.2 7329.9 8225.1 8471.3 8427.6 8530.6 8532.7 8562.4 8564.4 7466.2 7466.9 7703.4 7717.2 7745.7 7435.3 7472.2 7500.5 7610.2 7632.1 6069.6 6098.6 7198.8 7208.5 7281.9 4956.7 4999.5 5012.5 5142.9 5152.9 5085.4 5104.6 5116.7 5167.1 5322.6 14:34:18 INFO - PROCESS | 1661 | 14:34:18 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:6140.28 Median:6967.33 stddev:1963.87 (28.2%) stddev-sans-first:1919.76 14:34:18 INFO - PROCESS | 1661 | Values: 295.8 339.6 342.5 346.4 353.3 6941.6 7012.9 7013.3 7028.7 7043.9 6937.0 7008.1 7023.4 7040.6 7055.7 4944.3 5046.4 5205.2 5207.8 5218.3 5141.2 5218.9 5219.0 5226.3 5238.8 5152.1 5154.7 5160.9 5163.0 5167.5 5154.9 5180.0 5188.7 5194.9 5198.2 4429.1 4429.4 4430.7 4444.2 4451.0 6606.6 6756.8 6798.0 6808.6 6815.6 6020.1 6056.6 6069.8 6079.4 6093.2 6463.2 7527.1 7528.4 7530.3 7558.3 4689.7 4929.0 4931.7 4936.3 4940.6 7130.9 7137.5 7851.3 7933.8 7957.7 4933.6 5045.1 5045.7 5045.9 5050.8 4260.4 5097.7 5143.5 5153.0 5341.0 5929.9 6006.0 6020.2 6036.4 6041.9 6314.5 7526.1 7542.7 7575.2 7580.5 1709.2 1727.6 1751.8 1803.4 1803.9 1031.0 1064.7 1095.1 1115.4 1141.5 6952.9 6965.8 6979.7 6988.9 6998.7 7690.7 7708.1 7713.6 7717.2 7717.6 6968.9 6975.7 6986.8 6995.3 7001.5 3998.8 4056.7 4111.9 4115.2 4123.0 6527.9 8153.8 8181.4 8209.6 8219.8 8015.2 8045.1 8048.6 8106.4 8144.8 8265.3 8274.3 8280.4 8321.7 8325.2 6312.9 7659.3 7841.8 7920.6 7972.8 6840.5 7153.9 7691.6 7760.7 7784.6 8221.3 8286.5 8287.0 8311.0 8338.7 4614.2 4925.2 4929.3 4936.4 4947.1 6324.8 7638.2 7799.9 7910.8 7926.1 7548.9 7558.7 7560.8 7588.4 7597.2 6083.9 7533.5 7584.1 7608.3 7618.5 7127.3 7347.9 7356.3 7368.0 7382.6 7521.2 7579.7 7584.8 7586.5 7597.0 7325.0 7353.3 7379.8 7391.4 7413.5 14:34:18 INFO - PROCESS | 1661 | 14:34:18 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:18330.68 Median:65318.67 stddev:26068.48 (39.9%) stddev-sans-first:26107.93 14:34:18 INFO - PROCESS | 1661 | Values: 681.8 715.2 757.2 777.7 790.8 15351.2 15518.6 15663.5 15678.0 15719.4 13881.9 14288.2 14382.2 14407.6 14492.4 843.5 925.1 938.6 943.8 945.2 895.5 944.2 952.8 958.4 961.0 959.6 993.3 997.9 999.9 1000.8 838.8 960.7 962.9 969.0 998.2 700.0 730.7 753.6 755.3 756.9 13297.9 13401.9 13603.9 13645.6 13716.4 11425.2 11665.6 11828.0 12352.4 12476.7 9151.0 11089.9 11180.9 11499.7 11551.8 3421.8 3482.6 3532.3 3559.3 3610.0 76560.0 79496.2 81647.8 84657.3 88301.0 9631.5 9636.6 9731.1 9780.1 9844.3 20658.0 21362.4 21409.3 21629.9 21663.4 7595.5 7641.2 7663.7 7734.7 7902.4 4132.3 4199.5 4215.2 4230.5 4231.2 3186.8 3696.0 3719.1 3763.6 3767.8 672.9 676.4 681.2 688.1 693.4 499.8 545.8 574.8 621.3 622.8 7736.0 8030.3 8193.8 8203.3 8258.4 563.9 584.1 589.4 593.4 628.3 3844.7 3874.5 3995.0 4014.9 4031.8 95998.0 98366.0 98996.5 99396.0 100179.0 64209.7 70211.6 71255.9 71878.3 80526.0 66427.7 70669.0 70846.0 74977.0 76131.5 8353.7 8356.3 8413.3 8430.0 8716.5 39179.8 47683.0 49565.5 49914.8 50600.5 68356.0 69154.7 69407.7 69983.0 71078.0 10889.8 10963.6 11145.4 11304.4 11509.7 9581.9 10096.1 11522.0 12019.5 12082.5 11109.4 11237.6 11239.9 11367.2 11668.8 10142.9 10913.8 11174.0 11248.3 11636.8 7785.3 10847.0 11227.6 11292.7 11310.7 9639.0 9719.5 9859.7 9901.6 9999.0 9718.5 9826.6 9877.0 9981.7 10031.3 14:34:18 INFO - PROCESS | 1661 | -------- Summary: end -------- 14:34:18 INFO - PROCESS | 1661 | 14:34:19 INFO - TEST-INFO | 1661: exit 0 14:34:19 INFO - TEST-OK | dromaeo_css | took 1110173ms 14:34:19 INFO - TEST-START | kraken 14:34:19 INFO - operating with platform_type : mac_ 14:34:19 INFO - Initialising browser for kraken test... 14:34:19 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpadTQdh/profile http://localhost:49278/getInfo.html) 14:34:21 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 14:34:21 INFO - PROCESS | 1674 | colorDepth:24 14:34:21 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 14:34:21 INFO - PROCESS | 1674 | __metrics 14:34:21 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 14:34:22 INFO - TEST-INFO | 1674: exit 0 14:34:22 INFO - Browser initialized. 14:34:22 INFO - Running cycle 1/1 for kraken test... 14:34:22 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpadTQdh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:34:34 INFO - PROCESS | 1678 | RSS: Main: 170987520 14:34:34 INFO - PROCESS | 1678 | 14:34:37 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 14:34:37 INFO - PROCESS | 1678 | RSS: Main: 183742464 14:34:37 INFO - PROCESS | 1678 | 14:34:40 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 14:34:41 INFO - PROCESS | 1678 | RSS: Main: 192516096 14:34:41 INFO - PROCESS | 1678 | 14:34:44 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 14:34:45 INFO - PROCESS | 1678 | RSS: Main: 195989504 14:34:45 INFO - PROCESS | 1678 | 14:34:47 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 14:34:47 INFO - PROCESS | 1678 | RSS: Main: 196255744 14:34:47 INFO - PROCESS | 1678 | 14:34:49 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:34:50 INFO - PROCESS | 1678 | RSS: Main: 197906432 14:34:50 INFO - PROCESS | 1678 | 14:34:53 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 14:34:53 INFO - PROCESS | 1678 | RSS: Main: 198885376 14:34:53 INFO - PROCESS | 1678 | 14:34:56 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 14:34:57 INFO - PROCESS | 1678 | RSS: Main: 198565888 14:34:57 INFO - PROCESS | 1678 | 14:35:00 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 14:35:00 INFO - PROCESS | 1678 | RSS: Main: 198643712 14:35:00 INFO - PROCESS | 1678 | 14:35:02 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:35:02 INFO - PROCESS | 1678 | RSS: Main: 197636096 14:35:02 INFO - PROCESS | 1678 | 14:35:04 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:35:05 INFO - PROCESS | 1678 | RSS: Main: 197890048 14:35:05 INFO - PROCESS | 1678 | 14:35:07 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:35:08 INFO - PROCESS | 1678 | RSS: Main: 198135808 14:35:08 INFO - PROCESS | 1678 | 14:35:10 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:35:11 INFO - PROCESS | 1678 | RSS: Main: 198455296 14:35:11 INFO - PROCESS | 1678 | 14:35:13 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:35:14 INFO - PROCESS | 1678 | RSS: Main: 198320128 14:35:14 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 14:35:16 INFO - PROCESS | 1678 | RSS: Main: 200314880 14:35:16 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | __start_tp_report 14:35:16 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 14:35:16 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 14:35:16 INFO - PROCESS | 1678 | |i|pagename|runs| 14:35:16 INFO - PROCESS | 1678 | |0;ai-astar;117;114;117;117;116;132;117;96;168;176 14:35:16 INFO - PROCESS | 1678 | |1;audio-beat-detection;159;151;158;158;119;136;118;160;185;157 14:35:16 INFO - PROCESS | 1678 | |2;audio-dft;198;198;197;200;195;194;196;198;194;195 14:35:16 INFO - PROCESS | 1678 | |3;audio-fft;94;107;96;139;57;58;58;69;145;74 14:35:16 INFO - PROCESS | 1678 | |4;audio-oscillator;77;81;123;77;79;80;112;79;78;118 14:35:16 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;88;85;88;86;101;116;91;86;89;89 14:35:16 INFO - PROCESS | 1678 | |6;imaging-darkroom;96;95;96;92;95;95;96;95;95;120 14:35:16 INFO - PROCESS | 1678 | |7;imaging-desaturate;90;92;92;90;91;135;150;89;91;92 14:35:16 INFO - PROCESS | 1678 | |8;json-parse-financial;60;63;65;64;64;65;63;80;63;59 14:35:16 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;61;65;59;67;69;72;65;65;63;65 14:35:16 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;82;80;82;84;82;80;80;82;84;82 14:35:16 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;127;130;126;123;132;147;126;125;144;139 14:35:16 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;166;170;162;165;170;162;164;166;163;161 14:35:16 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;64;64;70;70;69;68;68;66;70;65 14:35:16 INFO - PROCESS | 1678 | __end_tp_report 14:35:16 INFO - PROCESS | 1678 | __start_cc_report 14:35:16 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1040 14:35:16 INFO - PROCESS | 1678 | __end_cc_report 14:35:16 INFO - PROCESS | 1678 | __startTimestamp1467322516493__endTimestamp 14:35:16 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | ------- Summary: start ------- 14:35:16 INFO - PROCESS | 1678 | Number of tests: 14 14:35:16 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:127.00 Median:124.50 stddev:25.29 (20.3%) stddev-sans-first:26.57 14:35:16 INFO - PROCESS | 1678 | Values: 117.0 114.0 117.0 117.0 116.0 132.0 117.0 96.0 168.0 176.0 14:35:16 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:158.00 stddev:20.45 (12.9%) stddev-sans-first:21.44 14:35:16 INFO - PROCESS | 1678 | Values: 159.0 151.0 158.0 158.0 119.0 136.0 118.0 160.0 185.0 157.0 14:35:16 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:196.50 Median:197.50 stddev:2.01 (1.0%) stddev-sans-first:2.06 14:35:16 INFO - PROCESS | 1678 | Values: 198.0 198.0 197.0 200.0 195.0 194.0 196.0 198.0 194.0 195.0 14:35:16 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:89.70 Median:63.50 stddev:32.66 (51.4%) stddev-sans-first:34.60 14:35:16 INFO - PROCESS | 1678 | Values: 94.0 107.0 96.0 139.0 57.0 58.0 58.0 69.0 145.0 74.0 14:35:16 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:78.50 stddev:19.03 (24.2%) stddev-sans-first:19.56 14:35:16 INFO - PROCESS | 1678 | Values: 77.0 81.0 123.0 77.0 79.0 80.0 112.0 79.0 78.0 118.0 14:35:16 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:91.90 Median:88.00 stddev:9.60 (10.9%) stddev-sans-first:10.07 14:35:16 INFO - PROCESS | 1678 | Values: 88.0 85.0 88.0 86.0 101.0 116.0 91.0 86.0 89.0 89.0 14:35:16 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:97.50 Median:95.00 stddev:7.99 (8.4%) stddev-sans-first:8.46 14:35:16 INFO - PROCESS | 1678 | Values: 96.0 95.0 96.0 92.0 95.0 95.0 96.0 95.0 95.0 120.0 14:35:16 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:101.20 Median:91.00 stddev:22.07 (24.3%) stddev-sans-first:23.04 14:35:16 INFO - PROCESS | 1678 | Values: 90.0 92.0 92.0 90.0 91.0 135.0 150.0 89.0 91.0 92.0 14:35:16 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.00 stddev:5.76 (9.0%) stddev-sans-first:5.86 14:35:16 INFO - PROCESS | 1678 | Values: 60.0 63.0 65.0 64.0 64.0 65.0 63.0 80.0 63.0 59.0 14:35:16 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:3.73 (5.7%) stddev-sans-first:3.64 14:35:16 INFO - PROCESS | 1678 | Values: 61.0 65.0 59.0 67.0 69.0 72.0 65.0 65.0 63.0 65.0 14:35:16 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:1.48 (1.8%) stddev-sans-first:1.56 14:35:16 INFO - PROCESS | 1678 | Values: 82.0 80.0 82.0 84.0 82.0 80.0 80.0 82.0 84.0 82.0 14:35:16 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:131.00 stddev:8.49 (6.5%) stddev-sans-first:8.82 14:35:16 INFO - PROCESS | 1678 | Values: 127.0 130.0 126.0 123.0 132.0 147.0 126.0 125.0 144.0 139.0 14:35:16 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.90 Median:165.50 stddev:3.18 (1.9%) stddev-sans-first:3.35 14:35:16 INFO - PROCESS | 1678 | Values: 166.0 170.0 162.0 165.0 170.0 162.0 164.0 166.0 163.0 161.0 14:35:16 INFO - PROCESS | 1678 | 14:35:16 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.50 stddev:2.46 (3.6%) stddev-sans-first:2.28 14:35:16 INFO - PROCESS | 1678 | Values: 64.0 64.0 70.0 70.0 69.0 68.0 68.0 66.0 70.0 65.0 14:35:16 INFO - PROCESS | 1678 | -------- Summary: end -------- 14:35:16 INFO - PROCESS | 1678 | 14:35:17 INFO - TEST-INFO | 1678: exit 0 14:35:17 INFO - TEST-OK | kraken | took 58114ms 14:35:17 INFO - SUITE-END | took 1168s 14:35:17 INFO - Completed test suite (00:19:28) 14:35:17 INFO - javascript benchmark 14:35:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3031.8029328093676, 3656.213914008488, 3698.9075273118187, 3721.3487639663053, 3726.441033844924, 5582.944170558293, 5783.98780213462, 5812.564057695668, 6000.039993601019, 6033.698315084239, 4691.695039822409, 5849.2980842298875, 5958.49352805011, 5994.250718660168, 6062.272527296731, 4493.595576398124, 4956.7769450374635, 5448.346198456171, 5465.398806131322, 5470.234167216593, 5366.087765079946, 5435.2934118564535, 5450.427705090968, 5518.365387980373, 5562.666240025591, 5479.123340265558, 5494.752736126864, 5510.669359838423, 5515.586331025189, 5525.723713814314, 4303.182395344875, 5275.446078161776, 5422.701751403672, 5435.701036442994, 5498.395176530578, 5317.946820531823, 5343.251944727741, 5367.141257398836, 5369.5972802040005, 5430.864228394283, 5674.773009079632, 5806.1000544915605, 5809.2738407699035, 5862.912056319158, 5872.882542349129, 6194.25668919728, 6201.534884883652, 6261.812145635638, 6292.2134733158355, 6298.433141017331, 6243.125962365272, 6280.905786413207, 6290.276618188921, 6300.621962682254, 6325.778597749057, 5856.941430585683, 5884.58807883444, 5902.114682797572, 5935.0, 5943.910841337383, 5305.336832895888, 6313.779017734358, 6335.334789847092, 6362.713677884506, 6372.044193370939, 6304.0, 6323.399277068671, 6332.430081292706, 6344.49244060474, 6348.301686814447, 6347.270063942613, 6349.238091428966, 6352.333005034498, 6359.459445947054, 6372.330905254974, 6119.472088496329, 6249.937500625027, 6291.056341548804, 6297.685115744194, 6312.905306420407, 5324.41431442541, 6272.686365681698, 6286.277078136073, 6298.401651843067, 6300.59046161998, 4972.105021096238, 5063.924041139386, 5077.619178561623, 5078.771455284447, 5083.135866902636, 4096.91806163875, 4475.731456112644, 4535.274356103074, 4566.4063671723125, 4849.563539281482, 4376.7811609419405, 5997.610155339889, 6056.788012419544, 6060.787872424444, 6081.391860813972, 5362.329708786402, 5605.80379686709, 6303.401176888188, 6309.62142271456, 6341.746330146742, 5845.064789633723, 5999.850003749942, 6045.455908968214, 6069.605475644069, 6085.786997455068, 5523.475269849358, 5545.279113715191, 5557.221988921554, 5566.666000040011, 5573.972130139405, 6568.277489476058, 6577.243616984012, 6579.1447111874195, 6588.505862060365, 6589.077529145923, 6222.128901953821, 6248.937510624835, 6287.842803929939, 6328.683565821782, 6350.428461438492, 6531.9020214695865, 6560.409563139149, 6572.539922205591, 6615.834604134935, 6712.228093769084, 6200.193974783249, 6227.844303892439, 6323.715432805627, 6324.177856878577, 6324.747010119728, 6241.812745617639, 6248.12526246335, 6259.874802504016, 6283.685815709105, 6304.810855674154, 6245.96877015612, 6250.499960003098, 6266.091416744638, 6280.9685951569945, 6283.74865005413, 6238.0, 6242.1261023455845, 6285.811425657238, 6302.054691796267, 6309.179806625109, 4655.9301610475195, 6116.8836339025665, 6209.472194863487, 6228.875422491616, 6249.406306400884, 5145.742712864267, 6292.276388215414, 6297.842553936188, 6310.52671049664, 6335.461485773577, 6080.118382834376, 6130.184124957687, 6197.03945888388, 6208.4722798562625, 6235.906461402992], "value": 5802.816062292962, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.627044204278, 540.370468404309, 574.7126436781609, 581.3779256195869, 589.2075158911264, 32149.67850321499, 41266.79366603171, 41306.0, 41334.7933260334, 41357.759267221954, 42340.0, 42361.364579531335, 42885.57114428855, 42900.57099429005, 43009.0, 9555.904440955588, 9637.90362096377, 9707.514624268793, 9768.413895166314, 9806.656767013155, 9635.903640963606, 9759.707208783713, 9784.21726261901, 9795.0, 9842.655507057254, 9826.606935722562, 9843.360181588174, 9882.962288959663, 9899.010098990115, 9911.553980070878, 9810.754731131707, 9847.90152098477, 9868.654597089138, 9873.753156171082, 9906.009399060109, 9734.318597698164, 9841.409515429097, 9850.60597576096, 9850.704478865646, 9865.753356166082, 40738.0, 40752.79623601893, 41404.964875878046, 41479.58520414818, 41480.962975925846, 3308.040668206217, 3332.6500717424806, 3349.7822641528464, 3490.9127271818406, 3496.5454490916272, 27691.307717307027, 27897.442051159065, 27961.300967475774, 29087.41825163506, 29686.851565742032, 2757.7793776497833, 2782.4713304472084, 2822.252103192656, 2823.774098072149, 2835.702251263608, 335096.0, 338116.0, 338414.0, 341360.0, 342599.28700356587, 37759.62240377616, 38682.80658596745, 65717.0, 66082.33917660858, 66131.0, 36212.0, 37184.814075929986, 37435.81282093626, 37509.81245093757, 37679.0, 16230.350785968665, 16354.10052447103, 16390.67218655644, 16432.424865129662, 16454.0, 12724.618261452171, 13073.346332683328, 13108.147970381895, 13147.53983610569, 13170.47318107265, 8184.427090103635, 8258.25675689191, 8505.489670619783, 8554.272886804567, 8624.784380390414, 3085.41377138343, 3533.452314891196, 3544.7873127612424, 3574.267275208576, 3578.302231064917, 997.4514017290461, 1038.6105210546045, 1047.2667734898603, 1077.6120596585224, 1202.5490441084594, 24880.0, 30687.0, 31052.68947310498, 31434.68565314363, 32224.38878056135, 1156.7281688803125, 1164.6331405607207, 1200.5857978997233, 1246.2584762066738, 1274.5973839312962, 15902.966307189996, 16087.597810054609, 16100.838991610168, 16219.756703649455, 16297.59256018609, 619141.0, 619143.9042804848, 627017.0, 629216.8539157367, 629774.0, 64138.0, 64220.0, 64351.35648643454, 64942.35057649457, 65193.0, 1362.7819548872133, 1495.274791726012, 1527.5341020988706, 1537.3927298717167, 1555.4633651390252, 30837.383252334377, 30854.382912342076, 30954.833161678467, 31611.0, 32303.51544726784, 54029.729851352065, 55127.0, 55604.16593751016, 55758.442415576945, 55949.72025139848, 546824.265878668, 547748.0, 550927.0, 551055.0, 552475.0, 26087.869560652074, 27436.0, 27486.0, 27544.58683119795, 27971.0, 47461.7626911877, 48069.75965120152, 48839.267410988155, 49352.75323623359, 49367.753161233966, 31883.52174717335, 32601.18497037593, 39920.80039599783, 39968.60031399649, 40312.39531406973, 31772.0, 38685.419718704805, 39275.41086883756, 39594.80202599084, 39870.0, 39620.405693914036, 39759.80120099381, 40771.0, 40834.79582602068, 40955.795221023705, 25239.61182135, 26211.73788262093, 31025.534616981215, 31949.0, 32869.17827054343, 18738.906305468387, 23975.640365394185, 23986.760132398453, 25168.74831251664, 25235.621465678396], "value": 18825.55748204624, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.3808534959991, 416.79368712487303, 419.86354434808686, 419.9370094485825, 430.0796295926717, 18048.368307109253, 20554.280600178998, 21227.0, 21237.893810530946, 21455.249066282682, 20113.0, 20143.89208593527, 20936.47658808527, 22831.08675652976, 22895.31314060581, 5332.680039197641, 5855.151003104558, 5984.640921544721, 6183.350748171445, 6188.319284878659, 5971.164037034797, 5985.88028239435, 6038.0942858571125, 6117.2659280886355, 6158.56890017699, 5826.650400975934, 5956.821295361146, 6118.204633397652, 6130.417610327012, 6130.785422510213, 5941.197938278342, 5970.701464926737, 6041.607295525799, 6094.116353128771, 6141.416565426277, 4383.780810959439, 5251.579873610102, 5613.624661957806, 5907.1434641976675, 5999.100134979788, 13722.970777191751, 15201.771973420296, 24826.751732482626, 25221.873890630613, 25607.871960640077, 2093.4033800366824, 2162.610730068587, 2167.794059564339, 2379.9643005354933, 2664.227374061539, 9614.855777163348, 9975.301728878982, 10051.396916185053, 10251.0, 10473.319234249826, 1650.4718490083058, 1811.194018661696, 1827.570520927581, 1878.3989123480492, 1912.4549503391606, 110660.89339106587, 112231.43884280608, 115176.0, 115963.0, 116779.0, 11669.76660466803, 11820.349880756641, 11901.940490297666, 11984.041276697842, 12034.939825300817, 12344.75310493803, 14716.484923027643, 15145.62135946588, 15486.922565387102, 15493.612659683373, 8978.775530611656, 9142.268618510503, 9258.009527951388, 9292.581833817494, 9363.953180234055, 9121.67735678323, 9293.814123717488, 9355.906440935503, 9384.67153649619, 9434.811303773886, 3945.6646185074014, 4723.362346083303, 4760.309755085494, 4783.784729687172, 4848.248521479177, 2029.3506078055175, 2121.915123395047, 2122.734658167729, 2149.1946764717713, 2167.8048975592274, 970.6117552978865, 983.6655537117272, 1067.631667074858, 1069.5294070608907, 1078.4661592511757, 20087.0, 20574.0, 20676.966151692355, 21259.0, 21298.148074076864, 1006.1799633298838, 1035.2597892506894, 1037.4913913978305, 1048.6853943816825, 1079.5142186016324, 10857.185711071701, 11027.779444411068, 11032.724181895357, 11046.33721976684, 11046.392448415414, 621966.0, 634499.0, 640283.0, 645633.0, 646479.0, 85270.29459410776, 113288.30067548994, 122465.0, 123738.0, 125147.0, 1032.3341444768082, 1033.6975410982366, 1035.808375450529, 1055.0873494427265, 1076.6178006807627, 16298.674026519166, 16950.321987120376, 17082.82917170862, 18604.627907442045, 18624.348147814762, 36792.113261877974, 42502.362464563674, 49029.26456103232, 49373.0, 50321.49678503168, 69622.30377696158, 72280.63859680668, 74411.0, 75305.0, 76182.6190869042, 6586.979018252178, 8153.8369232616205, 8215.219554142346, 8305.875411868707, 8480.024797148408, 10700.785984280115, 11699.415029248674, 12150.878491214975, 12356.3821808911, 12654.240745555297, 10762.192835537522, 10795.892041079489, 10839.295445795999, 10905.454727263765, 10970.0, 9828.213742900407, 10078.445685487368, 10574.788504230026, 10615.256932014685, 10984.06635435965, 10677.94661026721, 11003.559857605605, 11241.38172400493, 11251.156163287622, 11289.7742045157, 7074.842173137243, 8115.391345648982, 8226.506409615442, 8274.627641756015, 8285.80426187049, 9513.809723805623, 10928.672139835817, 10957.780844383227, 10959.397233152253, 11072.612458563912], "value": 9575.689600158068, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1648.472488803583, 1677.2787701288446, 1960.1571324330541, 2004.9699254511186, 2117.9258725944596, 8156.143604921472, 8862.246709029723, 8933.597988090536, 9147.542622868856, 9172.587233574488, 8899.644014239422, 8937.776555586113, 9039.141281578239, 9074.954625226881, 9115.68095116671, 2511.4977004599064, 2511.7362676918933, 2527.3302574817735, 2551.706553746315, 2555.718870924197, 2494.2267896952003, 2513.5349960257317, 2516.4086439686657, 2527.4818662174303, 2554.476332351863, 2513.3465299022296, 2521.596544552872, 2531.632913227581, 2532.3795670060863, 2567.935801604956, 2189.2228258968, 2479.0703486192588, 2510.159096702607, 2539.5809691400896, 2551.2983929419374, 2109.9367018989456, 2513.987430062856, 2533.0121252711456, 2545.083769842855, 2547.5669136246884, 9144.679936202267, 9164.175224229852, 9167.587458564314, 9198.954005229998, 9209.723708288695, 5526.0, 5608.186812912105, 5678.261825962599, 5724.284464441945, 5832.533397328203, 3619.348517266891, 3697.611750766158, 3707.7775333480076, 3755.6995440364976, 3767.7174211934216, 1057.5716834681966, 1080.1089101491302, 1081.7187531241934, 1081.7343707861821, 1084.322298563398, 12085.939570302093, 12119.93940030303, 12428.937855310665, 12434.689132771662, 12449.190802597803, 4885.193942999436, 4921.360223170965, 4957.677750946177, 4974.701517908937, 5034.8237811677145, 10413.687589372332, 10616.946915265375, 10630.415327157081, 10659.520321585547, 10661.147108231324, 5485.753141108659, 5531.778728850801, 5538.0, 5629.268195134607, 5694.686792226385, 4556.043230921544, 4966.304717339575, 5026.723530205873, 5077.720725360066, 5108.208227724708, 4235.8093885775215, 4240.575942405796, 4271.526323418416, 4276.486821581368, 4295.420118284054, 1269.2447993443886, 1345.7779466388133, 1379.4137491566044, 1407.429990853706, 1410.9365078571489, 823.2878560045517, 884.6107712606432, 902.8149229407956, 913.4610579757974, 973.6689525561343, 6143.078538219303, 6152.230971128609, 6153.2000839890525, 6234.407731265523, 6304.8423789404715, 769.926856948589, 948.5257371314343, 998.9200863931013, 1018.0379541333369, 1044.2742294105524, 3950.0, 4016.5380981187536, 4025.4766880305374, 4089.1208390196252, 4143.8964025899595, 10829.512671929624, 10872.0, 10962.123030157569, 11211.271267367758, 11268.661940141808, 10894.509747061402, 10941.945290273497, 11007.284526505751, 11082.0, 11240.100791936626, 8251.0, 8448.281896038905, 8487.830243395098, 8646.351523635753, 8722.34582406322, 5215.843524694265, 5908.202392676933, 5965.791197308074, 6057.575969682256, 6171.981623032149, 9713.56288966984, 9813.85279220798, 10043.246756493147, 10155.289129760846, 10292.0, 10026.097651211427, 10099.848502272618, 10242.692719218436, 10456.947715261374, 10499.580016799242, 6663.566868153554, 7317.195108538163, 7329.9267007329245, 8225.054118776177, 8471.279941205066, 8427.5786210688, 8530.573471326285, 8532.658693652433, 8562.357823163164, 8564.400491965502, 7466.216047314953, 7466.887996679946, 7703.383729301754, 7717.1896950819355, 7745.728899488491, 7435.293647103516, 7472.215417381314, 7500.549967001997, 7610.238976102345, 7632.122305934889, 6069.635821850703, 6098.634081955097, 7198.7840364789145, 7208.531445456028, 7281.854362912818, 4956.727379994135, 4999.525045120708, 5012.47369026247, 5142.922856157235, 5152.896942061213, 5085.4406015337545, 5104.642675012714, 5116.7441627917715, 5167.121589329748, 5322.627416080992], "value": 4775.3852358765325, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.7545237452914, 339.6094491334963, 342.46746309488736, 346.4422280128992, 353.27049642488277, 6941.618210998393, 7012.929870701291, 7013.3337332953415, 7028.718851245951, 7043.859122817541, 6936.965315173417, 7008.088948436696, 7023.40301074408, 7040.6127662978515, 7055.717771289155, 4944.283078953549, 5046.419661738892, 5205.16717325228, 5207.791688332462, 5218.347706536683, 5141.228815677659, 5218.8695282617855, 5218.973905130469, 5226.294450249225, 5238.842834714965, 5152.098382783017, 5154.716490593016, 5160.896782064357, 5163.044836705221, 5167.509086636764, 5154.896902061956, 5180.0, 5188.688678679272, 5194.92207616886, 5198.194279886624, 4429.069895321986, 4429.357743127229, 4430.715092623168, 4444.2222611042935, 4451.043025749447, 6606.60360378374, 6756.797296081077, 6797.966010169967, 6808.557443766139, 6815.625140617264, 6020.066889632114, 6056.576039677225, 6069.848253793646, 6079.422454866781, 6093.177421048191, 6463.192100987377, 7527.134379546367, 7528.397728181732, 7530.28462296081, 7558.281963213486, 4689.718616882998, 4929.0, 4931.728754918478, 4936.333594964705, 4940.580050695695, 7130.893036604455, 7137.464690148259, 7851.293383595446, 7933.761987140338, 7957.721479748239, 4933.6299777516115, 5045.091883461012, 5045.697258164522, 5045.8738531537, 5050.823221187241, 4260.360945858084, 5097.668651537638, 5143.485651434901, 5152.995165942605, 5340.985212809632, 5929.902967950943, 6006.039033754579, 6020.157177995085, 6036.396360363929, 6041.909371359433, 6314.463270621956, 7526.059242594676, 7542.736004239825, 7575.166731659513, 7580.507267027626, 1709.1710520397596, 1727.5940154063785, 1751.798543167552, 1803.386848471526, 1803.9368622098164, 1030.9587316810075, 1064.7391389109562, 1095.085603521053, 1115.3530952047954, 1141.5319718915205, 6952.895706564405, 6965.756198533129, 6979.720811167598, 6988.8951665724035, 6998.68505917235, 7690.653920573475, 7708.113566939762, 7713.614319284014, 7717.22827717235, 7717.57553334572, 6968.895466568006, 6975.651217439107, 6986.755463558751, 6995.26549712283, 7001.544899581511, 3998.8000599969887, 4056.6815784869445, 4111.9177616447505, 4115.156392939441, 4123.010477485382, 6527.8694426111215, 8153.836923261501, 8181.427300088937, 8209.630566624517, 8219.83560328802, 8015.238552337519, 8045.115037345888, 8048.557329346942, 8106.432549721463, 8144.75565733029, 8265.297449716842, 8274.338052955749, 8280.378971577156, 8321.66713331472, 8325.209105135002, 6312.936870631235, 7659.310662040443, 7841.764747057598, 7920.643571039202, 7972.760817175494, 6840.48696347766, 7153.892691609526, 7691.5769632670745, 7760.68957241704, 7784.610769461391, 8221.260086592236, 8286.46138001028, 8287.0, 8311.002679678477, 8338.749837504885, 4614.238650622609, 4925.187344088328, 4929.274753836129, 4936.3829521309835, 4947.084789313988, 6324.810255692337, 7638.197989211053, 7799.9220007799195, 7910.841783164189, 7926.088499822594, 7548.905408715816, 7558.735444259424, 7560.848783024198, 7588.430867684835, 7597.240275972579, 6083.878322433615, 7533.54798712079, 7584.12782529994, 7608.31525162738, 7618.504797188165, 7127.287271272831, 7347.889781653173, 7356.264373562601, 7367.963160184165, 7382.630868456663, 7521.210272921265, 7579.734709285149, 7584.772456826304, 7586.506877053194, 7597.0, 7325.01112349826, 7353.338199562065, 7379.8155046124275, 7391.40868730511, 7413.518121322097], "value": 5475.201575471985, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.8056853796669, 715.1596873673434, 757.1973707869655, 777.7316825695135, 790.7825348029291, 15351.232438378092, 15518.612034699125, 15663.451779187744, 15678.0, 15719.449819256328, 13881.93059034706, 14288.214148221843, 14382.208978506178, 14407.567772966802, 14492.420303187886, 843.4939036578065, 925.0518218825707, 938.6198589571235, 943.7687766497218, 945.2013048973606, 895.494045864088, 944.1927152284801, 952.8237276103908, 958.4488918871642, 961.0, 959.649727849337, 993.3344659078434, 997.9051990060968, 999.9050090241416, 1000.8448690452991, 838.8364268967554, 960.7117864640614, 962.9133377995979, 969.0406497567358, 998.241336584194, 700.0304578159236, 730.6565914020401, 753.5930597477355, 755.3353049316621, 756.9280918312752, 13297.86702132976, 13401.86598134016, 13603.86396136036, 13645.590632281048, 13716.3827627756, 11425.200235983484, 11665.591704290395, 11828.0, 12352.38238088092, 12476.688082797911, 9150.954245228731, 11089.889101108967, 11180.944095279552, 11499.716584293838, 11551.768964620745, 3421.8118003510044, 3482.564679415073, 3532.275883443888, 3559.288142371536, 3610.0, 76560.0, 79496.20503794946, 81647.7752833708, 84657.30685386258, 88301.0, 9631.470269135265, 9636.614535418645, 9731.075547822946, 9780.070893265129, 9844.310898237054, 20658.0, 21362.359129226148, 21409.250676226256, 21629.891850540647, 21663.35009949704, 7595.468317217742, 7641.159472458025, 7663.655135518804, 7734.651940662684, 7902.446828721934, 4132.33882578792, 4199.538050814408, 4215.156968606291, 4230.534641189467, 4231.217224813419, 3186.8247246401206, 3696.0, 3719.1445967427103, 3763.5671897731563, 3767.811609419518, 672.9334005601177, 676.3608390071433, 681.2438193605094, 688.0745397440435, 693.3551796828998, 499.7950840155519, 545.8226076525145, 574.764346617893, 621.2575971713759, 622.8256088295285, 7735.9613201933635, 8030.277275045274, 8193.79515512117, 8203.30271926893, 8258.380621453414, 563.9041362968305, 584.1442287049493, 589.3958692340385, 593.4391999560374, 628.2994461175756, 3844.692424606025, 3874.4769456123627, 3995.0212198011673, 4014.9197016059516, 4031.7580945143386, 95998.0, 98366.0, 98996.50501747445, 99396.0, 100178.99821001843, 64209.67895160494, 70211.59576808436, 71255.93116103263, 71878.28121718716, 80526.0, 66427.66786166135, 70669.0, 70846.0, 74977.0, 76131.47737045339, 8353.707620233263, 8356.289715374018, 8413.284870786052, 8429.957850210709, 8716.520591367282, 39179.804100979316, 47683.0, 49565.50434495609, 49914.750426247636, 50600.48198554049, 68356.0, 69154.65422672854, 69407.65296173487, 69983.0, 71078.0, 10889.782204356026, 10963.56145754161, 11145.442727863412, 11304.43477826089, 11509.654710358367, 9581.904180958101, 10096.141827944706, 11522.020628246693, 12019.459124339252, 12082.45628946717, 11109.388983605655, 11237.55049797999, 11239.943800280946, 11367.20429569922, 11668.766624667629, 10142.898571014195, 10913.781724365626, 11174.0, 11248.26886252391, 11636.767264654829, 7785.338246248905, 10847.0, 11227.55089796399, 11292.661220163409, 11310.660680179608, 9639.0, 9719.514024298898, 9859.704208873745, 9901.603935842773, 9999.0, 9718.514074296398, 9826.606935722491, 9877.012298770065, 9981.700548983543, 10031.29780915358], "value": 6949.908573391593, "unit": "score"}], "name": "dromaeo_css", "value": 7582.797344876034, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 117.0, 117.0, 116.0, 132.0, 117.0, 96.0, 168.0, 176.0], "value": 127.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 151.0, 158.0, 158.0, 119.0, 136.0, 118.0, 160.0, 185.0, 157.0], "value": 150.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 198.0, 197.0, 200.0, 195.0, 194.0, 196.0, 198.0, 194.0, 195.0], "value": 196.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 107.0, 96.0, 139.0, 57.0, 58.0, 58.0, 69.0, 145.0, 74.0], "value": 89.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 123.0, 77.0, 79.0, 80.0, 112.0, 79.0, 78.0, 118.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 86.0, 101.0, 116.0, 91.0, 86.0, 89.0, 89.0], "value": 91.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 92.0, 95.0, 95.0, 96.0, 95.0, 95.0, 120.0], "value": 97.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 92.0, 90.0, 91.0, 135.0, 150.0, 89.0, 91.0, 92.0], "value": 101.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 65.0, 64.0, 64.0, 65.0, 63.0, 80.0, 63.0, 59.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 59.0, 67.0, 69.0, 72.0, 65.0, 65.0, 63.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 82.0, 84.0, 82.0, 80.0, 80.0, 82.0, 84.0, 82.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 130.0, 126.0, 123.0, 132.0, 147.0, 126.0, 125.0, 144.0, 139.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 162.0, 165.0, 170.0, 162.0, 164.0, 166.0, 163.0, 161.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 70.0, 70.0, 69.0, 68.0, 68.0, 66.0, 70.0, 65.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1520.0000000000002, "alertThreshold": 2.0}]} 14:35:17 INFO - Return code: 0 14:35:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:35:17 ERROR - # TBPL SUCCESS # 14:35:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:35:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:35:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:35:17 INFO - 2016-06-30 14:35:17.828 screenresolution[1683:10377] starting screenresolution argv=screenresolution get 14:35:17 INFO - 2016-06-30 14:35:17.831 screenresolution[1683:10377] Display 0: 1600x1200x32@60 14:35:17 INFO - 2016-06-30 14:35:17.837 screenresolution[1684:10380] starting screenresolution argv=screenresolution list 14:35:17 INFO - Available Modes on Display 0 14:35:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:35:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:35:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:35:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:35:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:35:18 INFO - Intel Iris: 14:35:18 INFO - Chipset Model: Intel Iris 14:35:18 INFO - Type: GPU 14:35:18 INFO - Bus: Built-In 14:35:18 INFO - VRAM (Dynamic, Max): 1536 MB 14:35:18 INFO - Vendor: Intel (0x8086) 14:35:18 INFO - Device ID: 0x0a2e 14:35:18 INFO - Revision ID: 0x0009 14:35:18 INFO - Displays: 14:35:18 INFO - Display: 14:35:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:35:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:35:18 INFO - Display Serial Number: 1600x1200 60 14:35:18 INFO - Main Display: Yes 14:35:18 INFO - Mirror: Off 14:35:18 INFO - Online: Yes 14:35:18 INFO - Rotation: Supported 14:35:18 INFO - Return code: 0 14:35:18 INFO - Running post-action listener: _resource_record_post_action 14:35:18 INFO - Running post-run listener: _resource_record_post_run 14:35:19 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 38282752; Write bytes: 495948288; Read time: 389; Write time: 1792 14:35:19 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193405440; Write bytes: 185835520; Read time: 17581; Write time: 355 14:35:19 INFO - run-tests - Wall time: 1171s; CPU: 54.0%; Read bytes: 36500992; Write bytes: 300368384; Read time: 371; Write time: 1407 14:35:19 INFO - Running post-run listener: _upload_blobber_files 14:35:19 INFO - Blob upload gear active. 14:35:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:35:19 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 14:35:19 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'] 14:35:19 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 14:35:19 INFO - (blobuploader) - INFO - Open directory for files ... 14:35:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:35:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:35:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:20 INFO - (blobuploader) - INFO - Done attempting. 14:35:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:35:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:35:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:21 INFO - (blobuploader) - INFO - Done attempting. 14:35:21 INFO - (blobuploader) - INFO - Iteration through files over. 14:35:21 INFO - Return code: 0 14:35:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:35:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:35:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4a0a2a71b8c8dbae8411b8034513121afa28fc214e32ca3ccc278bab72fd4da21ac23b14f89aea6607f63399f2a6b1bbcdbdadb35f8048bc3e44f425435313b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1c7fbb05096f7f000be45831fceec1fc16f564dc0a5cced63dca9e388a10a73f5429f315a1458b0e7f588f8db5a0bc0a50488391a6bf1ceab110d9fad93d4da"} 14:35:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:35:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:35:21 INFO - Contents: 14:35:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4a0a2a71b8c8dbae8411b8034513121afa28fc214e32ca3ccc278bab72fd4da21ac23b14f89aea6607f63399f2a6b1bbcdbdadb35f8048bc3e44f425435313b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1c7fbb05096f7f000be45831fceec1fc16f564dc0a5cced63dca9e388a10a73f5429f315a1458b0e7f588f8db5a0bc0a50488391a6bf1ceab110d9fad93d4da"} 14:35:21 INFO - Running post-run listener: copy_logs_to_upload_dir 14:35:21 INFO - Copying logs to upload dir... 14:35:21 INFO - mkdir: /builds/slave/test/build/upload/logs 14:35:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.893247 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-30 14:35:21.293710) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 14:35:21.297066) ========= 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.ssFRsknrJk/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.peGEah51PS/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4a0a2a71b8c8dbae8411b8034513121afa28fc214e32ca3ccc278bab72fd4da21ac23b14f89aea6607f63399f2a6b1bbcdbdadb35f8048bc3e44f425435313b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1c7fbb05096f7f000be45831fceec1fc16f564dc0a5cced63dca9e388a10a73f5429f315a1458b0e7f588f8db5a0bc0a50488391a6bf1ceab110d9fad93d4da"} build_url:https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010929 build_url: 'https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4a0a2a71b8c8dbae8411b8034513121afa28fc214e32ca3ccc278bab72fd4da21ac23b14f89aea6607f63399f2a6b1bbcdbdadb35f8048bc3e44f425435313b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1c7fbb05096f7f000be45831fceec1fc16f564dc0a5cced63dca9e388a10a73f5429f315a1458b0e7f588f8db5a0bc0a50488391a6bf1ceab110d9fad93d4da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 14:35:21.329340) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:35:21.329663) ========= 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.ssFRsknrJk/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.peGEah51PS/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.005153 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:35:21.378748) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 14:35:21.379194) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 14:35:21.379539) ========= ========= Total master_lag: 0.17 =========