builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0027 starttime: 1468599113.11 results: success (0) buildid: 20160714094242 builduid: 5eac837765964f8393ec98e43c8f70d5 revision: 0968b5fb96974b862d6901f9250644d8e478a30f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 09:11:53.115300) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 09:11:53.115707) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 09:11:53.116059) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 09:11:53.141793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:11:53.142205) ========= 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.k2KIpuGxu6/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.NOLrAyD2Zz/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-15 09:11:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.7M=0.001s 2016-07-15 09:11:53 (14.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131591 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:11:53.296682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:11:53.297110) ========= 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.k2KIpuGxu6/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.NOLrAyD2Zz/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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.027304 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:11:53.345851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 09:11:53.346268) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0968b5fb96974b862d6901f9250644d8e478a30f --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 0968b5fb96974b862d6901f9250644d8e478a30f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k2KIpuGxu6/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.NOLrAyD2Zz/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-15 09:11:53,421 truncating revision to first 12 chars 2016-07-15 09:11:53,421 Setting DEBUG logging. 2016-07-15 09:11:53,421 attempt 1/10 2016-07-15 09:11:53,421 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0968b5fb9697?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 09:11:54,142 unpacking tar archive at: mozilla-beta-0968b5fb9697/testing/mozharness/ program finished with exit code 0 elapsedTime=0.977784 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 09:11:54.466462) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 09:11:54.467130) ========= script_repo_revision: 0968b5fb96974b862d6901f9250644d8e478a30f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 09:11:54.467510) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 09:11:54.467799) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 09:11:54.496103) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-15 09:11:54.496406) ========= /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.k2KIpuGxu6/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.NOLrAyD2Zz/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:11:54 INFO - MultiFileLogger online at 20160715 09:11:54 in /builds/slave/test 09:11:54 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 09:11:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:11:54 INFO - {'append_to_log': False, 09:11:54 INFO - 'base_work_dir': '/builds/slave/test', 09:11:54 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:11:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:11:54 INFO - 'branch': 'Mozilla-Beta', 09:11:54 INFO - 'buildbot_json_path': 'buildprops.json', 09:11:54 INFO - 'config_files': ('talos/mac_config.py',), 09:11:54 INFO - 'default_actions': ('clobber', 09:11:54 INFO - 'read-buildbot-config', 09:11:54 INFO - 'download-and-extract', 09:11:54 INFO - 'populate-webroot', 09:11:54 INFO - 'create-virtualenv', 09:11:54 INFO - 'install', 09:11:54 INFO - 'run-tests'), 09:11:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:11:54 INFO - 'download_minidump_stackwalk': True, 09:11:54 INFO - 'download_symbols': 'ondemand', 09:11:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:11:54 INFO - 'tooltool.py': '/tools/tooltool.py', 09:11:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:11:54 INFO - '/tools/misc-python/virtualenv.py')}, 09:11:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:11:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:11:54 INFO - 'installer_path': 'installer.exe', 09:11:54 INFO - 'log_level': 'info', 09:11:54 INFO - 'log_name': 'talos', 09:11:54 INFO - 'log_to_console': True, 09:11:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:11:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:11:54 INFO - 'opt_config_files': (), 09:11:54 INFO - 'pip_index': False, 09:11:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:11:54 INFO - 'cmd': ('bash', 09:11:54 INFO - '-c', 09:11:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:11:54 INFO - 'enabled': True, 09:11:54 INFO - 'halt_on_failure': False, 09:11:54 INFO - 'name': 'check_screen_resolution'},), 09:11:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:11:54 INFO - 'cmd': ('bash', 09:11:54 INFO - '-c', 09:11:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:11:54 INFO - 'enabled': True, 09:11:54 INFO - 'halt_on_failure': False, 09:11:54 INFO - 'name': 'check_screen_resolution'},), 09:11:54 INFO - 'run_cmd_checks_enabled': True, 09:11:54 INFO - 'sps_profile': False, 09:11:54 INFO - 'sps_profile_interval': 0, 09:11:54 INFO - 'suite': 'dromaeojs-e10s', 09:11:54 INFO - 'system_bits': '32', 09:11:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:11:54 INFO - 'title': 't-yosemite-r7-0027', 09:11:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:11:54 INFO - 'use_talos_json': True, 09:11:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:11:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:11:54 INFO - 'work_dir': 'build'} 09:11:54 INFO - ##### 09:11:54 INFO - ##### Running clobber step. 09:11:54 INFO - ##### 09:11:54 INFO - Running pre-action listener: _resource_record_pre_action 09:11:54 INFO - Running main action method: clobber 09:11:54 INFO - rmtree: /builds/slave/test/build 09:11:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:11:56 INFO - Running post-action listener: _resource_record_post_action 09:11:56 INFO - ##### 09:11:56 INFO - ##### Running read-buildbot-config step. 09:11:56 INFO - ##### 09:11:56 INFO - Running pre-action listener: _resource_record_pre_action 09:11:56 INFO - Running main action method: read_buildbot_config 09:11:56 INFO - Using buildbot properties: 09:11:56 INFO - { 09:11:56 INFO - "project": "", 09:11:56 INFO - "product": "firefox", 09:11:56 INFO - "script_repo_revision": "production", 09:11:56 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 09:11:56 INFO - "repository": "", 09:11:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 09:11:56 INFO - "buildid": "20160714094242", 09:11:56 INFO - "pgo_build": "False", 09:11:56 INFO - "basedir": "/builds/slave/test", 09:11:56 INFO - "buildnumber": 19, 09:11:56 INFO - "slavename": "t-yosemite-r7-0027", 09:11:56 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:11:56 INFO - "platform": "yosemite_r7", 09:11:56 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:11:56 INFO - "branch": "mozilla-beta", 09:11:56 INFO - "repo_path": "releases/mozilla-beta", 09:11:56 INFO - "revision": "0968b5fb96974b862d6901f9250644d8e478a30f", 09:11:56 INFO - "stage_platform": "macosx64", 09:11:56 INFO - "builduid": "5eac837765964f8393ec98e43c8f70d5", 09:11:56 INFO - "slavebuilddir": "test" 09:11:56 INFO - } 09:11:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 09:11:56 INFO - Running post-action listener: _resource_record_post_action 09:11:56 INFO - ##### 09:11:56 INFO - ##### Running download-and-extract step. 09:11:56 INFO - ##### 09:11:56 INFO - Running pre-action listener: _resource_record_pre_action 09:11:56 INFO - Running main action method: download_and_extract 09:11:56 INFO - mkdir: /builds/slave/test/build/tests 09:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:56 INFO - https://queue.taskcluster.net/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:11:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 09:11:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 09:11:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 09:11:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 09:11:57 INFO - Downloaded 1165 bytes. 09:11:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 09:11:57 INFO - Using the following test package requirements: 09:11:57 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 09:11:57 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:11:57 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 09:11:57 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:11:57 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 09:11:57 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:11:57 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:11:57 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 09:11:57 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 09:11:57 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:11:57 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 09:11:57 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:11:57 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 09:11:57 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:11:57 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 09:11:57 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:11:57 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 09:11:57 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 09:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:57 INFO - https://queue.taskcluster.net/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:11:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:11:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:11:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 09:11:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 09:11:59 INFO - Downloaded 18314842 bytes. 09:11:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:11:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:12:02 INFO - Return code: 0 09:12:02 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:12: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')]} 09:12:02 INFO - https://queue.taskcluster.net/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:12:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:12:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:12:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 09:12:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 09:12:11 INFO - Downloaded 18314842 bytes. 09:12:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:12:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:12:15 INFO - Return code: 0 09:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:15 INFO - https://queue.taskcluster.net/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:12:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 09:12:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 09:12:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 09:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 09:12:16 INFO - Downloaded 10840145 bytes. 09:12:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:12:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:12:16 INFO - Return code: 0 09:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:16 INFO - https://queue.taskcluster.net/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 09:12:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:12:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:12:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 09:12:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 09:12:18 INFO - Downloaded 86191200 bytes. 09:12:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:12:18 INFO - mkdir: /builds/slave/test/properties 09:12:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:12:18 INFO - Writing to file /builds/slave/test/properties/build_url 09:12:18 INFO - Contents: 09:12:18 INFO - build_url:https://queue.taskcluster.net/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:12:20 INFO - Running post-action listener: _resource_record_post_action 09:12:20 INFO - Running post-action listener: set_extra_try_arguments 09:12:20 INFO - ##### 09:12:20 INFO - ##### Running populate-webroot step. 09:12:20 INFO - ##### 09:12:20 INFO - Running pre-action listener: _resource_record_pre_action 09:12:20 INFO - Running main action method: populate_webroot 09:12:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:12:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:12:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:12:20 INFO - '--tppagecycles', 09:12:20 INFO - '7'], 09:12:20 INFO - 'tests': ['tsvgm']}}, 09:12:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:12:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:12:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:12:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:12:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:12:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:12:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:20 INFO - 'talos_options': ['--disable-e10s'], 09:12:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:20 INFO - 'talos_options': ['--disable-e10s'], 09:12:20 INFO - 'tests': ['damp', 'tps']}, 09:12:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:20 INFO - 'tests': ['damp', 'tps']}, 09:12:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:12:20 INFO - 'tests': ['dromaeo_dom']}, 09:12:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:12:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:12:20 INFO - 'tests': ['a11yr', 09:12:20 INFO - 'ts_paint', 09:12:20 INFO - 'tpaint', 09:12:20 INFO - 'sessionrestore', 09:12:20 INFO - 'sessionrestore_no_auto_restore', 09:12:20 INFO - 'tabpaint']}, 09:12:20 INFO - 'other-e10s': {'tests': ['a11yr', 09:12:20 INFO - 'ts_paint', 09:12:20 INFO - 'tpaint', 09:12:20 INFO - 'sessionrestore', 09:12:20 INFO - 'sessionrestore_no_auto_restore', 09:12:20 INFO - 'tabpaint']}, 09:12:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:12:20 INFO - 'ts_paint', 09:12:20 INFO - 'tpaint', 09:12:20 INFO - 'sessionrestore', 09:12:20 INFO - 'sessionrestore_no_auto_restore', 09:12:20 INFO - 'tabpaint']}, 09:12:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:12:20 INFO - 'ts_paint', 09:12:20 INFO - 'tpaint', 09:12:20 INFO - 'sessionrestore', 09:12:20 INFO - 'sessionrestore_no_auto_restore', 09:12:20 INFO - 'tabpaint']}, 09:12:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:12:20 INFO - 'tests': ['a11yr', 09:12:20 INFO - 'ts_paint', 09:12:20 INFO - 'tpaint', 09:12:20 INFO - 'sessionrestore', 09:12:20 INFO - 'sessionrestore_no_auto_restore', 09:12:20 INFO - 'tabpaint']}, 09:12:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:12:20 INFO - 'tests': ['a11yr', 09:12:20 INFO - 'ts_paint', 09:12:20 INFO - 'tpaint', 09:12:20 INFO - 'sessionrestore', 09:12:20 INFO - 'sessionrestore_no_auto_restore', 09:12:20 INFO - 'tabpaint']}, 09:12:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:12:20 INFO - 'tests': ['tsvgx', 09:12:20 INFO - 'tsvgr_opacity', 09:12:20 INFO - 'tart', 09:12:20 INFO - 'tscrollx', 09:12:20 INFO - 'cart']}, 09:12:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:12:20 INFO - 'tsvgr_opacity', 09:12:20 INFO - 'tart', 09:12:20 INFO - 'tscrollx', 09:12:20 INFO - 'cart']}, 09:12:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:20 INFO - 'talos_options': ['--disable-e10s'], 09:12:20 INFO - 'tests': ['tp5o']}, 09:12:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:20 INFO - 'tests': ['tp5o']}, 09:12:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:20 INFO - 'talos_options': ['--disable-e10s', 09:12:20 INFO - '--xperf_path', 09:12:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:20 INFO - 'tests': ['tp5n']}, 09:12:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:20 INFO - 'talos_options': ['--xperf_path', 09:12:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:20 INFO - 'tests': ['tp5n']}}, 09:12:20 INFO - 'talos.zip': {'path': '', 09:12:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:12:20 INFO - Running post-action listener: _resource_record_post_action 09:12:20 INFO - ##### 09:12:20 INFO - ##### Running create-virtualenv step. 09:12:20 INFO - ##### 09:12:20 INFO - Running pre-action listener: _resource_record_pre_action 09:12:20 INFO - Running main action method: create_virtualenv 09:12:20 INFO - Creating virtualenv /builds/slave/test/build/venv 09:12:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:12:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:12:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:12:20 INFO - Using real prefix '/tools/python27' 09:12:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:12:20 INFO - Installing distribute.............................................................................................................................................................................................done. 09:12:23 INFO - Installing pip.................done. 09:12:23 INFO - Return code: 0 09:12:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ba9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe33ac716c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a38e00>, '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 0x1008a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a33b20>, '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.k2KIpuGxu6/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.NOLrAyD2Zz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:12:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:12:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k2KIpuGxu6/Render', 09:12:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:23 INFO - 'HOME': '/Users/cltbld', 09:12:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:23 INFO - 'LOGNAME': 'cltbld', 09:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:23 INFO - 'MOZ_NO_REMOTE': '1', 09:12:23 INFO - 'NO_EM_RESTART': '1', 09:12:23 INFO - 'PAGER': '/bin/cat', 09:12:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:23 INFO - 'PWD': '/builds/slave/test', 09:12:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:23 INFO - 'SHELL': '/bin/bash', 09:12:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NOLrAyD2Zz/Listeners', 09:12:23 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:12:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:23 INFO - 'USER': 'cltbld', 09:12:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:23 INFO - 'XPC_FLAGS': '0x0', 09:12:23 INFO - 'XPC_SERVICE_NAME': '0', 09:12:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:12:24 INFO - Cleaning up... 09:12:24 INFO - Return code: 0 09:12:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:24 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 0x100b99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ba9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe33ac716c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a38e00>, '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 0x1008a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a33b20>, '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.k2KIpuGxu6/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.NOLrAyD2Zz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:12:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:12:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k2KIpuGxu6/Render', 09:12:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:24 INFO - 'HOME': '/Users/cltbld', 09:12:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:24 INFO - 'LOGNAME': 'cltbld', 09:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:24 INFO - 'MOZ_NO_REMOTE': '1', 09:12:24 INFO - 'NO_EM_RESTART': '1', 09:12:24 INFO - 'PAGER': '/bin/cat', 09:12:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:24 INFO - 'PWD': '/builds/slave/test', 09:12:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:24 INFO - 'SHELL': '/bin/bash', 09:12:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NOLrAyD2Zz/Listeners', 09:12:24 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:12:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:24 INFO - 'USER': 'cltbld', 09:12:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:24 INFO - 'XPC_FLAGS': '0x0', 09:12:24 INFO - 'XPC_SERVICE_NAME': '0', 09:12:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:24 INFO - Downloading/unpacking psutil>=0.7.1 09:12: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 09:12: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 09:12: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 09:12: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 09:12: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 09:12: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 09:12:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:12:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:12:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:12:26 INFO - Installing collected packages: psutil 09:12:26 INFO - Running setup.py install for psutil 09:12:26 INFO - building 'psutil._psutil_osx' extension 09:12:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:12:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:12:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:12:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:12:27 INFO - building 'psutil._psutil_posix' extension 09:12:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:12:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:12:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:12:27 INFO - ^ 09:12:27 INFO - 1 warning generated. 09:12:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:12:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:12:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:12:27 INFO - Successfully installed psutil 09:12:27 INFO - Cleaning up... 09:12:27 INFO - Return code: 0 09:12:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100b99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ba9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe33ac716c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a38e00>, '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 0x1008a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a33b20>, '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.k2KIpuGxu6/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.NOLrAyD2Zz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:12:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k2KIpuGxu6/Render', 09:12:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:27 INFO - 'HOME': '/Users/cltbld', 09:12:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:27 INFO - 'LOGNAME': 'cltbld', 09:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:27 INFO - 'MOZ_NO_REMOTE': '1', 09:12:27 INFO - 'NO_EM_RESTART': '1', 09:12:27 INFO - 'PAGER': '/bin/cat', 09:12:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:27 INFO - 'PWD': '/builds/slave/test', 09:12:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:27 INFO - 'SHELL': '/bin/bash', 09:12:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NOLrAyD2Zz/Listeners', 09:12:27 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:12:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:27 INFO - 'USER': 'cltbld', 09:12:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:27 INFO - 'XPC_FLAGS': '0x0', 09:12:27 INFO - 'XPC_SERVICE_NAME': '0', 09:12:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:12:30 INFO - Installing collected packages: mozsystemmonitor 09:12:30 INFO - Running setup.py install for mozsystemmonitor 09:12:30 INFO - Successfully installed mozsystemmonitor 09:12:30 INFO - Cleaning up... 09:12:30 INFO - Return code: 0 09:12:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:30 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 0x100b99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ba9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe33ac716c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a38e00>, '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 0x1008a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a33b20>, '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.k2KIpuGxu6/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.NOLrAyD2Zz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:12:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:12:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k2KIpuGxu6/Render', 09:12:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:30 INFO - 'HOME': '/Users/cltbld', 09:12:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:30 INFO - 'LOGNAME': 'cltbld', 09:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:30 INFO - 'MOZ_NO_REMOTE': '1', 09:12:30 INFO - 'NO_EM_RESTART': '1', 09:12:30 INFO - 'PAGER': '/bin/cat', 09:12:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:30 INFO - 'PWD': '/builds/slave/test', 09:12:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:30 INFO - 'SHELL': '/bin/bash', 09:12:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NOLrAyD2Zz/Listeners', 09:12:30 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:12:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:30 INFO - 'USER': 'cltbld', 09:12:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:30 INFO - 'XPC_FLAGS': '0x0', 09:12:30 INFO - 'XPC_SERVICE_NAME': '0', 09:12:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:31 INFO - Downloading/unpacking blobuploader==1.2.4 09:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:33 INFO - Downloading blobuploader-1.2.4.tar.gz 09:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:12:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:12:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:34 INFO - Downloading docopt-0.6.1.tar.gz 09:12:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:12:34 INFO - Installing collected packages: blobuploader, requests, docopt 09:12:34 INFO - Running setup.py install for blobuploader 09:12:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:12:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:12:34 INFO - Running setup.py install for requests 09:12:35 INFO - Running setup.py install for docopt 09:12:35 INFO - Successfully installed blobuploader requests docopt 09:12:35 INFO - Cleaning up... 09:12:35 INFO - Return code: 0 09:12:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:35 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 0x100b99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ba9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe33ac716c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a38e00>, '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 0x1008a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a33b20>, '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.k2KIpuGxu6/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.NOLrAyD2Zz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:12:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:12:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k2KIpuGxu6/Render', 09:12:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:35 INFO - 'HOME': '/Users/cltbld', 09:12:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:35 INFO - 'LOGNAME': 'cltbld', 09:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:35 INFO - 'MOZ_NO_REMOTE': '1', 09:12:35 INFO - 'NO_EM_RESTART': '1', 09:12:35 INFO - 'PAGER': '/bin/cat', 09:12:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:35 INFO - 'PWD': '/builds/slave/test', 09:12:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:35 INFO - 'SHELL': '/bin/bash', 09:12:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NOLrAyD2Zz/Listeners', 09:12:35 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:12:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:35 INFO - 'USER': 'cltbld', 09:12:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:35 INFO - 'XPC_FLAGS': '0x0', 09:12:35 INFO - 'XPC_SERVICE_NAME': '0', 09:12:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:35 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-aH8xcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-qIbqWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-8Bcga6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-9H8SYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-sZdmxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-Rc5cKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-cz_52D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-XtRriE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-rVfjms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-5cOQS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:36 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-8oQUA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-MHI5Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-V6TEto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-L5YHIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-mrf7cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-n1VW4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-nFXf9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:12:37 INFO - Running setup.py install for manifestparser 09:12:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:12:37 INFO - Running setup.py install for mozcrash 09:12:37 INFO - Running setup.py install for mozdebug 09:12:38 INFO - Running setup.py install for mozdevice 09:12:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:12:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:12:38 INFO - Running setup.py install for mozfile 09:12:38 INFO - Running setup.py install for mozhttpd 09:12:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:12:38 INFO - Running setup.py install for mozinfo 09:12:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:12:38 INFO - Running setup.py install for mozInstall 09:12:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:12:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:12:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:12:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:12:38 INFO - Running setup.py install for mozleak 09:12:38 INFO - Running setup.py install for mozlog 09:12:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:12:39 INFO - Running setup.py install for moznetwork 09:12:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:12:39 INFO - Running setup.py install for mozprocess 09:12:39 INFO - Running setup.py install for mozprofile 09:12:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:12:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:12:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:12:39 INFO - Running setup.py install for mozrunner 09:12:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:12:39 INFO - Running setup.py install for mozscreenshot 09:12:39 INFO - Running setup.py install for moztest 09:12:40 INFO - Running setup.py install for mozversion 09:12:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:12:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:12:40 INFO - Cleaning up... 09:12:40 INFO - Return code: 0 09:12:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:40 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 0x100b99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ba9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe33ac716c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a38e00>, '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 0x1008a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a33b20>, '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.k2KIpuGxu6/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.NOLrAyD2Zz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:12:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:12:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k2KIpuGxu6/Render', 09:12:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:40 INFO - 'HOME': '/Users/cltbld', 09:12:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:40 INFO - 'LOGNAME': 'cltbld', 09:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:40 INFO - 'MOZ_NO_REMOTE': '1', 09:12:40 INFO - 'NO_EM_RESTART': '1', 09:12:40 INFO - 'PAGER': '/bin/cat', 09:12:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:40 INFO - 'PWD': '/builds/slave/test', 09:12:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:40 INFO - 'SHELL': '/bin/bash', 09:12:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NOLrAyD2Zz/Listeners', 09:12:40 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:12:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:40 INFO - 'USER': 'cltbld', 09:12:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:40 INFO - 'XPC_FLAGS': '0x0', 09:12:40 INFO - 'XPC_SERVICE_NAME': '0', 09:12:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:40 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-BrT0gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:40 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-pxDEmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:40 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-cFEDqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:40 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-IfgvOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:40 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-CxULJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-0sWMku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-2FPO8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-c7w3LU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-S0TYdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-iY0W4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-OzArat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-pvl57I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-wfdjN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-43dd1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:41 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-tVTzRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:42 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-pjpOjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:42 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-7YTRW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:12:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:44 INFO - Downloading blessings-1.6.tar.gz 09:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:12:44 INFO - Installing collected packages: blessings 09:12:44 INFO - Running setup.py install for blessings 09:12:44 INFO - Successfully installed blessings 09:12:44 INFO - Cleaning up... 09:12:45 INFO - Return code: 0 09:12:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:12:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:45 INFO - Reading from file tmpfile_stdout 09:12:45 INFO - Current package versions: 09:12:45 INFO - blessings == 1.6 09:12:45 INFO - blobuploader == 1.2.4 09:12:45 INFO - docopt == 0.6.1 09:12:45 INFO - manifestparser == 1.1 09:12:45 INFO - mozInstall == 1.12 09:12:45 INFO - mozcrash == 0.17 09:12:45 INFO - mozdebug == 0.1 09:12:45 INFO - mozdevice == 0.48 09:12:45 INFO - mozfile == 1.2 09:12:45 INFO - mozhttpd == 0.7 09:12:45 INFO - mozinfo == 0.9 09:12:45 INFO - mozleak == 0.1 09:12:45 INFO - mozlog == 3.1 09:12:45 INFO - moznetwork == 0.27 09:12:45 INFO - mozprocess == 0.22 09:12:45 INFO - mozprofile == 0.28 09:12:45 INFO - mozrunner == 6.11 09:12:45 INFO - mozscreenshot == 0.1 09:12:45 INFO - mozsystemmonitor == 0.0 09:12:45 INFO - moztest == 0.7 09:12:45 INFO - mozversion == 1.4 09:12:45 INFO - psutil == 3.1.1 09:12:45 INFO - requests == 1.2.3 09:12:45 INFO - wsgiref == 0.1.2 09:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:45 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 0x100b99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ba9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe33ac716c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a38e00>, '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 0x1008a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a33b20>, '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.k2KIpuGxu6/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.NOLrAyD2Zz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:12:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k2KIpuGxu6/Render', 09:12:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:45 INFO - 'HOME': '/Users/cltbld', 09:12:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:45 INFO - 'LOGNAME': 'cltbld', 09:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:45 INFO - 'MOZ_NO_REMOTE': '1', 09:12:45 INFO - 'NO_EM_RESTART': '1', 09:12:45 INFO - 'PAGER': '/bin/cat', 09:12:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:45 INFO - 'PWD': '/builds/slave/test', 09:12:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:45 INFO - 'SHELL': '/bin/bash', 09:12:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NOLrAyD2Zz/Listeners', 09:12:45 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:12:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:45 INFO - 'USER': 'cltbld', 09:12:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:45 INFO - 'XPC_FLAGS': '0x0', 09:12:45 INFO - 'XPC_SERVICE_NAME': '0', 09:12:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:12:45 INFO - Cleaning up... 09:12:45 INFO - Return code: 0 09:12:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ba9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe33ac716c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a38e00>, '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 0x1008a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a33b20>, '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.k2KIpuGxu6/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.NOLrAyD2Zz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:12:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k2KIpuGxu6/Render', 09:12:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:45 INFO - 'HOME': '/Users/cltbld', 09:12:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:45 INFO - 'LOGNAME': 'cltbld', 09:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:45 INFO - 'MOZ_NO_REMOTE': '1', 09:12:45 INFO - 'NO_EM_RESTART': '1', 09:12:45 INFO - 'PAGER': '/bin/cat', 09:12:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:45 INFO - 'PWD': '/builds/slave/test', 09:12:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:45 INFO - 'SHELL': '/bin/bash', 09:12:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NOLrAyD2Zz/Listeners', 09:12:45 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:12:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:45 INFO - 'USER': 'cltbld', 09:12:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:45 INFO - 'XPC_FLAGS': '0x0', 09:12:45 INFO - 'XPC_SERVICE_NAME': '0', 09:12:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:45 INFO - Downloading/unpacking jsonschema 09:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:12:48 INFO - Downloading/unpacking functools32 (from jsonschema) 09:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:48 INFO - Downloading functools32-3.2.3-2.tar.gz 09:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:12:48 INFO - warning: no files found matching '*.txt' 09:12:48 INFO - no previously-included directories found matching 'build' 09:12:48 INFO - no previously-included directories found matching 'dist' 09:12:48 INFO - no previously-included directories found matching '.git*' 09:12:48 INFO - Installing collected packages: jsonschema, functools32 09:12:49 INFO - Running setup.py install for functools32 09:12:49 INFO - warning: no files found matching '*.txt' 09:12:49 INFO - no previously-included directories found matching 'build' 09:12:49 INFO - no previously-included directories found matching 'dist' 09:12:49 INFO - no previously-included directories found matching '.git*' 09:12:49 INFO - Successfully installed jsonschema functools32 09:12:49 INFO - Cleaning up... 09:12:49 INFO - Return code: 0 09:12:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ba9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe33ac716c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a38e00>, '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 0x1008a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a33b20>, '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.k2KIpuGxu6/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.NOLrAyD2Zz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:12:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:12:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k2KIpuGxu6/Render', 09:12:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:49 INFO - 'HOME': '/Users/cltbld', 09:12:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:49 INFO - 'LOGNAME': 'cltbld', 09:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:49 INFO - 'MOZ_NO_REMOTE': '1', 09:12:49 INFO - 'NO_EM_RESTART': '1', 09:12:49 INFO - 'PAGER': '/bin/cat', 09:12:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:49 INFO - 'PWD': '/builds/slave/test', 09:12:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:49 INFO - 'SHELL': '/bin/bash', 09:12:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NOLrAyD2Zz/Listeners', 09:12:49 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:12:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:49 INFO - 'USER': 'cltbld', 09:12:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:49 INFO - 'XPC_FLAGS': '0x0', 09:12:49 INFO - 'XPC_SERVICE_NAME': '0', 09:12:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:49 INFO - Downloading/unpacking flake8 09:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:12:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:12:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:12:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:12:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:12:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:12:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:12:53 INFO - no previously-included directories found matching 'docs/_build' 09:12:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:12:53 INFO - Running setup.py install for pep8 09:12:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:12:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:12:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:12:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:12:53 INFO - no previously-included directories found matching 'docs/_build' 09:12:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:12:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:12:53 INFO - Cleaning up... 09:12:53 INFO - Return code: 0 09:12:53 INFO - Running post-action listener: _resource_record_post_action 09:12:53 INFO - Running post-action listener: _start_resource_monitoring 09:12:53 INFO - Starting resource monitoring. 09:12:53 INFO - ##### 09:12:53 INFO - ##### Running install step. 09:12:53 INFO - ##### 09:12:53 INFO - Running pre-action listener: _resource_record_pre_action 09:12:53 INFO - Running main action method: install 09:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:53 INFO - Reading from file tmpfile_stdout 09:12:53 INFO - Detecting whether we're running mozinstall >=1.0... 09:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:12:54 INFO - Reading from file tmpfile_stdout 09:12:54 INFO - Output received: 09:12:54 INFO - Usage: mozinstall [options] installer 09:12:54 INFO - Options: 09:12:54 INFO - -h, --help show this help message and exit 09:12:54 INFO - -d DEST, --destination=DEST 09:12:54 INFO - Directory to install application into. [default: 09:12:54 INFO - "/builds/slave/test"] 09:12:54 INFO - --app=APP Application being installed. [default: firefox] 09:12:54 INFO - mkdir: /builds/slave/test/build/application 09:12:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:13:16 INFO - Reading from file tmpfile_stdout 09:13:16 INFO - Output received: 09:13:16 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:13:16 INFO - Running post-action listener: _resource_record_post_action 09:13:16 INFO - ##### 09:13:16 INFO - ##### Running run-tests step. 09:13:16 INFO - ##### 09:13:16 INFO - Running pre-action listener: _resource_record_pre_action 09:13:16 INFO - Running main action method: run_tests 09:13:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:13:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:13:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:13:16 INFO - 2016-07-15 09:13:16.327 screenresolution[2733:16179] starting screenresolution argv=screenresolution get 09:13:16 INFO - 2016-07-15 09:13:16.329 screenresolution[2733:16179] Display 0: 1600x1200x32@60 09:13:16 INFO - 2016-07-15 09:13:16.335 screenresolution[2734:16181] starting screenresolution argv=screenresolution list 09:13:16 INFO - Available Modes on Display 0 09:13:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:13:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:13:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:13:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:13:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:13:16 INFO - Intel Iris: 09:13:16 INFO - Chipset Model: Intel Iris 09:13:16 INFO - Type: GPU 09:13:16 INFO - Bus: Built-In 09:13:16 INFO - VRAM (Dynamic, Max): 1536 MB 09:13:16 INFO - Vendor: Intel (0x8086) 09:13:16 INFO - Device ID: 0x0a2e 09:13:16 INFO - Revision ID: 0x0009 09:13:16 INFO - Displays: 09:13:16 INFO - Display: 09:13:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:13:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:13:16 INFO - Display Serial Number: 1600x1200 60 09:13:16 INFO - Main Display: Yes 09:13:16 INFO - Mirror: Off 09:13:16 INFO - Online: Yes 09:13:16 INFO - Rotation: Supported 09:13:16 INFO - Return code: 0 09:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:13:16 INFO - Python 2.7.3 09:13:16 INFO - Return code: 0 09:13:16 INFO - grabbing minidump binary from tooltool 09:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:16 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 0x100a38e00>, '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 0x1008a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a33b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:13:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:13:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:13:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:13:16 INFO - Return code: 0 09:13:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:13:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:13:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:13:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:13:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:13:17 INFO - Return code: 0 09:13:17 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/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0027', '--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 09:13:17 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/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0027 --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 09:13:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k2KIpuGxu6/Render', 09:13:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:17 INFO - 'HOME': '/Users/cltbld', 09:13:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:17 INFO - 'LOGNAME': 'cltbld', 09:13:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:13:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:17 INFO - 'MOZ_NO_REMOTE': '1', 09:13:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:13:17 INFO - 'NO_EM_RESTART': '1', 09:13:17 INFO - 'PAGER': '/bin/cat', 09:13:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:17 INFO - 'PWD': '/builds/slave/test', 09:13:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:13:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:17 INFO - 'SHELL': '/bin/bash', 09:13:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NOLrAyD2Zz/Listeners', 09:13:17 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:13:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:17 INFO - 'USER': 'cltbld', 09:13:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:17 INFO - 'XPC_FLAGS': '0x0', 09:13:17 INFO - 'XPC_SERVICE_NAME': '0', 09:13:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:17 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/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0027', '--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 09:13:17 INFO - mozversion application_buildid: 20160714094242 09:13:17 INFO - mozversion application_changeset: 0968b5fb96974b862d6901f9250644d8e478a30f 09:13:17 INFO - mozversion application_display_name: Firefox 09:13:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:13:17 INFO - mozversion application_name: Firefox 09:13:17 INFO - mozversion application_remotingname: firefox 09:13:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:13:17 INFO - mozversion application_vendor: Mozilla 09:13:17 INFO - mozversion application_version: 48.0 09:13:17 INFO - mozversion platform_buildid: 20160714094242 09:13:17 INFO - mozversion platform_changeset: 0968b5fb96974b862d6901f9250644d8e478a30f 09:13:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:13:17 INFO - mozversion platform_version: 48.0 09:13:17 INFO - using testdate: 1468599197 09:13:17 INFO - actual date: 1468599197 09:13:17 INFO - starting webserver on 'localhost:49322' 09:13:17 INFO - SUITE-START | Running 2 tests 09:13:17 INFO - TEST-START | dromaeo_css 09:13:17 INFO - operating with platform_type : mac_ 09:13:17 INFO - Initialising browser for dromaeo_css test... 09:13:18 INFO - TEST-INFO | started process 2752 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpD0WZ48/profile http://localhost:49322/getInfo.html) 09:13:20 INFO - PROCESS | 2752 | __metrics Screen width/height:1600/1200 09:13:20 INFO - PROCESS | 2752 | colorDepth:24 09:13:20 INFO - PROCESS | 2752 | Browser inner width/height: 1024/689 09:13:20 INFO - PROCESS | 2752 | __metrics 09:13:20 ERROR - PROCESS | 2752 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 09:13:21 INFO - TEST-INFO | 2752: exit 0 09:13:21 INFO - Browser initialized. 09:13:21 INFO - Running cycle 1/1 for dromaeo_css test... 09:13:21 INFO - TEST-INFO | started process 2757 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpD0WZ48/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:33 INFO - PROCESS | 2757 | RSS: Main: 171139072 09:13:33 INFO - PROCESS | 2757 | 09:14:22 INFO - PROCESS | 2757 | 1468599262920 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:16:32 INFO - PROCESS | 2757 | Cycle 1(1): loaded http://localhost:49322/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49322/tests/dromaeo/cssquery-ext.html) 09:16:33 INFO - PROCESS | 2757 | RSS: Main: 182382592 09:16:33 INFO - PROCESS | 2757 | 09:19:35 INFO - PROCESS | 2757 | Cycle 1(1): loaded http://localhost:49322/tests/dromaeo/cssquery-ext.html (next: http://localhost:49322/tests/dromaeo/cssquery-jquery.html) 09:19:36 INFO - PROCESS | 2757 | RSS: Main: 193449984 09:19:36 INFO - PROCESS | 2757 | 09:22:38 INFO - PROCESS | 2757 | Cycle 1(1): loaded http://localhost:49322/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49322/tests/dromaeo/cssquery-mootools.html) 09:22:38 INFO - PROCESS | 2757 | RSS: Main: 195485696 09:22:38 INFO - PROCESS | 2757 | 09:25:40 INFO - PROCESS | 2757 | Cycle 1(1): loaded http://localhost:49322/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49322/tests/dromaeo/cssquery-prototype.html) 09:25:40 INFO - PROCESS | 2757 | RSS: Main: 199892992 09:25:40 INFO - PROCESS | 2757 | 09:28:43 INFO - PROCESS | 2757 | Cycle 1(1): loaded http://localhost:49322/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49322/tests/dromaeo/cssquery-yui.html) 09:28:44 INFO - PROCESS | 2757 | RSS: Main: 197795840 09:28:44 INFO - PROCESS | 2757 | 09:31:46 INFO - PROCESS | 2757 | Cycle 1(1): loaded http://localhost:49322/tests/dromaeo/cssquery-yui.html (next: http://localhost:49322/tests/dromaeo/cssquery-dojo.html) 09:31:46 INFO - PROCESS | 2757 | RSS: Main: 202936320 09:31:46 INFO - PROCESS | 2757 | 09:31:46 INFO - PROCESS | 2757 | __start_tp_report 09:31:46 INFO - PROCESS | 2757 | _x_x_mozilla_page_load 09:31:46 INFO - PROCESS | 2757 | _x_x_mozilla_page_load_details 09:31:46 INFO - PROCESS | 2757 | |i|pagename|runs| 09:31:46 INFO - PROCESS | 2757 | |0;dojo.html;2845.8861645534175;3172.524121381791;3500.597431295401;3671.4125739881606;3728.944065839013;5855.5022823060035;5923.703814809259;5958.851028724284;5966.3138739045025;5976.193213916131;4465.7320560766375;5864.5894787364905;5911.645301281927;5988.9101663475085;6015;5253.423972808161;5282.656627319231;5396.1096419091;5431.4840090191565;5444.700541470217;3924.7841368724708;4354.433923589945;4596.793144308497;4921.606271498272;4938.950610493903;5272.894542109156;5338.412774594811;5357.892842143175;5447.809326673567;5480.342358916935;4297.699161058727;4445.799939002736;5431.809886653988;5434.619576629638;5485.862853428656;5273.551748101416;5325.760340784674;5391.16436952273;5395.757190926418;5411.053065713524;4718.787654555554;4916.992016636581;5088.160453525164;5647.661140331552;5819.6508209507565;6234.127222188898;6256.655883926383;6276.811695649138;6277.497800175975;6299.716512756937;6202.19371481709;6337.651429171394;6351.872962540723;6354.078658594478;6387.648679322635;4777.402824646919;5960.344362120163;6004.489618382443;6071.969640151771;6099.878002439971;6304.936950630435;6317.747290108436;6352.428281454691;6359.745610175633;6363.872722545616;6203.100550420164;6280.0893870389455;6294.779682711083;6330.113784070234;6349.52378571609;6284.025975973731;6286.465650419674;6291.496680265659;6300.653464059521;6334.873302533923;6245.469135123565;6262.405071518198;6265.592736472115;6273.780417685359;6279.246490421178;6216.968915155395;6220.315765265817;6254.843628909313;6265.530085243625;6282.591631543935;4632.791524381343;4948.851534453972;4993.350864387607;4997.30037794709;5005.874853128628;4557.134144512532;4566.611837993808;4574.062317224961;4575.748333841604;4582.473015603182;5813.186153938452;5961;5980.8803823924145;5987.970060149672;6101.664408457489;6297.118403423525;6320.936790632035;6323.683815809191;6325.304216536178;6346.048092786119;6090.543209259235;6114.2357205349335;6117.724702388403;6140.478059365004;6143.109249158936;5452.509274165344;5532;5536.861578460571;5591.10542313228;5654.943450565524;6395.616263024233;6440.6135631862235;6442.0014897690935;6448.419642232222;6463.967680161663;6235.251769787655;6271.6550589718;6279.780207692892;6287.528435367457;6288.496920246461;6297.338779428094;6397.96801015992;6439.967800160969;6470.417662410406;6489.318621544669;6271.498280137487;6285.874282514415;6295.748170073329;6302.117703521602;6305.5901366411035;6187.907181392373;6238.6880655967925;6281.120643109877;6282.246130464374;6283.3088360281245;6185.536084793748;6233.096201050913;6269;6286.717097730704;6289.339619339903;6090.421409966046;6253.874922501615;6269.905951410824;6284.591501552384;6321.209848768904;6085.361037091218;6134.8159555213415;6160.44555989963;6211.9068213975925;6214.751409943552;4833.540813622701;5235.397929238034;6131.0708424985305;6154.753809847556;6165;6128.203333566787;6202.937970620416;6208.72060757258;6218.875622487615;6232.283287422005 09:31:46 INFO - PROCESS | 2757 | |1;ext.html;529.8066205834871;563.9013172694778;580.2369883603062;600.2586805295457;611.0528680545154;30406;39712;39725.60274397255;39751.40372894409;39808.40287395691;41760.791196044054;42003.789981050126;42222.788886055525;42233.788831055805;42383.57616423835;9530.142287194169;9710.028997100304;9721.125098741111;9726.951365243163;9760.414375137514;9547.331686781929;9746.610135594568;9755.560999754993;9760.365576237557;9788.265880058989;9675.080867317594;9726.854097188549;9735.97772233916;9757.804843903117;9823.312368134233;9701.029897010312;9751.366161199534;9755.902440975642;9778.804423911517;9811;9620.086091821266;9725.465099419529;9736.95131524345;9739.902600974041;9759.90240097597;40369.79815100935;40576.59423405758;40698.38952415716;40741.98145046397;40756.18487630261;3275.4431746603136;3322.551455553518;3344.0302312329395;3451.534042904226;3495.755297129202;27173.728262717515;28911.71088289111;29675.109746707632;30510.54234186489;30678.693213067807;2782.0541016054435;2812.2969257685577;2832.065418411919;2837.531807251801;2840.2899275181203;286275;356415;363083;363274;365273;37517.437238441446;38046.61953380431;63474;63843.36156638374;63878.6806065976;35598;36491.90524284276;36594.8170259147;36696.81651591778;36811.447828282595;15415.845841541666;15491.302891369915;15884.76172857408;15953.441629542911;16168.919155404383;13349.866501335056;13443.193408395528;13445.865541344658;13469.663258418617;13489.865101348862;7963.601819908981;8069.919300806917;8254.339652827879;8414.537200453911;8465.111163327885;3374.9493757593655;3568.768774772699;3621.4386770050683;3645.85416583339;3661.9450708239397;1043.2332235806675;1050.5797680927537;1069.5721711315537;1138.9863021910505;1166.4051333819643;25498;29683.703162968526;30238.941637042597;30759.69240307613;30858;1104.9226554141294;1160.4081918221768;1235.3761350517932;1248.2822377133184;1281.814136950137;12419;15624.296906639229;15792.684146317239;16065.036097834167;16085.356585736674;642860;696140;698377;707590;708421;49656;60178.097328540105;61480.69259653673;61549.384506155264;62179.689101554206;1570.803649543807;1583.8891277610687;1587.4364600566864;1596.6567188054623;1597.3770229610461;29154.854225729585;30276.69723302739;30380.392392152477;30679.693203067683;31012.844935775178;45492;53026;54403.45596543984;54777.45222547724;54971.175432367745;514675;610042;610189.9490502519;610571;611097;28623.284417889718;28823.85588072046;29156.416871662874;46279;46985;45432;46961;47204;47456.05087898292;47918.52081479141;38684;38752.03119921912;39014;39370.40944385894;39832.40251396174;34630.30739385248;35666.64333356633;37974.050648734;38106.61893381031;38991.41512877366;35372.11569710778;38651.42022869603;39072.6092739069;39658.80170599128;40270.79864600658;32055;32410.12966045156;32986.010419687445;33156.1710957228;33249.501257480675;21203.257885973915;21488.09820849319;25077.87461062683;25314.367140821625;25707.86382758679 09:31:46 INFO - PROCESS | 2757 | |2;jquery.html;352.89942366425544;403.0669001262078;416.58965918570203;417.0699340470752;424.5902703890746;15885;20579.691304630425;21274.36176914693;21300.99999999998;21534.89232553839;20400.795992040075;20571.588568228628;20714.89642551785;20968.370948871558;21545.784542154575;6015.308239552442;6052.757889684407;6077.301110372297;6276.152719382893;6280.623162610258;6082.787102451415;6100.962836317814;6105.023196288595;6187;6225.941589929723;5757.827265182052;6051.455369016788;6092.60398074126;6099.603525770833;6162.014077747562;6003.159557661931;6005;6012.128241404972;6111.480524155452;6125.816225513219;4603.217453032992;5358.517733403974;5693.800716974886;5884.235049443588;6016.4885984691355;13798.724025519534;13861.653458663613;13930.37313320903;14024.789628155586;14114.294285285798;2205.5368372641765;2247.235939780466;2293.9885300573555;2790.6651201855907;2854.5290027145497;10277.537510812032;10943;14105.717885642332;14674;15224.238788060664;1742.8779985401027;1756.8770186086979;1818.7362832389363;1851.6666999940005;1865.2259312385345;119775;123434;125820.37089814583;126491;126847;11769.293842369485;11850;12167.513299468099;12316;12354.938225308815;14896.180710060835;15279.388824446898;15301.387944482318;15391.230438478255;15400.152991585346;9105.271578273721;9279.489628070385;9285.535723213812;9359.766005849908;9378.95310523443;9189.586468608928;9189.95405022984;9380.390274632127;9387.57755900986;9449.622015119456;4836.371271734652;4857.465678775332;4861.1006963711825;4923.803047878045;4963.5036496350795;1804.8285412885755;1888.291890541047;1995.9222020109269;2118.8304935605115;2125.4473836802235;923.8475651517424;1021.9080282774586;1026.5072765072657;1033.607229252894;1035.8239099352977;17267;20273.594528109355;21290.36128916104;21300.78699212988;21423.571528569653;925.8518637018045;1017.9185665146771;1021.4433133942019;1022.2997246885907;1025.236199031726;10629.84055239172;10959.397233152094;10975.451227438596;11162.553497860157;11230.3261804292;553164;559273;567292;611924;651183;109733;124439;144514;145274;148981;896.6951236579595;908.418612088264;1042.6402891002592;1047.8428235764695;1070.743021674808;18281.266330557693;18525;18753.906230469307;18924.337648182798;18981.71527427062;49611.00777984348;51535.742321288155;51823;54617.53428218632;56178.719106404205;57115;74802.25197747952;80995.19004809877;82182.17817821745;83538.5823070905;6607.843627365288;7975.880361794694;8260;8293.83412331762;8456.112108228548;9241.21449676785;12062.215955962834;12766.29785361814;12937;13032.674183145118;11080.501377437873;11155.163362747664;11164.106871450102;11302.717432064264;11526.711832203926;11032.28290161137;11151.553937842395;11218.158638102012;11219.775604488028;11331.32012079278;9119.772005699646;11420.257683250562;11703.76592468129;11721.824172637587;11755.235909665844;8314.708985185489;8317.168283171877;8398.87401688963;8500.872486912825;8650.610722517627;11133.665990020312;11317.830232546683;11333;11368.374739389414;11518.481668324777 09:31:46 INFO - PROCESS | 2757 | |3;mootools.html;1616.8787340949432;1618.0938674342365;1626.9755953660695;1907.9427617171482;1998.7801341852385;8405.117462666423;9157;9181.632734690613;9385.343025988192;9433.81132377352;7647.579383133925;9168.724938251846;9265.166135047844;9288.210502107311;9294.767630809216;2555.4250293683867;2559.9360015999564;2565.384307766132;2584.819062665614;2592.8055395845295;2364.7280562735245;2559.4241295708503;2582.328594565417;2594.766471017608;2598.8050896182767;2568.191019828748;2577.7164511903675;2580.8193426460157;2603.6745406824148;2612.647292615501;2580.8193426460157;2585.857777822219;2609.8173127881055;2616.816822822403;2625.133705877056;2557.079451397514;2576.561984462646;2606.9478610427686;2615.163147792707;2620.882060307291;9283.628654853797;9290.535473226379;9387.295952803566;9411.200047995928;9439.480828554426;5669.858253543694;5670.432956704338;5827.621204621729;5833.474987251126;5865.090910908816;3685.963140368589;3744.2324323513612;3757.0982964088694;3782.7352085354037;3822.751521151144;1041.1046500009986;1046.3983209654402;1063.186662203415;1098.181854518389;1105.2539535813373;12329.753404931851;12580.370981450891;12630.30533320667;12648.241105533605;12684.23894566329;4235.4917409911;5023.472535383805;5121.155009423478;5145.974270128625;5169.302144210484;10487.108595769445;10579.735506612396;10686.732831679115;10686.946565267124;10721.088707459954;5650.943490565041;5735.2257445245195;5771.451712087345;5794.1308803679785;5799.768009279666;4657.417822772153;5100.336956195745;5168.992046550887;5207.791688332424;5211.687298762086;4301.07526881722;4325;4336.4145840311785;4368.759718215465;4423.1153769246275;1286.4532573656159;1402.2217669193492;1433.8351089624618;1451.1945870042016;1460.8247010358825;944.9763755906157;975.2685485885586;976.0776066616979;978.9657361992296;986.7342375913038;6012.609180403259;6113.296970848321;6250.531125185577;6253.6560489172625;6268.310485846553;467.14512442230637;473.9336492890998;477.3508029080517;480.7259861878696;485.1945770021747;3890.8638197662945;4092.6930480214105;4122.505299364096;4160.500739911169;4206.978965105155;11124.888751112385;11255.212135150625;11389.943050284695;11412.258203216765;11504.309741415542;11057;11208;11260.324380537195;11330.716732081764;11358.54565817358;8296.792580185544;8508.149185081442;8532.488050716853;8570.228679418882;8606.354523410644;5851.736671849691;6061.848453788691;6144.354842741448;6158.414950579688;6189.783357582463;9994.750131246778;10111.949440252753;10212.234082443698;10236.897631023594;10282.897171028193;8347.58262086881;10038.49037740565;10310.175185985254;10478.37129772216;10827.675169744605;7139.286071393027;7612.619369031637;7841.647125879464;7948.244916732901;8081.111077781557;8636.222739953435;8636.524991125298;8661.653533858575;8672.132786721277;8691.826163476822;7556.924430755622;7672.6547305372505;7694.07671079474;7726.845463090819;7824.021997250344;7546.132194797449;7547.396208303432;7569.583672897823;7662.463627546018;7688.192739762469;7400.629968501661;7422.294881986203;7426.888596670946;7447.143578488543;7455.962720186364;4670.1827180244;4714.98627795012;4887.7556122194455;5088.084144853962;5129.7691603877165;4755.524447555217;5161.561267292172;5217.426083130928;5297.231901374202;5432.375276843056 09:31:46 INFO - PROCESS | 2757 | |4;prototype.html;339.1047634245591;340.1292690711778;340.31256861140497;345.7406944791406;351.2132822477651;7065.964670176649;7090.149182098149;7120;7123.53697009694;7158.319959603842;7063.399611033068;7065.374963758326;7078.433725301977;7083.079199704031;7105.8223544411285;4975.278584605239;5034.748262586874;5168.638195326329;5188.92216616751;5205.16717325228;5145.845624631248;5215.1655735082395;5217.869553261161;5221;5241.86895327616;5181.1192097343355;5182.4299327073995;5187.948120518803;5200.583953283728;5225.921611175835;5192.71440070796;5221.086309895772;5225.451327610622;5226.477352264781;5240.842774716745;3624.58317293512;4430.1582699287355;4430.468343798732;4445.599896009342;4448.043670610834;5736.627119237278;6614.669266536654;6668.466522678174;6804.285550017276;6804.489663275274;5880.176775251468;6080.209572755558;6083.361247069039;6084.39156084388;6095.3904609538695;6061.605995610271;7494.325510704009;7504.061992250969;7531.020967274274;7539.773806785805;4041.717079804415;4899.167141585904;4950.702957822542;4954.578860796837;4977.950220497785;7707.190744971754;7793.922060779433;7947.443678942476;7951.840963180762;7957.283844453969;3923.3330333843314;4090.2637525245145;4763.403630259201;5001.149804533238;5057.6459647824295;5142.71715055668;5151.6908985461;5152.201408781645;5152.92270615941;5161.09680805865;5004.47453017428;5984.790532331347;5999.910001349983;6010.819675409744;6016.007358785839;7522.285382888617;7530.811729706801;7532.09614846211;7532.7740167795055;7545.924540754632;1368.931553422325;1544.050408998458;1662.783838101039;1693.060351504902;1732.9393471228698;1076.967690969272;1081.2755453845941;1093.4642025407652;1094.6278265389647;1096.8957948994832;7001.474889383215;7004.649767511604;7059.788206353817;7061.89407158893;7085.787426377217;7643.350315223157;7741.574213418204;7825.295723384923;7847.764567062997;7860.528368297921;7141.642917854087;7171.820704482429;7184.748533801292;7187.281271872771;7200.351968322876;4126.154138401621;4179.644730197906;4184.748915065105;4199.538050814408;4203.579642035833;8273;8275.462094963808;8275.586220688941;8283.213094755989;8292.834143317099;7826.951616207514;8108.2297181767635;8118.2693557580105;8146.389020823462;8162.061362943219;8059.838803223903;8230.300424463987;8254.504729716236;8281.99999999988;8292.37807164465;5975.701214939322;6984.882418812966;7315.268473152855;7682.654280557276;7945.642446089824;7494.812629684301;7737.0715514138665;7750.92249077502;7751.573663448565;7798.493097948615;6971.6862741175755;8229;8240.587970601326;8242.958785206276;8252.092269850431;4862.489438608895;4892.755362231803;4899.804007839646;4908.705477671351;4924.852254432372;7895.64469598858;7900.486468379537;7902.881456778038;7936.444448888522;7944.324732397811;7307.561546307238;7601.821717633776;7619.161892191743;7627.733029343946;7633.313001829862;6140.416660417253;6842.315768423317;7606.657700403606;7610.315071643578;7617.885731713918;6080.939190608215;6712.865742685021;7414.814629634302;7457.925420745723;7557.35762460175;7578.545287282781;7578.886316705364;7583.469157158946;7600.315971562586;7604.733834315773;6006.9699651503215;7070.116235470567;7420.480566360519;7429.888551671621;7439.032925719622 09:31:46 INFO - PROCESS | 2757 | |5;yui.html;697.260903442351;773.1340898194023;775.4765533265045;784.231453175888;786.1391776005275;15452.381904723812;15477.845221547781;15589;15598.688026239468;15634.843651563495;14339.78490322646;14362.928185359058;14386;14388.136711797299;14416.927915360435;758.1243663568587;931.38993958957;937.7843096087904;963.1716723617683;963.6579014449875;841.5750046226647;903.8101998580273;913.634546181526;938.976525586859;958.3100167879115;966.912977831995;998.2114129837456;999.6201443451479;1014.0619926567932;1025.9384436933808;869.6304070769961;953.4422362917702;954.9686338754129;960.6445615122379;961.7932144588912;707.745211723779;724.9383802376805;731.1737736357935;757.4243574883128;757.9734709285149;14799.33402996857;14817.851821481754;15051.247437628184;15204.087754734752;15322.15728134952;11235.887641123565;13175;13255.801162982563;13290.468381264738;13392.06255562111;10238.283320167591;10329.74175645615;10510.474476276155;10669.03978641926;10745.677629671123;3560.7151427885706;3638.890833275006;3642.3261696586214;3672.669459748609;3708.2583483303447;79652;82103;82250.17749822485;82849.58575207146;85673.57163214144;9836.458994755358;9871.111599955895;10061.849072263922;10121.645742398981;10186.745331366776;22751.772482275297;23005.194818181284;23136.768632313797;23190.76809231886;23218.07127714906;7714.459987800912;7767.067951845702;7807.804804879924;7820.530768153929;7945.364370850318;4125.1749650070105;4213.557576454489;4242.215190189825;4253.468316460442;4262.211490874198;3630.110622897407;3654.196076863086;3681.079730067483;3697.8890633281044;3761;557.8856334451427;652.1066139388972;658.6431950182639;661.5964261800298;665.4343807763363;515.920839018755;564.1256053117651;581.2037508613142;581.8225441240378;584.0392554248323;6799.422049125879;8107.797305067303;8270.421070525006;8275.255227029596;8359.456635318806;522.8292190238544;557.8633234857485;586.3989410853909;597.2892258212713;607.4178301410028;3857.3828187489867;3890.0469385000856;3923.2545816294814;3936.15372694872;3976;93029;93591.53204233936;93834;94892;95768.52115739517;78272.21727782763;79649.60175199086;80845.19154808376;81636;81948.59025704952;69243.65378173077;69393.65303173552;69496.6525167381;70795.99999999897;73259;7488.400927925862;8010;8193.50838949641;8391.748247552583;8428.620712067848;36974;48456.75771621119;48611.75694121648;48988.020239595724;50323;62903.6854815723;65641.67179164074;67038.99441508479;68278.3172168272;68569.62860742658;10145.847812282675;10154.44150571696;10182.032706892833;10301.793964120825;10407.791844163226;11959.76080478403;12004;12080.939595301967;12373.62879113628;12479.87520124787;11559.826602601135;11596.47815848272;11805.291682499077;11824.1131915105;12061.939690301493;10824.783504330027;11058.723531911444;11397.886021140013;11776.76446471083;11971.221870578385;11288.830667539829;11333.320000799979;11359.204855660024;11480.483378248166;11850.288982661068;9407.717768466957;9661.033896610565;9787.902120978699;9925.503724813874;10118.645847395306;9556;9692.030796920251;9693.9030609693;9751.658691945748;9788.265880058882 09:31:46 INFO - PROCESS | 2757 | __end_tp_report 09:31:46 INFO - PROCESS | 2757 | __start_cc_report 09:31:46 INFO - PROCESS | 2757 | _x_x_mozilla_cycle_collect,398 09:31:46 INFO - PROCESS | 2757 | __end_cc_report 09:31:46 INFO - PROCESS | 2757 | __startTimestamp1468600306403__endTimestamp 09:31:46 INFO - PROCESS | 2757 | 09:31:46 INFO - PROCESS | 2757 | ------- Summary: start ------- 09:31:46 INFO - PROCESS | 2757 | Number of tests: 6 09:31:46 INFO - PROCESS | 2757 | 09:31:46 INFO - PROCESS | 2757 | [#0] dojo.html Cycles:165 Average:5799.61 Median:6154.75 stddev:725.67 (11.8%) stddev-sans-first:689.91 09:31:46 INFO - PROCESS | 2757 | Values: 2845.9 3172.5 3500.6 3671.4 3728.9 5855.5 5923.7 5958.9 5966.3 5976.2 4465.7 5864.6 5911.6 5988.9 6015.0 5253.4 5282.7 5396.1 5431.5 5444.7 3924.8 4354.4 4596.8 4921.6 4939.0 5272.9 5338.4 5357.9 5447.8 5480.3 4297.7 4445.8 5431.8 5434.6 5485.9 5273.6 5325.8 5391.2 5395.8 5411.1 4718.8 4917.0 5088.2 5647.7 5819.7 6234.1 6256.7 6276.8 6277.5 6299.7 6202.2 6337.7 6351.9 6354.1 6387.6 4777.4 5960.3 6004.5 6072.0 6099.9 6304.9 6317.7 6352.4 6359.7 6363.9 6203.1 6280.1 6294.8 6330.1 6349.5 6284.0 6286.5 6291.5 6300.7 6334.9 6245.5 6262.4 6265.6 6273.8 6279.2 6217.0 6220.3 6254.8 6265.5 6282.6 4632.8 4948.9 4993.4 4997.3 5005.9 4557.1 4566.6 4574.1 4575.7 4582.5 5813.2 5961.0 5980.9 5988.0 6101.7 6297.1 6320.9 6323.7 6325.3 6346.0 6090.5 6114.2 6117.7 6140.5 6143.1 5452.5 5532.0 5536.9 5591.1 5654.9 6395.6 6440.6 6442.0 6448.4 6464.0 6235.3 6271.7 6279.8 6287.5 6288.5 6297.3 6398.0 6440.0 6470.4 6489.3 6271.5 6285.9 6295.7 6302.1 6305.6 6187.9 6238.7 6281.1 6282.2 6283.3 6185.5 6233.1 6269.0 6286.7 6289.3 6090.4 6253.9 6269.9 6284.6 6321.2 6085.4 6134.8 6160.4 6211.9 6214.8 4833.5 5235.4 6131.1 6154.8 6165.0 6128.2 6202.9 6208.7 6218.9 6232.3 09:31:46 INFO - PROCESS | 2757 | 09:31:46 INFO - PROCESS | 2757 | [#1] ext.html Cycles:180 Average:66937.38 Median:38379.02 stddev:151131.34 (393.8%) stddev-sans-first:151473.06 09:31:46 INFO - PROCESS | 2757 | Values: 529.8 563.9 580.2 600.3 611.1 30406.0 39712.0 39725.6 39751.4 39808.4 41760.8 42003.8 42222.8 42233.8 42383.6 9530.1 9710.0 9721.1 9727.0 9760.4 9547.3 9746.6 9755.6 9760.4 9788.3 9675.1 9726.9 9736.0 9757.8 9823.3 9701.0 9751.4 9755.9 9778.8 9811.0 9620.1 9725.5 9737.0 9739.9 9759.9 40369.8 40576.6 40698.4 40742.0 40756.2 3275.4 3322.6 3344.0 3451.5 3495.8 27173.7 28911.7 29675.1 30510.5 30678.7 2782.1 2812.3 2832.1 2837.5 2840.3 286275.0 356415.0 363083.0 363274.0 365273.0 37517.4 38046.6 63474.0 63843.4 63878.7 35598.0 36491.9 36594.8 36696.8 36811.4 15415.8 15491.3 15884.8 15953.4 16168.9 13349.9 13443.2 13445.9 13469.7 13489.9 7963.6 8069.9 8254.3 8414.5 8465.1 3374.9 3568.8 3621.4 3645.9 3661.9 1043.2 1050.6 1069.6 1139.0 1166.4 25498.0 29683.7 30238.9 30759.7 30858.0 1104.9 1160.4 1235.4 1248.3 1281.8 12419.0 15624.3 15792.7 16065.0 16085.4 642860.0 696140.0 698377.0 707590.0 708421.0 49656.0 60178.1 61480.7 61549.4 62179.7 1570.8 1583.9 1587.4 1596.7 1597.4 29154.9 30276.7 30380.4 30679.7 31012.8 45492.0 53026.0 54403.5 54777.5 54971.2 514675.0 610042.0 610189.9 610571.0 611097.0 28623.3 28823.9 29156.4 46279.0 46985.0 45432.0 46961.0 47204.0 47456.1 47918.5 38684.0 38752.0 39014.0 39370.4 39832.4 34630.3 35666.6 37974.1 38106.6 38991.4 35372.1 38651.4 39072.6 39658.8 40270.8 32055.0 32410.1 32986.0 33156.2 33249.5 21203.3 21488.1 25077.9 25314.4 25707.9 09:31:46 INFO - PROCESS | 2757 | 09:31:46 INFO - PROCESS | 2757 | [#2] jquery.html Cycles:180 Average:34936.64 Median:2122.14 stddev:98875.46 (4659.2%) stddev-sans-first:99118.74 09:31:46 INFO - PROCESS | 2757 | Values: 352.9 403.1 416.6 417.1 424.6 15885.0 20579.7 21274.4 21301.0 21534.9 20400.8 20571.6 20714.9 20968.4 21545.8 6015.3 6052.8 6077.3 6276.2 6280.6 6082.8 6101.0 6105.0 6187.0 6225.9 5757.8 6051.5 6092.6 6099.6 6162.0 6003.2 6005.0 6012.1 6111.5 6125.8 4603.2 5358.5 5693.8 5884.2 6016.5 13798.7 13861.7 13930.4 14024.8 14114.3 2205.5 2247.2 2294.0 2790.7 2854.5 10277.5 10943.0 14105.7 14674.0 15224.2 1742.9 1756.9 1818.7 1851.7 1865.2 119775.0 123434.0 125820.4 126491.0 126847.0 11769.3 11850.0 12167.5 12316.0 12354.9 14896.2 15279.4 15301.4 15391.2 15400.2 9105.3 9279.5 9285.5 9359.8 9379.0 9189.6 9190.0 9380.4 9387.6 9449.6 4836.4 4857.5 4861.1 4923.8 4963.5 1804.8 1888.3 1995.9 2118.8 2125.4 923.8 1021.9 1026.5 1033.6 1035.8 17267.0 20273.6 21290.4 21300.8 21423.6 925.9 1017.9 1021.4 1022.3 1025.2 10629.8 10959.4 10975.5 11162.6 11230.3 553164.0 559273.0 567292.0 611924.0 651183.0 109733.0 124439.0 144514.0 145274.0 148981.0 896.7 908.4 1042.6 1047.8 1070.7 18281.3 18525.0 18753.9 18924.3 18981.7 49611.0 51535.7 51823.0 54617.5 56178.7 57115.0 74802.3 80995.2 82182.2 83538.6 6607.8 7975.9 8260.0 8293.8 8456.1 9241.2 12062.2 12766.3 12937.0 13032.7 11080.5 11155.2 11164.1 11302.7 11526.7 11032.3 11151.6 11218.2 11219.8 11331.3 9119.8 11420.3 11703.8 11721.8 11755.2 8314.7 8317.2 8398.9 8500.9 8650.6 11133.7 11317.8 11333.0 11368.4 11518.5 09:31:46 INFO - PROCESS | 2757 | 09:31:46 INFO - PROCESS | 2757 | [#3] mootools.html Cycles:180 Average:5989.63 Median:479.04 stddev:3352.59 (699.9%) stddev-sans-first:3345.89 09:31:46 INFO - PROCESS | 2757 | Values: 1616.9 1618.1 1627.0 1907.9 1998.8 8405.1 9157.0 9181.6 9385.3 9433.8 7647.6 9168.7 9265.2 9288.2 9294.8 2555.4 2559.9 2565.4 2584.8 2592.8 2364.7 2559.4 2582.3 2594.8 2598.8 2568.2 2577.7 2580.8 2603.7 2612.6 2580.8 2585.9 2609.8 2616.8 2625.1 2557.1 2576.6 2606.9 2615.2 2620.9 9283.6 9290.5 9387.3 9411.2 9439.5 5669.9 5670.4 5827.6 5833.5 5865.1 3686.0 3744.2 3757.1 3782.7 3822.8 1041.1 1046.4 1063.2 1098.2 1105.3 12329.8 12580.4 12630.3 12648.2 12684.2 4235.5 5023.5 5121.2 5146.0 5169.3 10487.1 10579.7 10686.7 10686.9 10721.1 5650.9 5735.2 5771.5 5794.1 5799.8 4657.4 5100.3 5169.0 5207.8 5211.7 4301.1 4325.0 4336.4 4368.8 4423.1 1286.5 1402.2 1433.8 1451.2 1460.8 945.0 975.3 976.1 979.0 986.7 6012.6 6113.3 6250.5 6253.7 6268.3 467.1 473.9 477.4 480.7 485.2 3890.9 4092.7 4122.5 4160.5 4207.0 11124.9 11255.2 11389.9 11412.3 11504.3 11057.0 11208.0 11260.3 11330.7 11358.5 8296.8 8508.1 8532.5 8570.2 8606.4 5851.7 6061.8 6144.4 6158.4 6189.8 9994.8 10111.9 10212.2 10236.9 10282.9 8347.6 10038.5 10310.2 10478.4 10827.7 7139.3 7612.6 7841.6 7948.2 8081.1 8636.2 8636.5 8661.7 8672.1 8691.8 7556.9 7672.7 7694.1 7726.8 7824.0 7546.1 7547.4 7569.6 7662.5 7688.2 7400.6 7422.3 7426.9 7447.1 7456.0 4670.2 4715.0 4887.8 5088.1 5129.8 4755.5 5161.6 5217.4 5297.2 5432.4 09:31:46 INFO - PROCESS | 2757 | 09:31:46 INFO - PROCESS | 2757 | [#4] prototype.html Cycles:180 Average:6127.85 Median:7032.22 stddev:1998.09 (28.4%) stddev-sans-first:1955.88 09:31:46 INFO - PROCESS | 2757 | Values: 339.1 340.1 340.3 345.7 351.2 7066.0 7090.1 7120.0 7123.5 7158.3 7063.4 7065.4 7078.4 7083.1 7105.8 4975.3 5034.7 5168.6 5188.9 5205.2 5145.8 5215.2 5217.9 5221.0 5241.9 5181.1 5182.4 5187.9 5200.6 5225.9 5192.7 5221.1 5225.5 5226.5 5240.8 3624.6 4430.2 4430.5 4445.6 4448.0 5736.6 6614.7 6668.5 6804.3 6804.5 5880.2 6080.2 6083.4 6084.4 6095.4 6061.6 7494.3 7504.1 7531.0 7539.8 4041.7 4899.2 4950.7 4954.6 4978.0 7707.2 7793.9 7947.4 7951.8 7957.3 3923.3 4090.3 4763.4 5001.1 5057.6 5142.7 5151.7 5152.2 5152.9 5161.1 5004.5 5984.8 5999.9 6010.8 6016.0 7522.3 7530.8 7532.1 7532.8 7545.9 1368.9 1544.1 1662.8 1693.1 1732.9 1077.0 1081.3 1093.5 1094.6 1096.9 7001.5 7004.6 7059.8 7061.9 7085.8 7643.4 7741.6 7825.3 7847.8 7860.5 7141.6 7171.8 7184.7 7187.3 7200.4 4126.2 4179.6 4184.7 4199.5 4203.6 8273.0 8275.5 8275.6 8283.2 8292.8 7827.0 8108.2 8118.3 8146.4 8162.1 8059.8 8230.3 8254.5 8282.0 8292.4 5975.7 6984.9 7315.3 7682.7 7945.6 7494.8 7737.1 7750.9 7751.6 7798.5 6971.7 8229.0 8240.6 8243.0 8252.1 4862.5 4892.8 4899.8 4908.7 4924.9 7895.6 7900.5 7902.9 7936.4 7944.3 7307.6 7601.8 7619.2 7627.7 7633.3 6140.4 6842.3 7606.7 7610.3 7617.9 6080.9 6712.9 7414.8 7457.9 7557.4 7578.5 7578.9 7583.5 7600.3 7604.7 6007.0 7070.1 7420.5 7429.9 7439.0 09:31:46 INFO - PROCESS | 2757 | 09:31:46 INFO - PROCESS | 2757 | [#5] yui.html Cycles:180 Average:18475.60 Median:572.66 stddev:25973.89 (4535.6%) stddev-sans-first:26012.45 09:31:46 INFO - PROCESS | 2757 | Values: 697.3 773.1 775.5 784.2 786.1 15452.4 15477.8 15589.0 15598.7 15634.8 14339.8 14362.9 14386.0 14388.1 14416.9 758.1 931.4 937.8 963.2 963.7 841.6 903.8 913.6 939.0 958.3 966.9 998.2 999.6 1014.1 1025.9 869.6 953.4 955.0 960.6 961.8 707.7 724.9 731.2 757.4 758.0 14799.3 14817.9 15051.2 15204.1 15322.2 11235.9 13175.0 13255.8 13290.5 13392.1 10238.3 10329.7 10510.5 10669.0 10745.7 3560.7 3638.9 3642.3 3672.7 3708.3 79652.0 82103.0 82250.2 82849.6 85673.6 9836.5 9871.1 10061.8 10121.6 10186.7 22751.8 23005.2 23136.8 23190.8 23218.1 7714.5 7767.1 7807.8 7820.5 7945.4 4125.2 4213.6 4242.2 4253.5 4262.2 3630.1 3654.2 3681.1 3697.9 3761.0 557.9 652.1 658.6 661.6 665.4 515.9 564.1 581.2 581.8 584.0 6799.4 8107.8 8270.4 8275.3 8359.5 522.8 557.9 586.4 597.3 607.4 3857.4 3890.0 3923.3 3936.2 3976.0 93029.0 93591.5 93834.0 94892.0 95768.5 78272.2 79649.6 80845.2 81636.0 81948.6 69243.7 69393.7 69496.7 70796.0 73259.0 7488.4 8010.0 8193.5 8391.7 8428.6 36974.0 48456.8 48611.8 48988.0 50323.0 62903.7 65641.7 67039.0 68278.3 68569.6 10145.8 10154.4 10182.0 10301.8 10407.8 11959.8 12004.0 12080.9 12373.6 12479.9 11559.8 11596.5 11805.3 11824.1 12061.9 10824.8 11058.7 11397.9 11776.8 11971.2 11288.8 11333.3 11359.2 11480.5 11850.3 9407.7 9661.0 9787.9 9925.5 10118.6 9556.0 9692.0 9693.9 9751.7 9788.3 09:31:46 INFO - PROCESS | 2757 | -------- Summary: end -------- 09:31:46 INFO - PROCESS | 2757 | 09:31:46 INFO - TEST-INFO | 2757: exit 0 09:31:46 INFO - TEST-OK | dromaeo_css | took 1108920ms 09:31:46 INFO - TEST-START | kraken 09:31:46 INFO - operating with platform_type : mac_ 09:31:46 INFO - Initialising browser for kraken test... 09:31:46 INFO - TEST-INFO | started process 2765 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmp2OokL3/profile http://localhost:49322/getInfo.html) 09:31:49 INFO - PROCESS | 2765 | __metrics Screen width/height:1600/1200 09:31:49 INFO - PROCESS | 2765 | colorDepth:24 09:31:49 INFO - PROCESS | 2765 | Browser inner width/height: 1024/689 09:31:49 INFO - PROCESS | 2765 | __metrics 09:31:49 ERROR - PROCESS | 2765 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 09:31:50 INFO - TEST-INFO | 2765: exit 0 09:31:50 INFO - Browser initialized. 09:31:50 INFO - Running cycle 1/1 for kraken test... 09:31:50 INFO - TEST-INFO | started process 2769 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmp2OokL3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:02 INFO - PROCESS | 2769 | RSS: Main: 171024384 09:32:02 INFO - PROCESS | 2769 | 09:32:05 INFO - PROCESS | 2769 | Cycle 1(1): loaded http://localhost:49322/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49322/tests/kraken/driver.html?testName=audio-beat-detection) 09:32:06 INFO - PROCESS | 2769 | RSS: Main: 183816192 09:32:06 INFO - PROCESS | 2769 | 09:32:08 INFO - PROCESS | 2769 | Cycle 1(1): loaded http://localhost:49322/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49322/tests/kraken/driver.html?testName=audio-dft) 09:32:09 INFO - PROCESS | 2769 | RSS: Main: 192581632 09:32:09 INFO - PROCESS | 2769 | 09:32:12 INFO - PROCESS | 2769 | Cycle 1(1): loaded http://localhost:49322/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49322/tests/kraken/driver.html?testName=audio-fft) 09:32:13 INFO - PROCESS | 2769 | RSS: Main: 196530176 09:32:13 INFO - PROCESS | 2769 | 09:32:15 INFO - PROCESS | 2769 | Cycle 1(1): loaded http://localhost:49322/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49322/tests/kraken/driver.html?testName=audio-oscillator) 09:32:15 INFO - PROCESS | 2769 | RSS: Main: 197304320 09:32:15 INFO - PROCESS | 2769 | 09:32:18 INFO - PROCESS | 2769 | Cycle 1(1): loaded http://localhost:49322/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49322/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:32:18 INFO - PROCESS | 2769 | RSS: Main: 197832704 09:32:18 INFO - PROCESS | 2769 | 09:32:21 INFO - PROCESS | 2769 | Cycle 1(1): loaded http://localhost:49322/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49322/tests/kraken/driver.html?testName=imaging-darkroom) 09:32:22 INFO - PROCESS | 2769 | RSS: Main: 198356992 09:32:22 INFO - PROCESS | 2769 | 09:32:24 INFO - PROCESS | 2769 | Cycle 1(1): loaded http://localhost:49322/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49322/tests/kraken/driver.html?testName=imaging-desaturate) 09:32:25 INFO - PROCESS | 2769 | RSS: Main: 198447104 09:32:25 INFO - PROCESS | 2769 | 09:32:28 INFO - PROCESS | 2769 | Cycle 1(1): loaded http://localhost:49322/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49322/tests/kraken/driver.html?testName=json-parse-financial) 09:32:29 INFO - PROCESS | 2769 | RSS: Main: 198557696 09:32:29 INFO - PROCESS | 2769 | 09:32:30 INFO - PROCESS | 2769 | Cycle 1(1): loaded http://localhost:49322/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49322/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:32:31 INFO - PROCESS | 2769 | RSS: Main: 197779456 09:32:31 INFO - PROCESS | 2769 | 09:32:33 INFO - PROCESS | 2769 | Cycle 1(1): loaded http://localhost:49322/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49322/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:32:33 INFO - PROCESS | 2769 | RSS: Main: 197967872 09:32:33 INFO - PROCESS | 2769 | 09:32:35 INFO - PROCESS | 2769 | Cycle 1(1): loaded http://localhost:49322/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49322/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:32:36 INFO - PROCESS | 2769 | RSS: Main: 198184960 09:32:36 INFO - PROCESS | 2769 | 09:32:39 INFO - PROCESS | 2769 | Cycle 1(1): loaded http://localhost:49322/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49322/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:32:40 INFO - PROCESS | 2769 | RSS: Main: 198377472 09:32:40 INFO - PROCESS | 2769 | 09:32:43 INFO - PROCESS | 2769 | Cycle 1(1): loaded http://localhost:49322/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49322/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:32:43 INFO - PROCESS | 2769 | RSS: Main: 198328320 09:32:43 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | Cycle 1(1): loaded http://localhost:49322/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49322/tests/kraken/driver.html?testName=ai-astar) 09:32:45 INFO - PROCESS | 2769 | RSS: Main: 200138752 09:32:45 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | __start_tp_report 09:32:45 INFO - PROCESS | 2769 | _x_x_mozilla_page_load 09:32:45 INFO - PROCESS | 2769 | _x_x_mozilla_page_load_details 09:32:45 INFO - PROCESS | 2769 | |i|pagename|runs| 09:32:45 INFO - PROCESS | 2769 | |0;ai-astar;115;110;162;148;117;131;116;115;97;167 09:32:45 INFO - PROCESS | 2769 | |1;audio-beat-detection;166;125;158;153;117;142;118;159;191;155 09:32:45 INFO - PROCESS | 2769 | |2;audio-dft;188;208;194;199;195;261;272;194;197;199 09:32:45 INFO - PROCESS | 2769 | |3;audio-fft;63;71;80;140;57;56;58;64;135;80 09:32:45 INFO - PROCESS | 2769 | |4;audio-oscillator;78;80;124;90;106;125;118;79;78;120 09:32:45 INFO - PROCESS | 2769 | |5;imaging-gaussian-blur;92;90;92;89;94;92;137;130;91;88 09:32:45 INFO - PROCESS | 2769 | |6;imaging-darkroom;95;97;96;96;95;95;95;97;95;97 09:32:45 INFO - PROCESS | 2769 | |7;imaging-desaturate;92;113;118;91;92;89;90;92;90;93 09:32:45 INFO - PROCESS | 2769 | |8;json-parse-financial;62;65;66;66;65;65;66;82;64;61 09:32:45 INFO - PROCESS | 2769 | |9;json-stringify-tinderbox;62;66;69;64;76;79;99;95;93;66 09:32:45 INFO - PROCESS | 2769 | |10;stanford-crypto-aes;81;75;73;80;79;93;107;108;104;87 09:32:45 INFO - PROCESS | 2769 | |11;stanford-crypto-ccm;124;147;141;148;138;129;148;147;157;154 09:32:45 INFO - PROCESS | 2769 | |12;stanford-crypto-pbkdf2;184;168;202;214;172;162;159;162;166;162 09:32:45 INFO - PROCESS | 2769 | |13;stanford-crypto-sha256-iterative;68;66;71;72;87;69;59;98;95;96 09:32:45 INFO - PROCESS | 2769 | __end_tp_report 09:32:45 INFO - PROCESS | 2769 | __start_cc_report 09:32:45 INFO - PROCESS | 2769 | _x_x_mozilla_cycle_collect,1040 09:32:45 INFO - PROCESS | 2769 | __end_cc_report 09:32:45 INFO - PROCESS | 2769 | __startTimestamp1468600365693__endTimestamp 09:32:45 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | ------- Summary: start ------- 09:32:45 INFO - PROCESS | 2769 | Number of tests: 14 09:32:45 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | [#0] ai-astar Cycles:10 Average:127.80 Median:139.50 stddev:23.51 (16.9%) stddev-sans-first:24.47 09:32:45 INFO - PROCESS | 2769 | Values: 115.0 110.0 162.0 148.0 117.0 131.0 116.0 115.0 97.0 167.0 09:32:45 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:156.50 stddev:23.32 (14.9%) stddev-sans-first:23.84 09:32:45 INFO - PROCESS | 2769 | Values: 166.0 125.0 158.0 153.0 117.0 142.0 118.0 159.0 191.0 155.0 09:32:45 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | [#2] audio-dft Cycles:10 Average:210.70 Median:199.00 stddev:29.96 (15.1%) stddev-sans-first:30.63 09:32:45 INFO - PROCESS | 2769 | Values: 188.0 208.0 194.0 199.0 195.0 261.0 272.0 194.0 197.0 199.0 09:32:45 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | [#3] audio-fft Cycles:10 Average:80.40 Median:63.50 stddev:31.34 (49.4%) stddev-sans-first:32.60 09:32:45 INFO - PROCESS | 2769 | Values: 63.0 71.0 80.0 140.0 57.0 56.0 58.0 64.0 135.0 80.0 09:32:45 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | [#4] audio-oscillator Cycles:10 Average:99.80 Median:78.00 stddev:20.74 (26.6%) stddev-sans-first:20.44 09:32:45 INFO - PROCESS | 2769 | Values: 78.0 80.0 124.0 90.0 106.0 125.0 118.0 79.0 78.0 120.0 09:32:45 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | [#5] imaging-gaussian-blur Cycles:10 Average:99.50 Median:91.50 stddev:18.08 (19.8%) stddev-sans-first:18.97 09:32:45 INFO - PROCESS | 2769 | Values: 92.0 90.0 92.0 89.0 94.0 92.0 137.0 130.0 91.0 88.0 09:32:45 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | [#6] imaging-darkroom Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.93 09:32:45 INFO - PROCESS | 2769 | Values: 95.0 97.0 96.0 96.0 95.0 95.0 95.0 97.0 95.0 97.0 09:32:45 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:91.50 stddev:10.41 (11.4%) stddev-sans-first:10.94 09:32:45 INFO - PROCESS | 2769 | Values: 92.0 113.0 118.0 91.0 92.0 89.0 90.0 92.0 90.0 93.0 09:32:45 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:65.50 stddev:5.81 (8.9%) stddev-sans-first:5.96 09:32:45 INFO - PROCESS | 2769 | Values: 62.0 65.0 66.0 66.0 65.0 65.0 66.0 82.0 64.0 61.0 09:32:45 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | [#9] json-stringify-tinderbox Cycles:10 Average:76.90 Median:77.50 stddev:14.02 (18.1%) stddev-sans-first:13.79 09:32:45 INFO - PROCESS | 2769 | Values: 62.0 66.0 69.0 64.0 76.0 79.0 99.0 95.0 93.0 66.0 09:32:45 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:79.50 stddev:13.44 (16.9%) stddev-sans-first:13.97 09:32:45 INFO - PROCESS | 2769 | Values: 81.0 75.0 73.0 80.0 79.0 93.0 107.0 108.0 104.0 87.0 09:32:45 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:147.50 stddev:10.46 (7.1%) stddev-sans-first:8.44 09:32:45 INFO - PROCESS | 2769 | Values: 124.0 147.0 141.0 148.0 138.0 129.0 148.0 147.0 157.0 154.0 09:32:45 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:170.00 stddev:18.95 (11.1%) stddev-sans-first:19.83 09:32:45 INFO - PROCESS | 2769 | Values: 184.0 168.0 202.0 214.0 172.0 162.0 159.0 162.0 166.0 162.0 09:32:45 INFO - PROCESS | 2769 | 09:32:45 INFO - PROCESS | 2769 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.10 Median:79.50 stddev:14.39 (18.1%) stddev-sans-first:14.80 09:32:45 INFO - PROCESS | 2769 | Values: 68.0 66.0 71.0 72.0 87.0 69.0 59.0 98.0 95.0 96.0 09:32:45 INFO - PROCESS | 2769 | -------- Summary: end -------- 09:32:45 INFO - PROCESS | 2769 | 09:32:46 INFO - TEST-INFO | 2769: exit 0 09:32:46 INFO - TEST-OK | kraken | took 59620ms 09:32:46 INFO - SUITE-END | took 1168s 09:32:46 INFO - Completed test suite (00:19:28) 09:32:46 INFO - javascript benchmark 09:32:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2845.8861645534175, 3172.524121381791, 3500.597431295401, 3671.4125739881606, 3728.944065839013, 5855.5022823060035, 5923.703814809259, 5958.851028724284, 5966.3138739045025, 5976.193213916131, 4465.7320560766375, 5864.5894787364905, 5911.645301281927, 5988.9101663475085, 6015.0, 5253.423972808161, 5282.656627319231, 5396.1096419091, 5431.4840090191565, 5444.700541470217, 3924.7841368724708, 4354.433923589945, 4596.793144308497, 4921.606271498272, 4938.950610493903, 5272.894542109156, 5338.412774594811, 5357.892842143175, 5447.809326673567, 5480.342358916935, 4297.699161058727, 4445.799939002736, 5431.809886653988, 5434.619576629638, 5485.862853428656, 5273.551748101416, 5325.760340784674, 5391.16436952273, 5395.757190926418, 5411.053065713524, 4718.787654555554, 4916.992016636581, 5088.160453525164, 5647.661140331552, 5819.6508209507565, 6234.127222188898, 6256.655883926383, 6276.811695649138, 6277.497800175975, 6299.716512756937, 6202.19371481709, 6337.651429171394, 6351.872962540723, 6354.078658594478, 6387.648679322635, 4777.402824646919, 5960.344362120163, 6004.489618382443, 6071.969640151771, 6099.878002439971, 6304.936950630435, 6317.747290108436, 6352.428281454691, 6359.745610175633, 6363.872722545616, 6203.100550420164, 6280.0893870389455, 6294.779682711083, 6330.113784070234, 6349.52378571609, 6284.025975973731, 6286.465650419674, 6291.496680265659, 6300.653464059521, 6334.873302533923, 6245.469135123565, 6262.405071518198, 6265.592736472115, 6273.780417685359, 6279.246490421178, 6216.968915155395, 6220.315765265817, 6254.843628909313, 6265.530085243625, 6282.591631543935, 4632.791524381343, 4948.851534453972, 4993.350864387607, 4997.30037794709, 5005.874853128628, 4557.134144512532, 4566.611837993808, 4574.062317224961, 4575.748333841604, 4582.473015603182, 5813.186153938452, 5961.0, 5980.8803823924145, 5987.970060149672, 6101.664408457489, 6297.118403423525, 6320.936790632035, 6323.683815809191, 6325.304216536178, 6346.048092786119, 6090.543209259235, 6114.2357205349335, 6117.724702388403, 6140.478059365004, 6143.109249158936, 5452.509274165344, 5532.0, 5536.861578460571, 5591.10542313228, 5654.943450565524, 6395.616263024233, 6440.6135631862235, 6442.0014897690935, 6448.419642232222, 6463.967680161663, 6235.251769787655, 6271.6550589718, 6279.780207692892, 6287.528435367457, 6288.496920246461, 6297.338779428094, 6397.96801015992, 6439.967800160969, 6470.417662410406, 6489.318621544669, 6271.498280137487, 6285.874282514415, 6295.748170073329, 6302.117703521602, 6305.5901366411035, 6187.907181392373, 6238.6880655967925, 6281.120643109877, 6282.246130464374, 6283.3088360281245, 6185.536084793748, 6233.096201050913, 6269.0, 6286.717097730704, 6289.339619339903, 6090.421409966046, 6253.874922501615, 6269.905951410824, 6284.591501552384, 6321.209848768904, 6085.361037091218, 6134.8159555213415, 6160.44555989963, 6211.9068213975925, 6214.751409943552, 4833.540813622701, 5235.397929238034, 6131.0708424985305, 6154.753809847556, 6165.0, 6128.203333566787, 6202.937970620416, 6208.72060757258, 6218.875622487615, 6232.283287422005], "value": 5751.642032558823, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.8066205834871, 563.9013172694778, 580.2369883603062, 600.2586805295457, 611.0528680545154, 30406.0, 39712.0, 39725.60274397255, 39751.40372894409, 39808.40287395691, 41760.791196044054, 42003.789981050126, 42222.788886055525, 42233.788831055805, 42383.57616423835, 9530.142287194169, 9710.028997100304, 9721.125098741111, 9726.951365243163, 9760.414375137514, 9547.331686781929, 9746.610135594568, 9755.560999754993, 9760.365576237557, 9788.265880058989, 9675.080867317594, 9726.854097188549, 9735.97772233916, 9757.804843903117, 9823.312368134233, 9701.029897010312, 9751.366161199534, 9755.902440975642, 9778.804423911517, 9811.0, 9620.086091821266, 9725.465099419529, 9736.95131524345, 9739.902600974041, 9759.90240097597, 40369.79815100935, 40576.59423405758, 40698.38952415716, 40741.98145046397, 40756.18487630261, 3275.4431746603136, 3322.551455553518, 3344.0302312329395, 3451.534042904226, 3495.755297129202, 27173.728262717515, 28911.71088289111, 29675.109746707632, 30510.54234186489, 30678.693213067807, 2782.0541016054435, 2812.2969257685577, 2832.065418411919, 2837.531807251801, 2840.2899275181203, 286275.0, 356415.0, 363083.0, 363274.0, 365273.0, 37517.437238441446, 38046.61953380431, 63474.0, 63843.36156638374, 63878.6806065976, 35598.0, 36491.90524284276, 36594.8170259147, 36696.81651591778, 36811.447828282595, 15415.845841541666, 15491.302891369915, 15884.76172857408, 15953.441629542911, 16168.919155404383, 13349.866501335056, 13443.193408395528, 13445.865541344658, 13469.663258418617, 13489.865101348862, 7963.601819908981, 8069.919300806917, 8254.339652827879, 8414.537200453911, 8465.111163327885, 3374.9493757593655, 3568.768774772699, 3621.4386770050683, 3645.85416583339, 3661.9450708239397, 1043.2332235806675, 1050.5797680927537, 1069.5721711315537, 1138.9863021910505, 1166.4051333819643, 25498.0, 29683.703162968526, 30238.941637042597, 30759.69240307613, 30858.0, 1104.9226554141294, 1160.4081918221768, 1235.3761350517932, 1248.2822377133184, 1281.814136950137, 12419.0, 15624.296906639229, 15792.684146317239, 16065.036097834167, 16085.356585736674, 642860.0, 696140.0, 698377.0, 707590.0, 708421.0, 49656.0, 60178.097328540105, 61480.69259653673, 61549.384506155264, 62179.689101554206, 1570.803649543807, 1583.8891277610687, 1587.4364600566864, 1596.6567188054623, 1597.3770229610461, 29154.854225729585, 30276.69723302739, 30380.392392152477, 30679.693203067683, 31012.844935775178, 45492.0, 53026.0, 54403.45596543984, 54777.45222547724, 54971.175432367745, 514675.0, 610042.0, 610189.9490502519, 610571.0, 611097.0, 28623.284417889718, 28823.85588072046, 29156.416871662874, 46279.0, 46985.0, 45432.0, 46961.0, 47204.0, 47456.05087898292, 47918.52081479141, 38684.0, 38752.03119921912, 39014.0, 39370.40944385894, 39832.40251396174, 34630.30739385248, 35666.64333356633, 37974.050648734, 38106.61893381031, 38991.41512877366, 35372.11569710778, 38651.42022869603, 39072.6092739069, 39658.80170599128, 40270.79864600658, 32055.0, 32410.12966045156, 32986.010419687445, 33156.1710957228, 33249.501257480675, 21203.257885973915, 21488.09820849319, 25077.87461062683, 25314.367140821625, 25707.86382758679], "value": 18967.86575873068, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.89942366425544, 403.0669001262078, 416.58965918570203, 417.0699340470752, 424.5902703890746, 15885.0, 20579.691304630425, 21274.36176914693, 21300.99999999998, 21534.89232553839, 20400.795992040075, 20571.588568228628, 20714.89642551785, 20968.370948871558, 21545.784542154575, 6015.308239552442, 6052.757889684407, 6077.301110372297, 6276.152719382893, 6280.623162610258, 6082.787102451415, 6100.962836317814, 6105.023196288595, 6187.0, 6225.941589929723, 5757.827265182052, 6051.455369016788, 6092.60398074126, 6099.603525770833, 6162.014077747562, 6003.159557661931, 6005.0, 6012.128241404972, 6111.480524155452, 6125.816225513219, 4603.217453032992, 5358.517733403974, 5693.800716974886, 5884.235049443588, 6016.4885984691355, 13798.724025519534, 13861.653458663613, 13930.37313320903, 14024.789628155586, 14114.294285285798, 2205.5368372641765, 2247.235939780466, 2293.9885300573555, 2790.6651201855907, 2854.5290027145497, 10277.537510812032, 10943.0, 14105.717885642332, 14674.0, 15224.238788060664, 1742.8779985401027, 1756.8770186086979, 1818.7362832389363, 1851.6666999940005, 1865.2259312385345, 119775.0, 123434.0, 125820.37089814583, 126491.0, 126847.0, 11769.293842369485, 11850.0, 12167.513299468099, 12316.0, 12354.938225308815, 14896.180710060835, 15279.388824446898, 15301.387944482318, 15391.230438478255, 15400.152991585346, 9105.271578273721, 9279.489628070385, 9285.535723213812, 9359.766005849908, 9378.95310523443, 9189.586468608928, 9189.95405022984, 9380.390274632127, 9387.57755900986, 9449.622015119456, 4836.371271734652, 4857.465678775332, 4861.1006963711825, 4923.803047878045, 4963.5036496350795, 1804.8285412885755, 1888.291890541047, 1995.9222020109269, 2118.8304935605115, 2125.4473836802235, 923.8475651517424, 1021.9080282774586, 1026.5072765072657, 1033.607229252894, 1035.8239099352977, 17267.0, 20273.594528109355, 21290.36128916104, 21300.78699212988, 21423.571528569653, 925.8518637018045, 1017.9185665146771, 1021.4433133942019, 1022.2997246885907, 1025.236199031726, 10629.84055239172, 10959.397233152094, 10975.451227438596, 11162.553497860157, 11230.3261804292, 553164.0, 559273.0, 567292.0, 611924.0, 651183.0, 109733.0, 124439.0, 144514.0, 145274.0, 148981.0, 896.6951236579595, 908.418612088264, 1042.6402891002592, 1047.8428235764695, 1070.743021674808, 18281.266330557693, 18525.0, 18753.906230469307, 18924.337648182798, 18981.71527427062, 49611.00777984348, 51535.742321288155, 51823.0, 54617.53428218632, 56178.719106404205, 57115.0, 74802.25197747952, 80995.19004809877, 82182.17817821745, 83538.5823070905, 6607.843627365288, 7975.880361794694, 8260.0, 8293.83412331762, 8456.112108228548, 9241.21449676785, 12062.215955962834, 12766.29785361814, 12937.0, 13032.674183145118, 11080.501377437873, 11155.163362747664, 11164.106871450102, 11302.717432064264, 11526.711832203926, 11032.28290161137, 11151.553937842395, 11218.158638102012, 11219.775604488028, 11331.32012079278, 9119.772005699646, 11420.257683250562, 11703.76592468129, 11721.824172637587, 11755.235909665844, 8314.708985185489, 8317.168283171877, 8398.87401688963, 8500.872486912825, 8650.610722517627, 11133.665990020312, 11317.830232546683, 11333.0, 11368.374739389414, 11518.481668324777], "value": 9706.656142473988, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1616.8787340949432, 1618.0938674342365, 1626.9755953660695, 1907.9427617171482, 1998.7801341852385, 8405.117462666423, 9157.0, 9181.632734690613, 9385.343025988192, 9433.81132377352, 7647.579383133925, 9168.724938251846, 9265.166135047844, 9288.210502107311, 9294.767630809216, 2555.4250293683867, 2559.9360015999564, 2565.384307766132, 2584.819062665614, 2592.8055395845295, 2364.7280562735245, 2559.4241295708503, 2582.328594565417, 2594.766471017608, 2598.8050896182767, 2568.191019828748, 2577.7164511903675, 2580.8193426460157, 2603.6745406824148, 2612.647292615501, 2580.8193426460157, 2585.857777822219, 2609.8173127881055, 2616.816822822403, 2625.133705877056, 2557.079451397514, 2576.561984462646, 2606.9478610427686, 2615.163147792707, 2620.882060307291, 9283.628654853797, 9290.535473226379, 9387.295952803566, 9411.200047995928, 9439.480828554426, 5669.858253543694, 5670.432956704338, 5827.621204621729, 5833.474987251126, 5865.090910908816, 3685.963140368589, 3744.2324323513612, 3757.0982964088694, 3782.7352085354037, 3822.751521151144, 1041.1046500009986, 1046.3983209654402, 1063.186662203415, 1098.181854518389, 1105.2539535813373, 12329.753404931851, 12580.370981450891, 12630.30533320667, 12648.241105533605, 12684.23894566329, 4235.4917409911, 5023.472535383805, 5121.155009423478, 5145.974270128625, 5169.302144210484, 10487.108595769445, 10579.735506612396, 10686.732831679115, 10686.946565267124, 10721.088707459954, 5650.943490565041, 5735.2257445245195, 5771.451712087345, 5794.1308803679785, 5799.768009279666, 4657.417822772153, 5100.336956195745, 5168.992046550887, 5207.791688332424, 5211.687298762086, 4301.07526881722, 4325.0, 4336.4145840311785, 4368.759718215465, 4423.1153769246275, 1286.4532573656159, 1402.2217669193492, 1433.8351089624618, 1451.1945870042016, 1460.8247010358825, 944.9763755906157, 975.2685485885586, 976.0776066616979, 978.9657361992296, 986.7342375913038, 6012.609180403259, 6113.296970848321, 6250.531125185577, 6253.6560489172625, 6268.310485846553, 467.14512442230637, 473.9336492890998, 477.3508029080517, 480.7259861878696, 485.1945770021747, 3890.8638197662945, 4092.6930480214105, 4122.505299364096, 4160.500739911169, 4206.978965105155, 11124.888751112385, 11255.212135150625, 11389.943050284695, 11412.258203216765, 11504.309741415542, 11057.0, 11208.0, 11260.324380537195, 11330.716732081764, 11358.54565817358, 8296.792580185544, 8508.149185081442, 8532.488050716853, 8570.228679418882, 8606.354523410644, 5851.736671849691, 6061.848453788691, 6144.354842741448, 6158.414950579688, 6189.783357582463, 9994.750131246778, 10111.949440252753, 10212.234082443698, 10236.897631023594, 10282.897171028193, 8347.58262086881, 10038.49037740565, 10310.175185985254, 10478.37129772216, 10827.675169744605, 7139.286071393027, 7612.619369031637, 7841.647125879464, 7948.244916732901, 8081.111077781557, 8636.222739953435, 8636.524991125298, 8661.653533858575, 8672.132786721277, 8691.826163476822, 7556.924430755622, 7672.6547305372505, 7694.07671079474, 7726.845463090819, 7824.021997250344, 7546.132194797449, 7547.396208303432, 7569.583672897823, 7662.463627546018, 7688.192739762469, 7400.629968501661, 7422.294881986203, 7426.888596670946, 7447.143578488543, 7455.962720186364, 4670.1827180244, 4714.98627795012, 4887.7556122194455, 5088.084144853962, 5129.7691603877165, 4755.524447555217, 5161.561267292172, 5217.426083130928, 5297.231901374202, 5432.375276843056], "value": 4757.5474397992975, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.1047634245591, 340.1292690711778, 340.31256861140497, 345.7406944791406, 351.2132822477651, 7065.964670176649, 7090.149182098149, 7120.0, 7123.53697009694, 7158.319959603842, 7063.399611033068, 7065.374963758326, 7078.433725301977, 7083.079199704031, 7105.8223544411285, 4975.278584605239, 5034.748262586874, 5168.638195326329, 5188.92216616751, 5205.16717325228, 5145.845624631248, 5215.1655735082395, 5217.869553261161, 5221.0, 5241.86895327616, 5181.1192097343355, 5182.4299327073995, 5187.948120518803, 5200.583953283728, 5225.921611175835, 5192.71440070796, 5221.086309895772, 5225.451327610622, 5226.477352264781, 5240.842774716745, 3624.58317293512, 4430.1582699287355, 4430.468343798732, 4445.599896009342, 4448.043670610834, 5736.627119237278, 6614.669266536654, 6668.466522678174, 6804.285550017276, 6804.489663275274, 5880.176775251468, 6080.209572755558, 6083.361247069039, 6084.39156084388, 6095.3904609538695, 6061.605995610271, 7494.325510704009, 7504.061992250969, 7531.020967274274, 7539.773806785805, 4041.717079804415, 4899.167141585904, 4950.702957822542, 4954.578860796837, 4977.950220497785, 7707.190744971754, 7793.922060779433, 7947.443678942476, 7951.840963180762, 7957.283844453969, 3923.3330333843314, 4090.2637525245145, 4763.403630259201, 5001.149804533238, 5057.6459647824295, 5142.71715055668, 5151.6908985461, 5152.201408781645, 5152.92270615941, 5161.09680805865, 5004.47453017428, 5984.790532331347, 5999.910001349983, 6010.819675409744, 6016.007358785839, 7522.285382888617, 7530.811729706801, 7532.09614846211, 7532.7740167795055, 7545.924540754632, 1368.931553422325, 1544.050408998458, 1662.783838101039, 1693.060351504902, 1732.9393471228698, 1076.967690969272, 1081.2755453845941, 1093.4642025407652, 1094.6278265389647, 1096.8957948994832, 7001.474889383215, 7004.649767511604, 7059.788206353817, 7061.89407158893, 7085.787426377217, 7643.350315223157, 7741.574213418204, 7825.295723384923, 7847.764567062997, 7860.528368297921, 7141.642917854087, 7171.820704482429, 7184.748533801292, 7187.281271872771, 7200.351968322876, 4126.154138401621, 4179.644730197906, 4184.748915065105, 4199.538050814408, 4203.579642035833, 8273.0, 8275.462094963808, 8275.586220688941, 8283.213094755989, 8292.834143317099, 7826.951616207514, 8108.2297181767635, 8118.2693557580105, 8146.389020823462, 8162.061362943219, 8059.838803223903, 8230.300424463987, 8254.504729716236, 8281.99999999988, 8292.37807164465, 5975.701214939322, 6984.882418812966, 7315.268473152855, 7682.654280557276, 7945.642446089824, 7494.812629684301, 7737.0715514138665, 7750.92249077502, 7751.573663448565, 7798.493097948615, 6971.6862741175755, 8229.0, 8240.587970601326, 8242.958785206276, 8252.092269850431, 4862.489438608895, 4892.755362231803, 4899.804007839646, 4908.705477671351, 4924.852254432372, 7895.64469598858, 7900.486468379537, 7902.881456778038, 7936.444448888522, 7944.324732397811, 7307.561546307238, 7601.821717633776, 7619.161892191743, 7627.733029343946, 7633.313001829862, 6140.416660417253, 6842.315768423317, 7606.657700403606, 7610.315071643578, 7617.885731713918, 6080.939190608215, 6712.865742685021, 7414.814629634302, 7457.925420745723, 7557.35762460175, 7578.545287282781, 7578.886316705364, 7583.469157158946, 7600.315971562586, 7604.733834315773, 6006.9699651503215, 7070.116235470567, 7420.480566360519, 7429.888551671621, 7439.032925719622], "value": 5450.758015311192, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.260903442351, 773.1340898194023, 775.4765533265045, 784.231453175888, 786.1391776005275, 15452.381904723812, 15477.845221547781, 15589.0, 15598.688026239468, 15634.843651563495, 14339.78490322646, 14362.928185359058, 14386.0, 14388.136711797299, 14416.927915360435, 758.1243663568587, 931.38993958957, 937.7843096087904, 963.1716723617683, 963.6579014449875, 841.5750046226647, 903.8101998580273, 913.634546181526, 938.976525586859, 958.3100167879115, 966.912977831995, 998.2114129837456, 999.6201443451479, 1014.0619926567932, 1025.9384436933808, 869.6304070769961, 953.4422362917702, 954.9686338754129, 960.6445615122379, 961.7932144588912, 707.745211723779, 724.9383802376805, 731.1737736357935, 757.4243574883128, 757.9734709285149, 14799.33402996857, 14817.851821481754, 15051.247437628184, 15204.087754734752, 15322.15728134952, 11235.887641123565, 13175.0, 13255.801162982563, 13290.468381264738, 13392.06255562111, 10238.283320167591, 10329.74175645615, 10510.474476276155, 10669.03978641926, 10745.677629671123, 3560.7151427885706, 3638.890833275006, 3642.3261696586214, 3672.669459748609, 3708.2583483303447, 79652.0, 82103.0, 82250.17749822485, 82849.58575207146, 85673.57163214144, 9836.458994755358, 9871.111599955895, 10061.849072263922, 10121.645742398981, 10186.745331366776, 22751.772482275297, 23005.194818181284, 23136.768632313797, 23190.76809231886, 23218.07127714906, 7714.459987800912, 7767.067951845702, 7807.804804879924, 7820.530768153929, 7945.364370850318, 4125.1749650070105, 4213.557576454489, 4242.215190189825, 4253.468316460442, 4262.211490874198, 3630.110622897407, 3654.196076863086, 3681.079730067483, 3697.8890633281044, 3761.0, 557.8856334451427, 652.1066139388972, 658.6431950182639, 661.5964261800298, 665.4343807763363, 515.920839018755, 564.1256053117651, 581.2037508613142, 581.8225441240378, 584.0392554248323, 6799.422049125879, 8107.797305067303, 8270.421070525006, 8275.255227029596, 8359.456635318806, 522.8292190238544, 557.8633234857485, 586.3989410853909, 597.2892258212713, 607.4178301410028, 3857.3828187489867, 3890.0469385000856, 3923.2545816294814, 3936.15372694872, 3976.0, 93029.0, 93591.53204233936, 93834.0, 94892.0, 95768.52115739517, 78272.21727782763, 79649.60175199086, 80845.19154808376, 81636.0, 81948.59025704952, 69243.65378173077, 69393.65303173552, 69496.6525167381, 70795.99999999897, 73259.0, 7488.400927925862, 8010.0, 8193.50838949641, 8391.748247552583, 8428.620712067848, 36974.0, 48456.75771621119, 48611.75694121648, 48988.020239595724, 50323.0, 62903.6854815723, 65641.67179164074, 67038.99441508479, 68278.3172168272, 68569.62860742658, 10145.847812282675, 10154.44150571696, 10182.032706892833, 10301.793964120825, 10407.791844163226, 11959.76080478403, 12004.0, 12080.939595301967, 12373.62879113628, 12479.87520124787, 11559.826602601135, 11596.47815848272, 11805.291682499077, 11824.1131915105, 12061.939690301493, 10824.783504330027, 11058.723531911444, 11397.886021140013, 11776.76446471083, 11971.221870578385, 11288.830667539829, 11333.320000799979, 11359.204855660024, 11480.483378248166, 11850.288982661068, 9407.717768466957, 9661.033896610565, 9787.902120978699, 9925.503724813874, 10118.645847395306, 9556.0, 9692.030796920251, 9693.9030609693, 9751.658691945748, 9788.265880058882], "value": 7002.345830725865, "unit": "score"}], "name": "dromaeo_css", "value": 7597.419628353478, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 162.0, 148.0, 117.0, 131.0, 116.0, 115.0, 97.0, 167.0], "value": 127.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 125.0, 158.0, 153.0, 117.0, 142.0, 118.0, 159.0, 191.0, 155.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 208.0, 194.0, 199.0, 195.0, 261.0, 272.0, 194.0, 197.0, 199.0], "value": 210.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 80.0, 140.0, 57.0, 56.0, 58.0, 64.0, 135.0, 80.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 124.0, 90.0, 106.0, 125.0, 118.0, 79.0, 78.0, 120.0], "value": 99.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 92.0, 89.0, 94.0, 92.0, 137.0, 130.0, 91.0, 88.0], "value": 99.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 95.0, 95.0, 95.0, 97.0, 95.0, 97.0], "value": 95.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 113.0, 118.0, 91.0, 92.0, 89.0, 90.0, 92.0, 90.0, 93.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 82.0, 64.0, 61.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 69.0, 64.0, 76.0, 79.0, 99.0, 95.0, 93.0, 66.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 73.0, 80.0, 79.0, 93.0, 107.0, 108.0, 104.0, 87.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 147.0, 141.0, 148.0, 138.0, 129.0, 148.0, 147.0, 157.0, 154.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 168.0, 202.0, 214.0, 172.0, 162.0, 159.0, 162.0, 166.0, 162.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 71.0, 72.0, 87.0, 69.0, 59.0, 98.0, 95.0, 96.0], "value": 78.1, "unit": "score"}], "name": "kraken", "value": 1586.6999999999998, "alertThreshold": 2.0}]} 09:32:46 INFO - Return code: 0 09:32:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:32:46 ERROR - # TBPL SUCCESS # 09:32:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:32:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:32:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:32:46 INFO - 2016-07-15 09:32:46.992 screenresolution[2774:18994] starting screenresolution argv=screenresolution get 09:32:46 INFO - 2016-07-15 09:32:46.994 screenresolution[2774:18994] Display 0: 1600x1200x32@60 09:32:47 INFO - 2016-07-15 09:32:47.000 screenresolution[2775:18997] starting screenresolution argv=screenresolution list 09:32:47 INFO - Available Modes on Display 0 09:32:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:32:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:32:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:32:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:32:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:32:47 INFO - Intel Iris: 09:32:47 INFO - Chipset Model: Intel Iris 09:32:47 INFO - Type: GPU 09:32:47 INFO - Bus: Built-In 09:32:47 INFO - VRAM (Dynamic, Max): 1536 MB 09:32:47 INFO - Vendor: Intel (0x8086) 09:32:47 INFO - Device ID: 0x0a2e 09:32:47 INFO - Revision ID: 0x0009 09:32:47 INFO - Displays: 09:32:47 INFO - Display: 09:32:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:32:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:32:47 INFO - Display Serial Number: 1600x1200 60 09:32:47 INFO - Main Display: Yes 09:32:47 INFO - Mirror: Off 09:32:47 INFO - Online: Yes 09:32:47 INFO - Rotation: Supported 09:32:47 INFO - Return code: 0 09:32:47 INFO - Running post-action listener: _resource_record_post_action 09:32:47 INFO - Running post-run listener: _resource_record_post_run 09:32:48 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 33021440; Write bytes: 497697280; Read time: 348; Write time: 1938 09:32:48 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 187367936; Write bytes: 186496512; Read time: 17188; Write time: 399 09:32:48 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 31030784; Write bytes: 300407808; Read time: 297; Write time: 1504 09:32:48 INFO - Running post-run listener: _upload_blobber_files 09:32:48 INFO - Blob upload gear active. 09:32:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:32:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:32:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:32:48 INFO - (blobuploader) - INFO - Open directory for files ... 09:32:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:32:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:32:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:49 INFO - (blobuploader) - INFO - Done attempting. 09:32:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:32:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:32:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:50 INFO - (blobuploader) - INFO - Done attempting. 09:32:50 INFO - (blobuploader) - INFO - Iteration through files over. 09:32:50 INFO - Return code: 0 09:32:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:32:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:32:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/890659e47690403425c4399fe2f43244301b14522cb9a7ac81ba21d3388114f78d51e12d0e03b73938cc6f7b6a463cdbe5633380da20cba2dc85e3675dbd4a37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d786732a52315fcf10ac7de47a9759d4c3b71ae969081f68ecf8f8bb79c5033cf4cbf218a882a1d52eeab93496f25c1db800c57dbca6d4eb2270d63100320d70"} 09:32:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:32:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:32:50 INFO - Contents: 09:32:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/890659e47690403425c4399fe2f43244301b14522cb9a7ac81ba21d3388114f78d51e12d0e03b73938cc6f7b6a463cdbe5633380da20cba2dc85e3675dbd4a37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d786732a52315fcf10ac7de47a9759d4c3b71ae969081f68ecf8f8bb79c5033cf4cbf218a882a1d52eeab93496f25c1db800c57dbca6d4eb2270d63100320d70"} 09:32:50 INFO - Running post-run listener: copy_logs_to_upload_dir 09:32:50 INFO - Copying logs to upload dir... 09:32:50 INFO - mkdir: /builds/slave/test/build/upload/logs 09:32:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.479674 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-15 09:32:51.021449) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:51.025315) ========= 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.k2KIpuGxu6/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.NOLrAyD2Zz/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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/890659e47690403425c4399fe2f43244301b14522cb9a7ac81ba21d3388114f78d51e12d0e03b73938cc6f7b6a463cdbe5633380da20cba2dc85e3675dbd4a37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d786732a52315fcf10ac7de47a9759d4c3b71ae969081f68ecf8f8bb79c5033cf4cbf218a882a1d52eeab93496f25c1db800c57dbca6d4eb2270d63100320d70"} build_url:https://queue.taskcluster.net/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010965 build_url: 'https://queue.taskcluster.net/v1/task/TcgGz8s_RH2jCtNbYMLHJQ/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/890659e47690403425c4399fe2f43244301b14522cb9a7ac81ba21d3388114f78d51e12d0e03b73938cc6f7b6a463cdbe5633380da20cba2dc85e3675dbd4a37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d786732a52315fcf10ac7de47a9759d4c3b71ae969081f68ecf8f8bb79c5033cf4cbf218a882a1d52eeab93496f25c1db800c57dbca6d4eb2270d63100320d70"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:51.057602) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:51.057957) ========= 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.k2KIpuGxu6/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.NOLrAyD2Zz/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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.005158 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:51.106574) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 09:32:51.106919) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 09:32:51.107279) ========= ========= Total master_lag: 0.30 =========