builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0190 starttime: 1461680040.12 results: success (0) buildid: 20160426044609 builduid: 02fb4cf5b87449e88c6f8bfc6c2a4e4b revision: 9ce31e9f90cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 07:14:00.115524) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 07:14:00.116052) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 29 secs) (at 2016-04-26 07:14:00.116358) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 29 secs) (at 2016-04-26 07:14:29.309880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2016-04-26 07:14:29.310531) ========= 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.Eex3ethMNk/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.icMvRAxBCA/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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-04-26 07:14:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2016-04-26 07:14:31 (168 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=1.038977 ========= master_lag: 11.47 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2016-04-26 07:14:41.822184) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-04-26 07:14:41.822473) ========= 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.Eex3ethMNk/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.icMvRAxBCA/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.020035 ========= master_lag: 7.80 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-04-26 07:14:49.644333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2016-04-26 07:14:49.644651) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9ce31e9f90cb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9ce31e9f90cb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Eex3ethMNk/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.icMvRAxBCA/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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-04-26 07:14:50,409 Setting DEBUG logging. 2016-04-26 07:14:50,409 attempt 1/10 2016-04-26 07:14:50,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9ce31e9f90cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 07:14:51,485 unpacking tar archive at: mozilla-central-9ce31e9f90cb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.331085 ========= master_lag: 9.75 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2016-04-26 07:15:00.726975) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 07:15:00.727249) ========= script_repo_revision: 9ce31e9f90cb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 07:15:00.727605) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 4 secs) (at 2016-04-26 07:15:00.730906) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 4 secs) (at 2016-04-26 07:15:05.162151) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-04-26 07:15:05.162588) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Eex3ethMNk/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.icMvRAxBCA/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:15:05 INFO - MultiFileLogger online at 20160426 07:15:05 in /builds/slave/test 07:15:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:15:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:15:05 INFO - {'append_to_log': False, 07:15:05 INFO - 'base_work_dir': '/builds/slave/test', 07:15:05 INFO - 'blob_upload_branch': 'Firefox', 07:15:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:15:05 INFO - 'branch': 'Firefox', 07:15:05 INFO - 'buildbot_json_path': 'buildprops.json', 07:15:05 INFO - 'config_files': ('talos/mac_config.py',), 07:15:05 INFO - 'default_actions': ('clobber', 07:15:05 INFO - 'read-buildbot-config', 07:15:05 INFO - 'download-and-extract', 07:15:05 INFO - 'populate-webroot', 07:15:05 INFO - 'create-virtualenv', 07:15:05 INFO - 'install', 07:15:05 INFO - 'run-tests'), 07:15:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:15:05 INFO - 'download_minidump_stackwalk': True, 07:15:05 INFO - 'download_symbols': 'ondemand', 07:15:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:15:05 INFO - 'tooltool.py': '/tools/tooltool.py', 07:15:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:15:05 INFO - '/tools/misc-python/virtualenv.py')}, 07:15:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:15:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:15:05 INFO - 'installer_path': 'installer.exe', 07:15:05 INFO - 'log_level': 'info', 07:15:05 INFO - 'log_name': 'talos', 07:15:05 INFO - 'log_to_console': True, 07:15:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:15:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:15:05 INFO - 'opt_config_files': (), 07:15:05 INFO - 'pip_index': False, 07:15:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:15:05 INFO - 'cmd': ('bash', 07:15:05 INFO - '-c', 07:15:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:15:05 INFO - 'enabled': True, 07:15:05 INFO - 'halt_on_failure': False, 07:15:05 INFO - 'name': 'check_screen_resolution'},), 07:15:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:15:05 INFO - 'cmd': ('bash', 07:15:05 INFO - '-c', 07:15:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:15:05 INFO - 'enabled': True, 07:15:05 INFO - 'halt_on_failure': False, 07:15:05 INFO - 'name': 'check_screen_resolution'},), 07:15:05 INFO - 'run_cmd_checks_enabled': True, 07:15:05 INFO - 'sps_profile': False, 07:15:05 INFO - 'sps_profile_interval': 0, 07:15:05 INFO - 'suite': 'dromaeojs-e10s', 07:15:05 INFO - 'system_bits': '32', 07:15:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:15:05 INFO - 'title': 't-yosemite-r7-0190', 07:15:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:15:05 INFO - 'use_talos_json': True, 07:15:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:15:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:15:05 INFO - 'work_dir': 'build'} 07:15:05 INFO - ##### 07:15:05 INFO - ##### Running clobber step. 07:15:05 INFO - ##### 07:15:05 INFO - Running pre-action listener: _resource_record_pre_action 07:15:05 INFO - Running main action method: clobber 07:15:05 INFO - rmtree: /builds/slave/test/build 07:15:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:15:05 INFO - Running post-action listener: _resource_record_post_action 07:15:05 INFO - ##### 07:15:05 INFO - ##### Running read-buildbot-config step. 07:15:05 INFO - ##### 07:15:05 INFO - Running pre-action listener: _resource_record_pre_action 07:15:05 INFO - Running main action method: read_buildbot_config 07:15:05 INFO - Using buildbot properties: 07:15:05 INFO - { 07:15:05 INFO - "project": "", 07:15:05 INFO - "product": "firefox", 07:15:05 INFO - "script_repo_revision": "production", 07:15:05 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:15:05 INFO - "repository": "", 07:15:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:15:05 INFO - "buildid": "20160426044609", 07:15:05 INFO - "stage_platform": "macosx64", 07:15:05 INFO - "basedir": "/builds/slave/test", 07:15:05 INFO - "nightly_build": "True", 07:15:05 INFO - "buildnumber": 211, 07:15:05 INFO - "slavename": "t-yosemite-r7-0190", 07:15:05 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:15:05 INFO - "platform": "yosemite_r7", 07:15:05 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:15:05 INFO - "branch": "mozilla-central", 07:15:05 INFO - "repo_path": "mozilla-central", 07:15:05 INFO - "revision": "9ce31e9f90cb", 07:15:05 INFO - "pgo_build": "False", 07:15:05 INFO - "builduid": "02fb4cf5b87449e88c6f8bfc6c2a4e4b", 07:15:05 INFO - "slavebuilddir": "test" 07:15:05 INFO - } 07:15:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 07:15:05 INFO - Running post-action listener: _resource_record_post_action 07:15:05 INFO - ##### 07:15:05 INFO - ##### Running download-and-extract step. 07:15:05 INFO - ##### 07:15:05 INFO - Running pre-action listener: _resource_record_pre_action 07:15:05 INFO - Running main action method: download_and_extract 07:15:05 INFO - mkdir: /builds/slave/test/build/tests 07:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:05 INFO - https://queue.taskcluster.net/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:15:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 07:15:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 07:15:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 07:15:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 07:15:15 INFO - Downloaded 1199 bytes. 07:15:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 07:15:15 INFO - Using the following test package requirements: 07:15:15 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 07:15:15 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:15:15 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 07:15:15 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:15:15 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 07:15:15 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:15:15 INFO - u'jsshell-mac.zip'], 07:15:15 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:15:15 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 07:15:15 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 07:15:15 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:15:15 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 07:15:15 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:15:15 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 07:15:15 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:15:15 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 07:15:15 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:15:15 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 07:15:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:15: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')]} 07:15:15 INFO - https://queue.taskcluster.net/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:15:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:15:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:15:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:15:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:15:22 INFO - Downloaded 18114236 bytes. 07:15:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:15:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:15:25 INFO - Return code: 0 07:15:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:25 INFO - https://queue.taskcluster.net/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:15:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:15:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:15:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:15:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:15:27 INFO - Downloaded 18114236 bytes. 07:15:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:15:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:15:31 INFO - Return code: 0 07:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:31 INFO - https://queue.taskcluster.net/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:15:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 07:15:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 07:15:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 07:15:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:15:32 INFO - Downloaded 10840145 bytes. 07:15:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:15:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:15:33 INFO - Return code: 0 07:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:33 INFO - https://queue.taskcluster.net/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:15:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 07:15:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 07:15:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 07:15:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 07:15:36 INFO - Downloaded 110261283 bytes. 07:15:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 07:15:36 INFO - mkdir: /builds/slave/test/properties 07:15:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:15:36 INFO - Writing to file /builds/slave/test/properties/build_url 07:15:36 INFO - Contents: 07:15:36 INFO - build_url:https://queue.taskcluster.net/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 07:15:37 INFO - Running post-action listener: _resource_record_post_action 07:15:37 INFO - Running post-action listener: set_extra_try_arguments 07:15:37 INFO - ##### 07:15:37 INFO - ##### Running populate-webroot step. 07:15:37 INFO - ##### 07:15:37 INFO - Running pre-action listener: _resource_record_pre_action 07:15:37 INFO - Running main action method: populate_webroot 07:15:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:15:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:15:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:15:37 INFO - '--tppagecycles', 07:15:37 INFO - '7'], 07:15:37 INFO - 'tests': ['tsvgm']}}, 07:15:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:15:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:15:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:15:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:15:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:15:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:15:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:37 INFO - 'talos_options': ['--disable-e10s'], 07:15:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:37 INFO - 'talos_options': ['--disable-e10s'], 07:15:37 INFO - 'tests': ['damp', 'tps']}, 07:15:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:37 INFO - 'tests': ['damp', 'tps']}, 07:15:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:15:37 INFO - 'tests': ['dromaeo_dom']}, 07:15:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:15:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:15:37 INFO - 'tests': ['a11yr', 07:15:37 INFO - 'ts_paint', 07:15:37 INFO - 'tpaint', 07:15:37 INFO - 'sessionrestore', 07:15:37 INFO - 'sessionrestore_no_auto_restore', 07:15:37 INFO - 'tabpaint']}, 07:15:37 INFO - 'other-e10s': {'tests': ['a11yr', 07:15:37 INFO - 'ts_paint', 07:15:37 INFO - 'tpaint', 07:15:37 INFO - 'sessionrestore', 07:15:37 INFO - 'sessionrestore_no_auto_restore', 07:15:37 INFO - 'tabpaint']}, 07:15:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:15:37 INFO - 'ts_paint', 07:15:37 INFO - 'tpaint', 07:15:37 INFO - 'sessionrestore', 07:15:37 INFO - 'sessionrestore_no_auto_restore', 07:15:37 INFO - 'tabpaint']}, 07:15:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:15:37 INFO - 'ts_paint', 07:15:37 INFO - 'tpaint', 07:15:37 INFO - 'sessionrestore', 07:15:37 INFO - 'sessionrestore_no_auto_restore', 07:15:37 INFO - 'tabpaint']}, 07:15:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:15:37 INFO - 'tests': ['a11yr', 07:15:37 INFO - 'ts_paint', 07:15:37 INFO - 'tpaint', 07:15:37 INFO - 'sessionrestore', 07:15:37 INFO - 'sessionrestore_no_auto_restore', 07:15:37 INFO - 'tabpaint']}, 07:15:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:15:37 INFO - 'tests': ['a11yr', 07:15:37 INFO - 'ts_paint', 07:15:37 INFO - 'tpaint', 07:15:37 INFO - 'sessionrestore', 07:15:37 INFO - 'sessionrestore_no_auto_restore', 07:15:37 INFO - 'tabpaint']}, 07:15:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:15:37 INFO - 'tests': ['tsvgx', 07:15:37 INFO - 'tsvgr_opacity', 07:15:37 INFO - 'tart', 07:15:37 INFO - 'tscrollx', 07:15:37 INFO - 'cart']}, 07:15:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:15:37 INFO - 'tsvgr_opacity', 07:15:37 INFO - 'tart', 07:15:37 INFO - 'tscrollx', 07:15:37 INFO - 'cart']}, 07:15:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:37 INFO - 'talos_options': ['--disable-e10s'], 07:15:37 INFO - 'tests': ['tp5o']}, 07:15:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:37 INFO - 'tests': ['tp5o']}, 07:15:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:37 INFO - 'talos_options': ['--disable-e10s', 07:15:37 INFO - '--xperf_path', 07:15:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:37 INFO - 'tests': ['tp5n']}, 07:15:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:37 INFO - 'talos_options': ['--xperf_path', 07:15:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:37 INFO - 'tests': ['tp5n']}}, 07:15:37 INFO - 'talos.zip': {'path': '', 07:15:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:15:37 INFO - Running post-action listener: _resource_record_post_action 07:15:37 INFO - ##### 07:15:37 INFO - ##### Running create-virtualenv step. 07:15:37 INFO - ##### 07:15:37 INFO - Running pre-action listener: _resource_record_pre_action 07:15:37 INFO - Running main action method: create_virtualenv 07:15:37 INFO - Creating virtualenv /builds/slave/test/build/venv 07:15:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:15:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:15:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:15:38 INFO - Using real prefix '/tools/python27' 07:15:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:15:38 INFO - Installing distribute.............................................................................................................................................................................................done. 07:15:41 INFO - Installing pip.................done. 07:15:41 INFO - Return code: 0 07:15:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:41 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 0x10460aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10461a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2995757a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a9e00>, '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 0x104312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044a4b20>, '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.Eex3ethMNk/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.icMvRAxBCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:15:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Eex3ethMNk/Render', 07:15:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:41 INFO - 'HOME': '/Users/cltbld', 07:15:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:41 INFO - 'LOGNAME': 'cltbld', 07:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:41 INFO - 'MOZ_NO_REMOTE': '1', 07:15:41 INFO - 'NO_EM_RESTART': '1', 07:15:41 INFO - 'PAGER': '/bin/cat', 07:15:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:41 INFO - 'PWD': '/builds/slave/test', 07:15:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:41 INFO - 'SHELL': '/bin/bash', 07:15:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icMvRAxBCA/Listeners', 07:15:41 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 07:15:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:41 INFO - 'USER': 'cltbld', 07:15:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:41 INFO - 'XPC_FLAGS': '0x0', 07:15:41 INFO - 'XPC_SERVICE_NAME': '0', 07:15:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:15:41 INFO - Cleaning up... 07:15:41 INFO - Return code: 0 07:15:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:41 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 0x10460aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10461a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2995757a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a9e00>, '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 0x104312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044a4b20>, '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.Eex3ethMNk/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.icMvRAxBCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:15:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Eex3ethMNk/Render', 07:15:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:41 INFO - 'HOME': '/Users/cltbld', 07:15:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:41 INFO - 'LOGNAME': 'cltbld', 07:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:41 INFO - 'MOZ_NO_REMOTE': '1', 07:15:41 INFO - 'NO_EM_RESTART': '1', 07:15:41 INFO - 'PAGER': '/bin/cat', 07:15:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:41 INFO - 'PWD': '/builds/slave/test', 07:15:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:41 INFO - 'SHELL': '/bin/bash', 07:15:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icMvRAxBCA/Listeners', 07:15:41 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 07:15:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:41 INFO - 'USER': 'cltbld', 07:15:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:41 INFO - 'XPC_FLAGS': '0x0', 07:15:41 INFO - 'XPC_SERVICE_NAME': '0', 07:15:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:42 INFO - Downloading/unpacking psutil>=0.7.1 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:15:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:45 INFO - Installing collected packages: psutil 07:15:45 INFO - Running setup.py install for psutil 07:15:45 INFO - building 'psutil._psutil_osx' extension 07:15:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:15:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:15:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:15:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:15:46 INFO - building 'psutil._psutil_posix' extension 07:15:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:15:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:15:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:15:46 INFO - ^ 07:15:46 INFO - 1 warning generated. 07:15:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:15:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:46 INFO - Successfully installed psutil 07:15:46 INFO - Cleaning up... 07:15:46 INFO - Return code: 0 07:15:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:46 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 0x10460aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10461a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2995757a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a9e00>, '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 0x104312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044a4b20>, '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.Eex3ethMNk/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.icMvRAxBCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Eex3ethMNk/Render', 07:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:46 INFO - 'HOME': '/Users/cltbld', 07:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:46 INFO - 'LOGNAME': 'cltbld', 07:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:46 INFO - 'MOZ_NO_REMOTE': '1', 07:15:46 INFO - 'NO_EM_RESTART': '1', 07:15:46 INFO - 'PAGER': '/bin/cat', 07:15:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:46 INFO - 'PWD': '/builds/slave/test', 07:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:46 INFO - 'SHELL': '/bin/bash', 07:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icMvRAxBCA/Listeners', 07:15:46 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 07:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:46 INFO - 'USER': 'cltbld', 07:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:46 INFO - 'XPC_FLAGS': '0x0', 07:15:46 INFO - 'XPC_SERVICE_NAME': '0', 07:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:15:49 INFO - Installing collected packages: mozsystemmonitor 07:15:49 INFO - Running setup.py install for mozsystemmonitor 07:15:49 INFO - Successfully installed mozsystemmonitor 07:15:49 INFO - Cleaning up... 07:15:49 INFO - Return code: 0 07:15:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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', '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 0x10460aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10461a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2995757a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a9e00>, '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 0x104312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044a4b20>, '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.Eex3ethMNk/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.icMvRAxBCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:15: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:15: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 blobuploader==1.2.4 07:15:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Eex3ethMNk/Render', 07:15:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:49 INFO - 'HOME': '/Users/cltbld', 07:15:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:49 INFO - 'LOGNAME': 'cltbld', 07:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:49 INFO - 'MOZ_NO_REMOTE': '1', 07:15:49 INFO - 'NO_EM_RESTART': '1', 07:15:49 INFO - 'PAGER': '/bin/cat', 07:15:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:49 INFO - 'PWD': '/builds/slave/test', 07:15:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:49 INFO - 'SHELL': '/bin/bash', 07:15:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icMvRAxBCA/Listeners', 07:15:49 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 07:15:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:49 INFO - 'USER': 'cltbld', 07:15:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:49 INFO - 'XPC_FLAGS': '0x0', 07:15:49 INFO - 'XPC_SERVICE_NAME': '0', 07:15:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:49 INFO - Downloading/unpacking blobuploader==1.2.4 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:52 INFO - Downloading blobuploader-1.2.4.tar.gz 07:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:15:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:15:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:53 INFO - Downloading docopt-0.6.1.tar.gz 07:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:15:53 INFO - Installing collected packages: blobuploader, requests, docopt 07:15:53 INFO - Running setup.py install for blobuploader 07:15:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:15:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:15:53 INFO - Running setup.py install for requests 07:15:54 INFO - Running setup.py install for docopt 07:15:54 INFO - Successfully installed blobuploader requests docopt 07:15:54 INFO - Cleaning up... 07:15:54 INFO - Return code: 0 07:15:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:54 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 0x10460aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10461a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2995757a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a9e00>, '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 0x104312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044a4b20>, '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.Eex3ethMNk/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.icMvRAxBCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:15:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Eex3ethMNk/Render', 07:15:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:54 INFO - 'HOME': '/Users/cltbld', 07:15:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:54 INFO - 'LOGNAME': 'cltbld', 07:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:54 INFO - 'MOZ_NO_REMOTE': '1', 07:15:54 INFO - 'NO_EM_RESTART': '1', 07:15:54 INFO - 'PAGER': '/bin/cat', 07:15:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:54 INFO - 'PWD': '/builds/slave/test', 07:15:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:54 INFO - 'SHELL': '/bin/bash', 07:15:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icMvRAxBCA/Listeners', 07:15:54 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 07:15:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:54 INFO - 'USER': 'cltbld', 07:15:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:54 INFO - 'XPC_FLAGS': '0x0', 07:15:54 INFO - 'XPC_SERVICE_NAME': '0', 07:15:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:54 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-UoxRQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:54 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-OgPJjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:54 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-sPqt7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:54 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-72qZ2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:54 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-UJZ6ET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:55 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-aGCwMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:55 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-lIxiCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:55 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-j5R8OE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:55 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-EjdE4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:55 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-mOih2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:55 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-cLs7DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:55 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-L3hJwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:55 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-3HZYac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:55 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-Vwrq3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:55 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-PO07jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:56 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-yNAxad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:56 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-e8rq9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:15:56 INFO - Running setup.py install for manifestparser 07:15:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:15:56 INFO - Running setup.py install for mozcrash 07:15:56 INFO - Running setup.py install for mozdebug 07:15:56 INFO - Running setup.py install for mozdevice 07:15:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:15:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:15:56 INFO - Running setup.py install for mozfile 07:15:57 INFO - Running setup.py install for mozhttpd 07:15:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:15:57 INFO - Running setup.py install for mozinfo 07:15:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:15:57 INFO - Running setup.py install for mozInstall 07:15:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:15:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:15:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:15:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:15:57 INFO - Running setup.py install for mozleak 07:15:57 INFO - Running setup.py install for mozlog 07:15:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:15:57 INFO - Running setup.py install for moznetwork 07:15:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:15:57 INFO - Running setup.py install for mozprocess 07:15:58 INFO - Running setup.py install for mozprofile 07:15:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:15:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:15:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:15:58 INFO - Running setup.py install for mozrunner 07:15:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:15:58 INFO - Running setup.py install for mozscreenshot 07:15:58 INFO - Running setup.py install for moztest 07:15:58 INFO - Running setup.py install for mozversion 07:15:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:15:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:15:58 INFO - Cleaning up... 07:15:58 INFO - Return code: 0 07:15:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:58 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 0x10460aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10461a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2995757a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a9e00>, '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 0x104312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044a4b20>, '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.Eex3ethMNk/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.icMvRAxBCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:15:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Eex3ethMNk/Render', 07:15:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:58 INFO - 'HOME': '/Users/cltbld', 07:15:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:58 INFO - 'LOGNAME': 'cltbld', 07:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:58 INFO - 'MOZ_NO_REMOTE': '1', 07:15:58 INFO - 'NO_EM_RESTART': '1', 07:15:58 INFO - 'PAGER': '/bin/cat', 07:15:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:58 INFO - 'PWD': '/builds/slave/test', 07:15:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:58 INFO - 'SHELL': '/bin/bash', 07:15:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icMvRAxBCA/Listeners', 07:15:58 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 07:15:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:58 INFO - 'USER': 'cltbld', 07:15:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:58 INFO - 'XPC_FLAGS': '0x0', 07:15:58 INFO - 'XPC_SERVICE_NAME': '0', 07:15:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:59 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-I8iUbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:59 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-QnXXqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:59 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-wc_DX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:59 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-eS1ur2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:59 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-bkMxzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:59 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-U_RDwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:59 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-fWEnFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:59 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-wOmgU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:59 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-b_eYL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:16:00 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-SFQnTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:16:00 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-lvI4Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:16:00 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-iUDjaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:16:00 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-Y9olLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:16:00 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-wSi8J7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:00 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-SNTTeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:16:00 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-f6vf7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:16:00 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-3JPFWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:16:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:03 INFO - Downloading blessings-1.6.tar.gz 07:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:16:03 INFO - Installing collected packages: blessings 07:16:03 INFO - Running setup.py install for blessings 07:16:03 INFO - Successfully installed blessings 07:16:03 INFO - Cleaning up... 07:16:03 INFO - Return code: 0 07:16:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:16:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:03 INFO - Reading from file tmpfile_stdout 07:16:03 INFO - Current package versions: 07:16:03 INFO - blessings == 1.6 07:16:03 INFO - blobuploader == 1.2.4 07:16:03 INFO - docopt == 0.6.1 07:16:03 INFO - manifestparser == 1.1 07:16:03 INFO - mozInstall == 1.12 07:16:03 INFO - mozcrash == 0.17 07:16:03 INFO - mozdebug == 0.1 07:16:03 INFO - mozdevice == 0.48 07:16:03 INFO - mozfile == 1.2 07:16:03 INFO - mozhttpd == 0.7 07:16:03 INFO - mozinfo == 0.9 07:16:03 INFO - mozleak == 0.1 07:16:03 INFO - mozlog == 3.1 07:16:03 INFO - moznetwork == 0.27 07:16:03 INFO - mozprocess == 0.22 07:16:03 INFO - mozprofile == 0.28 07:16:03 INFO - mozrunner == 6.11 07:16:03 INFO - mozscreenshot == 0.1 07:16:03 INFO - mozsystemmonitor == 0.0 07:16:03 INFO - moztest == 0.7 07:16:03 INFO - mozversion == 1.4 07:16:03 INFO - psutil == 3.1.1 07:16:03 INFO - requests == 1.2.3 07:16:03 INFO - wsgiref == 0.1.2 07:16:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:03 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 0x10460aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10461a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2995757a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a9e00>, '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 0x104312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044a4b20>, '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.Eex3ethMNk/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.icMvRAxBCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Eex3ethMNk/Render', 07:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:16:03 INFO - 'HOME': '/Users/cltbld', 07:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:16:03 INFO - 'LOGNAME': 'cltbld', 07:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:03 INFO - 'MOZ_NO_REMOTE': '1', 07:16:03 INFO - 'NO_EM_RESTART': '1', 07:16:03 INFO - 'PAGER': '/bin/cat', 07:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:03 INFO - 'PWD': '/builds/slave/test', 07:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:16:03 INFO - 'SHELL': '/bin/bash', 07:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icMvRAxBCA/Listeners', 07:16:03 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 07:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:16:03 INFO - 'USER': 'cltbld', 07:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:03 INFO - 'XPC_FLAGS': '0x0', 07:16:03 INFO - 'XPC_SERVICE_NAME': '0', 07:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:16:04 INFO - Cleaning up... 07:16:04 INFO - Return code: 0 07:16:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:04 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 0x10460aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10461a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2995757a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a9e00>, '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 0x104312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044a4b20>, '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.Eex3ethMNk/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.icMvRAxBCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:16:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:16:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Eex3ethMNk/Render', 07:16:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:16:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:16:04 INFO - 'HOME': '/Users/cltbld', 07:16:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:16:04 INFO - 'LOGNAME': 'cltbld', 07:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:04 INFO - 'MOZ_NO_REMOTE': '1', 07:16:04 INFO - 'NO_EM_RESTART': '1', 07:16:04 INFO - 'PAGER': '/bin/cat', 07:16:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:04 INFO - 'PWD': '/builds/slave/test', 07:16:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:16:04 INFO - 'SHELL': '/bin/bash', 07:16:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icMvRAxBCA/Listeners', 07:16:04 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 07:16:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:16:04 INFO - 'USER': 'cltbld', 07:16:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:16:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:04 INFO - 'XPC_FLAGS': '0x0', 07:16:04 INFO - 'XPC_SERVICE_NAME': '0', 07:16:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:04 INFO - Downloading/unpacking jsonschema 07:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:16:06 INFO - Downloading/unpacking functools32 (from jsonschema) 07:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:07 INFO - Downloading functools32-3.2.3-2.tar.gz 07:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:16:07 INFO - warning: no files found matching '*.txt' 07:16:07 INFO - no previously-included directories found matching 'build' 07:16:07 INFO - no previously-included directories found matching 'dist' 07:16:07 INFO - no previously-included directories found matching '.git*' 07:16:07 INFO - Installing collected packages: jsonschema, functools32 07:16:07 INFO - Running setup.py install for functools32 07:16:07 INFO - warning: no files found matching '*.txt' 07:16:07 INFO - no previously-included directories found matching 'build' 07:16:07 INFO - no previously-included directories found matching 'dist' 07:16:07 INFO - no previously-included directories found matching '.git*' 07:16:07 INFO - Successfully installed jsonschema functools32 07:16:07 INFO - Cleaning up... 07:16:07 INFO - Return code: 0 07:16:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:07 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 0x10460aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10461a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2995757a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044a9e00>, '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 0x104312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044a4b20>, '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.Eex3ethMNk/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.icMvRAxBCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:16:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Eex3ethMNk/Render', 07:16:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:16:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:16:08 INFO - 'HOME': '/Users/cltbld', 07:16:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:16:08 INFO - 'LOGNAME': 'cltbld', 07:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:08 INFO - 'MOZ_NO_REMOTE': '1', 07:16:08 INFO - 'NO_EM_RESTART': '1', 07:16:08 INFO - 'PAGER': '/bin/cat', 07:16:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:08 INFO - 'PWD': '/builds/slave/test', 07:16:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:16:08 INFO - 'SHELL': '/bin/bash', 07:16:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icMvRAxBCA/Listeners', 07:16:08 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 07:16:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:16:08 INFO - 'USER': 'cltbld', 07:16:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:16:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:08 INFO - 'XPC_FLAGS': '0x0', 07:16:08 INFO - 'XPC_SERVICE_NAME': '0', 07:16:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:08 INFO - Downloading/unpacking flake8 07:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:16:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:16:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:16:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:16:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:16:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:16:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:16:12 INFO - no previously-included directories found matching 'docs/_build' 07:16:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:16:12 INFO - Running setup.py install for pep8 07:16:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:16:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:16:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:16:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:16:12 INFO - no previously-included directories found matching 'docs/_build' 07:16:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:16:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:16:12 INFO - Cleaning up... 07:16:12 INFO - Return code: 0 07:16:12 INFO - Running post-action listener: _resource_record_post_action 07:16:12 INFO - Running post-action listener: _start_resource_monitoring 07:16:12 INFO - Starting resource monitoring. 07:16:12 INFO - ##### 07:16:12 INFO - ##### Running install step. 07:16:12 INFO - ##### 07:16:12 INFO - Running pre-action listener: _resource_record_pre_action 07:16:12 INFO - Running main action method: install 07:16:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:12 INFO - Reading from file tmpfile_stdout 07:16:12 INFO - Detecting whether we're running mozinstall >=1.0... 07:16:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:16:13 INFO - Reading from file tmpfile_stdout 07:16:13 INFO - Output received: 07:16:13 INFO - Usage: mozinstall [options] installer 07:16:13 INFO - Options: 07:16:13 INFO - -h, --help show this help message and exit 07:16:13 INFO - -d DEST, --destination=DEST 07:16:13 INFO - Directory to install application into. [default: 07:16:13 INFO - "/builds/slave/test"] 07:16:13 INFO - --app=APP Application being installed. [default: firefox] 07:16:13 INFO - mkdir: /builds/slave/test/build/application 07:16:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:16:46 INFO - Reading from file tmpfile_stdout 07:16:46 INFO - Output received: 07:16:46 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 07:16:46 INFO - Running post-action listener: _resource_record_post_action 07:16:46 INFO - ##### 07:16:46 INFO - ##### Running run-tests step. 07:16:46 INFO - ##### 07:16:46 INFO - Running pre-action listener: _resource_record_pre_action 07:16:46 INFO - Running main action method: run_tests 07:16:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:16:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:16:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:16:46 INFO - 2016-04-26 07:16:46.162 screenresolution[6426:110923] starting screenresolution argv=screenresolution get 07:16:46 INFO - 2016-04-26 07:16:46.165 screenresolution[6426:110923] Display 0: 1600x1200x32@60 07:16:46 INFO - 2016-04-26 07:16:46.170 screenresolution[6427:110926] starting screenresolution argv=screenresolution list 07:16:46 INFO - Available Modes on Display 0 07:16:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:16:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:16:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:16:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:16:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:16:46 INFO - Intel Iris: 07:16:46 INFO - Chipset Model: Intel Iris 07:16:46 INFO - Type: GPU 07:16:46 INFO - Bus: Built-In 07:16:46 INFO - VRAM (Dynamic, Max): 1536 MB 07:16:46 INFO - Vendor: Intel (0x8086) 07:16:46 INFO - Device ID: 0x0a2e 07:16:46 INFO - Revision ID: 0x0009 07:16:46 INFO - Displays: 07:16:46 INFO - Display: 07:16:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:16:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:16:46 INFO - Display Serial Number: 1600x1200 60 07:16:46 INFO - Main Display: Yes 07:16:46 INFO - Mirror: Off 07:16:46 INFO - Online: Yes 07:16:46 INFO - Rotation: Supported 07:16:46 INFO - Return code: 0 07:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:16:46 INFO - Python 2.7.3 07:16:46 INFO - Return code: 0 07:16:46 INFO - grabbing minidump binary from tooltool 07:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:46 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 0x1044a9e00>, '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 0x104312db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044a4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:16:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:16:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:16:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:16:46 INFO - Return code: 0 07:16:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:16:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:16:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:16:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:16:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:16:47 INFO - Return code: 0 07:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0190 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:16:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Eex3ethMNk/Render', 07:16:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:16:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:16:47 INFO - 'HOME': '/Users/cltbld', 07:16:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:16:47 INFO - 'LOGNAME': 'cltbld', 07:16:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:16:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:47 INFO - 'MOZ_NO_REMOTE': '1', 07:16:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:16:47 INFO - 'NO_EM_RESTART': '1', 07:16:47 INFO - 'PAGER': '/bin/cat', 07:16:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:47 INFO - 'PWD': '/builds/slave/test', 07:16:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:16:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:16:47 INFO - 'SHELL': '/bin/bash', 07:16:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icMvRAxBCA/Listeners', 07:16:47 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 07:16:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:16:47 INFO - 'USER': 'cltbld', 07:16:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:16:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:47 INFO - 'XPC_FLAGS': '0x0', 07:16:47 INFO - 'XPC_SERVICE_NAME': '0', 07:16:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:16:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:16:47 INFO - mozversion application_buildid: 20160426044609 07:16:47 INFO - mozversion application_changeset: 9ce31e9f90cb0e534611b0f617c5bbc232ffe748 07:16:47 INFO - mozversion application_display_name: Nightly 07:16:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:16:47 INFO - mozversion application_name: Firefox 07:16:47 INFO - mozversion application_remotingname: firefox 07:16:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:16:47 INFO - mozversion application_vendor: Mozilla 07:16:47 INFO - mozversion application_version: 49.0a1 07:16:47 INFO - mozversion platform_buildid: 20160426044609 07:16:47 INFO - mozversion platform_changeset: 9ce31e9f90cb0e534611b0f617c5bbc232ffe748 07:16:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:16:47 INFO - mozversion platform_version: 49.0a1 07:16:47 INFO - using testdate: 1461680207 07:16:47 INFO - actual date: 1461680207 07:16:47 INFO - starting webserver on 'localhost:61107' 07:16:47 INFO - SUITE-START | Running 2 tests 07:16:47 INFO - TEST-START | dromaeo_css 07:16:47 INFO - operating with platform_type : mac_ 07:16:47 INFO - Initialising browser for dromaeo_css test... 07:16:47 INFO - TEST-INFO | started process 6445 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmp_ws10C/profile http://localhost:61107/getInfo.html) 07:16:50 INFO - PROCESS | 6445 | __metrics Screen width/height:1600/1200 07:16:50 INFO - PROCESS | 6445 | colorDepth:24 07:16:50 INFO - PROCESS | 6445 | Browser inner width/height: 1024/689 07:16:50 INFO - PROCESS | 6445 | __metrics 07:16:50 ERROR - PROCESS | 6445 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:16:51 INFO - TEST-INFO | 6445: exit 0 07:16:51 INFO - Browser initialized. 07:16:51 INFO - Running cycle 1/1 for dromaeo_css test... 07:16:51 INFO - TEST-INFO | started process 6449 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmp_ws10C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:03 INFO - PROCESS | 6449 | RSS: Main: 250019840 07:17:03 INFO - PROCESS | 6449 | 07:17:53 INFO - PROCESS | 6449 | 1461680273531 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:20:03 INFO - PROCESS | 6449 | Cycle 1(1): loaded http://localhost:61107/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61107/tests/dromaeo/cssquery-ext.html) 07:20:04 INFO - PROCESS | 6449 | RSS: Main: 262225920 07:20:04 INFO - PROCESS | 6449 | 07:23:07 INFO - PROCESS | 6449 | Cycle 1(1): loaded http://localhost:61107/tests/dromaeo/cssquery-ext.html (next: http://localhost:61107/tests/dromaeo/cssquery-jquery.html) 07:23:07 INFO - PROCESS | 6449 | RSS: Main: 273862656 07:23:07 INFO - PROCESS | 6449 | 07:26:09 INFO - PROCESS | 6449 | Cycle 1(1): loaded http://localhost:61107/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61107/tests/dromaeo/cssquery-mootools.html) 07:26:10 INFO - PROCESS | 6449 | RSS: Main: 275910656 07:26:10 INFO - PROCESS | 6449 | 07:29:12 INFO - PROCESS | 6449 | Cycle 1(1): loaded http://localhost:61107/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61107/tests/dromaeo/cssquery-prototype.html) 07:29:12 INFO - PROCESS | 6449 | RSS: Main: 277512192 07:29:12 INFO - PROCESS | 6449 | 07:32:15 INFO - PROCESS | 6449 | Cycle 1(1): loaded http://localhost:61107/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61107/tests/dromaeo/cssquery-yui.html) 07:32:15 INFO - PROCESS | 6449 | RSS: Main: 280354816 07:32:15 INFO - PROCESS | 6449 | 07:35:18 INFO - PROCESS | 6449 | Cycle 1(1): loaded http://localhost:61107/tests/dromaeo/cssquery-yui.html (next: http://localhost:61107/tests/dromaeo/cssquery-dojo.html) 07:35:18 INFO - PROCESS | 6449 | RSS: Main: 281882624 07:35:18 INFO - PROCESS | 6449 | 07:35:18 INFO - PROCESS | 6449 | __start_tp_report 07:35:18 INFO - PROCESS | 6449 | _x_x_mozilla_page_load 07:35:18 INFO - PROCESS | 6449 | _x_x_mozilla_page_load_details 07:35:18 INFO - PROCESS | 6449 | |i|pagename|runs| 07:35:18 INFO - PROCESS | 6449 | |0;dojo.html;2844.7724182065435;3179.2846609512853;3383.221858972436;3403.8298085095726;3436.1924947637285;4706.670533062678;4967.45358010619;5601;5622.044252477079;5654.46282603153;4582.931256031162;5086.855457522065;5511.090670039449;5614.606977511576;5729.828105156842;5124.308218390525;5128.717920514361;5142.177251639739;5236.397814251352;5265.210218467222;325.33798730424104;4763.42821142574;5078.542931136197;5109.2591574221715;5158.174692049273;5111.386633603973;5127.487251274862;5149.9485005149845;5160.277561141444;5170.327857378555;5153.6392452528335;5166.095933211673;5170.069387510247;5188.299579556749;5223.973880130575;5044.965782014679;5122.667026643294;5128.230765385222;5134.922976155361;5203.583713302926;4409.338599210112;5406.675599464044;5420.214068960018;5429.701366424845;5503.889922201533;6036.305824830113;6125.938740612626;6167.814965551041;6170.8765824683705;6172.969135154295;6140.62695141751;6142.170806941095;6148.200733904609;6171.074338849164;6186.226721659793;5799.101139323411;5801.564882633777;5802.303723553201;5805.738741756589;5807.419258074201;6125.785597504155;6140.995089002448;6241.843953901189;6250.874982500324;6251.12484252205;6081.391860813883;6089.543284253698;6101.084837274444;6113.663748493876;6124.877502449926;6157.9133062010715;6165.0444181152;6167.876642467126;6193.225846769154;6209.192804935329;6034.487068599218;6042.063480160582;6079.544034197364;6110.175126357974;6139.416755408229;6141.447269745744;6142.201513803177;6189.6286222825875;6191.318954914956;6211.875762484816;4844.006978569385;4937.333459982857;4937.432195297515;4937.802487900515;4957.380327459067;4311.956880431218;4314.309710446313;4427.601515863524;4472.753998530047;4509.143262780061;5710.942890571124;5725.541956643458;5792.160136780143;5801.3038435388025;5871.060630299132;6160.322364539897;6169.96915015422;6175.59858609189;6184.81445556634;6189.721462534197;5602.691851948182;5602.747876345574;5670.432956704297;5679.6876171810945;5722.971385143131;5323;5389.218563308376;5390.595705322116;5390.838274851761;5405.21624364465;6125.204929265209;6327.430531252209;6335.239771227482;6350.269718982284;6356.904646430307;6087.178230938766;6090.485227154543;6148.815535533941;6150.446459818638;6160.199174107337;6276.278228003838;6287.371262873676;6300.558960872878;6318.147050148171;6349.238091429058;5073.847784566321;5104.464031276811;5343.465653434625;5806.954748145375;6123.6631985239455;5146;5235.816746413857;5906.586538942404;6117.796956032775;6183.598066125687;6009.098635204754;6027.095935609694;6052.66710330936;6057.061155520902;6071.635701857903;5948.672822994777;6031.457168854648;6050.30421501533;6076.422739839708;6080.969595151996;5830.650160990354;5948.5538584605465;5996.370381110095;6027.487663548647;6037.577369584087;6114;6128.448439640454;6145.262568491631;6162.352952940056;6165.876682466415;4819.855404337875;5812.099124635688;5927.496162826208;5985.191999080243;6047.334793172659 07:35:18 INFO - PROCESS | 6449 | |1;ext.html;502.4096686393487;523.6727045596502;538.3109619686801;573.0945106731365;602.7588964414236;36961;37693.811530942345;37801.81099094504;37817.810910945474;37829.810850945774;29718.702812971864;34925.476117858256;39428.40857387141;39528.60471395285;39615;9228.6308547658;9383.155516003559;9506.47714375709;9514.57184426699;9515.28635352348;9289.303302252325;9472.289578281656;9487.051294870527;9520.381175223623;9522.000189980055;9459.337846350758;9499.905000949972;9505.239580833517;9518.095780900803;9532.428054316728;9407.858882116774;9470.242380609534;9478.573464194127;9479.715608531686;9510.191633711109;9369.344145909788;9389.248860091177;9514.191293740041;9523.857142142873;9539.046095390475;37563.24873502515;37735;37912.43131353032;38227.23545529074;38236.42645360322;2791.148699646607;2798.9300267493477;3008.052108933236;3043.223977885647;3161.2887100402454;26608.733912661013;27055.594166087525;27684.031058913042;27980.160595181973;28603.14190574286;2670.0136923779082;2709.91870243893;2716.2666080158247;2727.6317697111035;2852.87162077707;298733;401737;401907;403165.9841700802;410747;59734.402655973754;59998;60134.699326503964;60178.49553761104;60300;53229;58935.115973260436;60556.78886422335;61789.691051544454;62997.68501157465;16771.748423773653;17335.479935601954;17353.132343382782;17374.47876563705;17419.04195269247;13138.868611313765;13176.275304858133;13240.53658121961;13253.536126235536;13274.336283185801;16103.919480402523;19308.4207473776;19346;19388.321408750908;19441.513962150777;7868.921310786934;8091.635876385577;8210.753677389688;8245.876311855327;8279.710210142615;818.60706860706;935.3125452792192;962.3263715399248;1039.6673064619401;1132.4337831084458;25808.09671661483;27790.166295011182;28759.856200718863;29262.707372926423;29603.555946660817;1099.6316234061678;1115.3363748569589;1119.4906317625462;1214.1379620469388;1267.8732126787431;14956.953013289183;14985.550433487013;15007.024543404645;15398.769018464733;15399.076055436486;423729;451220;452145;454836;506020;45773.54226457693;58578.70710646419;59105.11342329869;59555.70222148862;59938.70030649819;1488.040214061924;1504.4358365612895;1505.0668585477074;1505.631120375515;1510.2448775612195;27459.17622471329;28850.567241491815;29619.85190074036;29777.85111074431;30060.24849378783;45608.85977850448;48583.5141648579;50894.49105509045;51730.48269517257;51762.741186293824;408832;419513;463801;468434;469294;27030.05394811251;27380.452390951672;27385.863070684518;27438.45123097567;27453;43507;43514.564854351054;44124;44185.779071104436;44466.77766611146;36579.63420365869;36587.45118823273;36754.63245367512;37247.44128838124;37367;35950.82024589965;35965.64034359623;36412.81793591015;36612.633873660925;36946;29568.408631827675;35346.82326588454;35982;36972.630273696916;37153;29577.556336654536;30933.535996959614;30952;31027.224319392197;31399.529007064455;20703.482412939797;23613.881930590236;23757.64363534514;24666.630000550365;25076.62385064189 07:35:18 INFO - PROCESS | 6449 | |2;jquery.html;356.69324381032305;374.1282811050252;392.99999999999983;400.45538068227216;408.28957613752044;18351.449456516308;20113.296034638755;20166.59666806665;20208.59582808343;20316.984150792458;19661.05084237365;20157.899210503925;20480.078396472156;20562.69155962662;21185.68221476679;5250.422453530108;5664.858378540528;5711.343195532505;5989.700514974255;6007.969960150193;4965.776540055706;5791.942080579203;5819.447152520504;5903.4686878180955;5944.762209511614;5594.356648985378;5823.9708801456145;5825.621334613258;5846.853828654275;5875.324337701177;5688.11834165705;5748.798792042258;5758.251427314443;5814.215080964079;5815.88368232633;4408.382826404306;4523.592876641118;4986.800527978877;5085.313482679865;5112.590992720573;19814;22434.32697019092;24835.751642483523;24867.50264994708;24933.5013299733;2234.430220293831;2250.7861753133425;2258.525709600986;2311.8150547956293;2497.5379554782426;12740.936295318465;13971.720565588734;14546.709065818624;14783.039102458413;15224;1772.831580999803;1786.4729904678152;1792.856571474279;1799.3072667023291;1821.790494093183;92133;96427.07145857114;98954;98965.51551726658;99594.50202749012;9247.352685312098;10582.735431614272;10799.352038877692;10896.836547451794;11165.162612804072;13581.981351398685;13648;13680.589582312547;13703.314834258248;13704.931475342759;7441.958125862384;8549.914500855037;8680.826383472295;8757.386982911135;8802.823943521094;8796.648134074565;8823.073577274294;8837.779055523662;8868.556572171366;8933.865992009994;5642.576806739511;6526.934730652632;6653.500987425962;6718.596884186867;6726.22648395431;1869.2055876252539;1927.2483731344787;1928.5150434165614;1932.6327997680396;1968.4783532363936;953.68051702679;993.1409330928839;1019.8373853806667;1020.9285350025427;1092.7705181911729;19434.028298585014;20299.79700202979;20515.974201289875;20592.382228533166;20779.58440831205;1006.9748256293651;1007.1137399088755;1032.4837581209395;1035.316690983947;1071.539238127597;10091.646792362379;11155.888441115647;11155.944220279009;11188.272762270426;11214.327140371604;599901.0004950034;610626;614233;618135;637451;69284;87085.12914870896;90368;90681.09318906859;96518;1019.887812340642;1046.942418167008;1051.731808388856;1062.2776511971779;1066.871975362946;18026.63946721032;18149.818501814814;18293.451196464128;18330.633387332444;18795.154218060492;46105.76947115243;46969.53030469651;47848;47978;48480;64262.67868660627;64390.678046609464;64512.354876450634;65251.02123468247;66156;7792.84414311722;7832.334251588451;7900.486468379537;8003.239692229229;8005.839883202187;9705.272104592043;11103.889611038832;11486.597969071043;12206;12469.438875250455;10529.473526323807;10775.892241077489;10798.892011079788;10987.670369888916;11341.546338146381;10112.949435252776;10551.419671918118;10729.034386904903;10842.620508282173;10929.836052459379;10926;11203.047740942111;11244.55021799119;11353.37556434404;11460.426978650867;7157.57054576727;7755;7865.410094243069;7932.16712245206;8064.193580641889;7506.361959233526;10037.397756134655;10829;11041.613543525938;11090.944545277222 07:35:18 INFO - PROCESS | 6449 | |3;mootools.html;1517.5674932644197;1611.484325015995;1861.6276744651072;1941.2429152630477;1978.821906028459;7849.68601255949;8462.661493540267;8763.386562940597;9098.044705305938;9180.357374983745;8426.578671066438;8535.57322133894;8574.614142363593;8601.91398086019;8620.74137775866;2428.2229686500327;2463.987680061597;2466.05057053035;2468.4445999650115;2475.6905386826647;2432.2460037388378;2493.13986674597;2494.950100997988;2498.100683753856;2506.9373265668323;2453.668754718117;2458.840175388603;2488.6142647889606;2491.613799861015;2507.2728908616477;2457.1891275878916;2459.86470744109;2474.653548503211;2488.4276616378243;2491.028498885436;2453.2640207937548;2461.938451538708;2465.506898620283;2466.802655787533;2475.8390704604144;8657.740267791976;8661.393702440831;8693.261072808818;8728.563571821383;8746.431481953652;5320.334958130234;5479.150731636602;5502.697351645658;5505.421930697299;5511.311086114236;3595.2989167112423;3606.1165014571334;3616.6437585905287;3672.6143754905615;3693.8153092345274;1029.711680729397;1036.0778906772978;1040.583766493401;1045.5347370420166;1047.1570385839395;11602.419879006016;11702.707432314175;11733.4719937603;11751.588694395656;11785.469653865597;4835.661503694778;4854.344663470457;4970.975145124251;4972.229304457815;5003.074431230234;9981.850272245922;10063;10088.890222075566;10093.142082922886;10148.441835699108;5411.756470958738;5444.373897001896;5477;5480.424555421623;5483.479069488392;4391.8682439526865;4885.389326334208;4947.876303092451;5056.06462804375;5079.746012699424;3692.3538380783257;4085.722182737134;4093.345064789679;4176.791160441966;4177.540470548237;1353.363918958108;1378.9586312410643;1385.3211926156312;1389.1248513436672;1399.818023656918;805.1746959366697;827.3546633625782;885.9601317940708;886.6054605700401;943.9528023598792;5542.140968149944;5717.142428635655;5842.649441033552;5985.670788106609;6003.729832157476;433.5989209980755;445.04537766490694;455.5217022126754;455.67191622032084;469.6477641768673;3717.628237176261;3758.4362345648374;3764.247150569897;3806.7906265155684;3821;10464.372137671764;10705.411202383788;10753.51609177589;11071;11084.390358530198;8002;9070.591823367964;9471.621135154655;9587.808243835085;10403.895961040293;6982;7944.483608565541;8329.50022998622;8391.958040209882;8419.452735572046;5859.857327821034;5907.881842363215;6012.458878700938;6024.487918526975;6128.509719222362;8236.876446853423;10221.029002244775;10237.334573253012;10241.641542545975;10308.845367319345;8099.716509922125;10305.175585952957;10378.896211037792;10410;10472.10987066108;6841.076454678555;7403.8149046274275;7419;7693.230676932486;7751.3411360035025;8424.663013479638;8473.95763021181;8518.872216916876;8525.914740852511;8526.616302266537;7329.926700733137;7488.737894173678;7591.924080759121;7602.961985190039;7649.6557654904545;7354.521956072838;7356.006939063158;7431.29402706742;7458.5151965122095;7513.211112833293;7034.402075823407;7078;7084.433245340258;7098.43212542985;7117.537360071578;4772.976135119302;4799.640026998059;4948.356713627206;4949.950500494949;5084.034033533617;4876.756162191805;4972.477889821516;5011.4487406386;5017.774200161075;5190.480951904779 07:35:18 INFO - PROCESS | 6449 | |4;prototype.html;278.3833808115025;320.66810850769457;323.90444818778457;325.1335191714082;327.4744035822505;5050.772715227814;5579.832605021856;5605.607607467474;5647.407022262654;5649.745761440729;5115.718635475047;5245.423003469616;5545.334559852813;5557.749901254443;5566.805161819327;4048.6153815387565;4052.7770972596495;4143.274926887798;4150.813213405404;4196.244675958326;3921.64701179293;4027.4224496322377;4108.678596592916;4166.395872598471;4194.643455306303;3818.7589033564063;3977.2443235785254;4130.277201489727;4134.917301653965;4142.440770495989;3431.330890476358;3948.0919388540797;4009.5470160581585;4101.671866250693;4156.334986402177;2936.9118926432243;3608.7293452990866;3616.8191590420374;3618.7466877318598;3638.43604241343;4377.584129507692;4814.277858321279;4942.498901888745;5145.459726728677;5238.5023422774775;4441.955580444219;4745.1695953208055;4751.904961900777;4780.80876764929;4796.088743138827;5865.677387743673;5881.67650779207;5890.764369425261;5907.172995780594;5932.317783454915;3512.7189824813954;3960.386140148282;3977.925959990815;3992.960070399317;4002.3590327965394;4857;4906.239532872411;5460.590455715837;5998.250218722616;6190.2571691397325;3976.940345894814;4019.437278780973;4032.1532478179324;4036.455078564415;4051.6353528182017;3600.855965761393;3661.5240018797385;3701.444783282529;4091.97954010228;4108.239975604522;4737.573618374363;4769.260764581495;4769.499202583679;4775;4796.35249241348;5580.246666700024;5915.438033386908;5949.286085669747;5967.701614919237;5974.880502389928;1435.468876515696;1447.8190226221723;1450.6010847016944;1453.3677850135225;1460.4085345435117;810.9148539403395;885.5970533407414;940.9304756926321;968.2012339819677;976.2580438866513;5161;5822.184894114827;5830.7959221427045;5859.150423188614;5875.588708790429;6531.872480103097;6536.542442029012;6545.934540654628;6599.274079851212;6614.040964060185;4224.894377640584;5153.484651534892;5729.25519682447;5833.270841144857;5866.032104702762;3277.5903012123485;3395.2530443302435;3449.8443021587545;3450.896473105811;3475.6871881530783;5251.579873610102;6377.904331435032;6658.300878407795;6825.385715285648;6838.829029274308;5340.038793017294;5860.157823455621;5959.791407300723;6734.45107625249;6791.72833086671;5603.6077474577205;5797.565182611321;6734.932650673529;6747.797566073025;6810.250872404032;6515.250746164252;6516.869662606627;6533.509986750918;6580.144581204413;6585.341465853377;5448.618596698193;6441.033844923111;6453.128827608401;6459.515536334888;6493.935060649522;5045.351190624804;5887.381824908323;5951.613145145551;6373.171487706569;6394.808155755335;3161.9051428457183;3510.8771193008124;3967.4643923070016;4009;4054.1283624020975;6039.33918172506;6126.816195514141;6193.783217587363;6207.689615519296;6219.782307619212;5940.762369505172;5946.524278057658;5971.820845374646;5974.4324289192455;5977.310210405422;5281.811592391835;5640.435956404491;5903.822885313448;5982.371850955587;6002.249718785152;4853.9029219416125;5367.114426119802;5372.62391632582;5822.621529600562;5865.677387743715;5453.100238460768;5704.771809127755;5933.732982015733;5958.914379966977;5999.970000149971;4932.988737308915;4938.456769755396;5733.31200255972;5878.441548052928;5912.556558258234 07:35:18 INFO - PROCESS | 6449 | |5;yui.html;712.7327252280395;730.6638946084801;732.2055569706868;737.2443245673185;745.903032605761;14730;14807.889408294368;15087.924560377196;15247.923760381183;15275.847241527581;13878.097923634956;14150.150990940525;14177;14232.71534569308;14250.4299828007;631.7094136697114;722.3498851034059;883.6951251818112;912.6212621761961;924.4545718026396;899.6896070855545;913.8720579118929;918.1507105927025;921.258386998466;923.5336155241628;961.5817119552981;970.6845275285525;974.8050389922043;977.1205914676776;977.1986970684042;950.9191718703919;951.8048799996053;966;969.5733877094056;973.795502944379;704.4962851561107;708.5677736580682;711.2531841566334;724.5109551053071;725.4595326481805;14882.107073575511;14976.251187440585;14993.475228366955;14999.550013499613;15020;12426.378681066;12491.504417702834;12665.620031399072;12677.936610316981;12755.36223188846;9859.408435493822;10077.344972576833;10140.594376224943;10273.897261027369;10380.377177369306;3362.714169295613;3476.704480119193;3486.180747524355;3551.662592053751;3558.9644103558894;59728;63114.053289200696;64537.99999999953;69756;81665;9470.195033422237;9473.668421605349;9477.668281610111;9523.952380238194;9755.658551950648;21704.674429883566;21889.12443502274;21933.01301441439;22028.88985555062;22088.447788805086;6727.764528241488;7050.4727157045045;7277.599732014684;7295.088113985752;7586.62066896653;3276.9344613107605;4080.265552200573;4101.241270364992;4139.068709540329;4165.354370072643;3173.444647186779;3345.6988871001727;3534.699550538233;3568.411212149966;3605.4772058051435;624.5628060357768;627.2535682537857;653.3825534869598;655.77048033188;660.6366498425847;554.1715135871897;570.6347937320119;589.5254320272222;604.4771272848953;608.5496732417979;7870.370370370357;8176.836463270702;8285.171482851667;8320.37597180214;8377.162283771697;540.5891522442971;596.9373215812277;598.8202052248089;598.9309083286313;607.8541150123939;3610.332088563624;3891.747036442679;3900.278448487039;3940.4877365942243;4040.7370224413526;89054;89537.20925581452;91936.54031729799;96686;96983;81185;81208.37583248301;81431;82821.58589207016;82943.7558436624;64764.67617661976;68453.3154668447;69940.65029674921;70621.64689176624;70727;8285.130061343472;8373.706920257762;8377.45546539473;8441.577921104043;8466.957665211634;27898;40457.797711011255;41259.93700314912;43094.56905430905;44523.55476445194;50989.66587840075;59090;65478.67260663666;65638;66874.66562667156;10815.621453249098;10832.67501974942;10935.015848573667;10964.396958167377;11123.615001363502;11836;11860.34768087729;11883;12176.512939482322;12388.690282743004;9200.539973001189;11511.942440287745;11533.538658453568;11538.76922461563;11802.291862488279;11289.548418063185;11335.943320283346;11378;11624.941875290908;11793.941030294794;11020.614278500534;11287.266327688674;11315.547378104784;11582.594609188638;11615.303081815118;9585.424874507551;9675.274354423305;9846;10181.84727229107;10339;9650.131488166098;9674.85487717699;9755;9766.414015159113;9894.604215831574 07:35:18 INFO - PROCESS | 6449 | __end_tp_report 07:35:18 INFO - PROCESS | 6449 | __start_cc_report 07:35:18 INFO - PROCESS | 6449 | _x_x_mozilla_cycle_collect,426 07:35:18 INFO - PROCESS | 6449 | __end_cc_report 07:35:18 INFO - PROCESS | 6449 | __startTimestamp1461681318737__endTimestamp 07:35:18 INFO - PROCESS | 6449 | 07:35:18 INFO - PROCESS | 6449 | ------- Summary: start ------- 07:35:18 INFO - PROCESS | 6449 | Number of tests: 6 07:35:18 INFO - PROCESS | 6449 | 07:35:18 INFO - PROCESS | 6449 | [#0] dojo.html Cycles:165 Average:5600.76 Median:5830.65 stddev:784.91 (13.5%) stddev-sans-first:756.95 07:35:18 INFO - PROCESS | 6449 | Values: 2844.8 3179.3 3383.2 3403.8 3436.2 4706.7 4967.5 5601.0 5622.0 5654.5 4582.9 5086.9 5511.1 5614.6 5729.8 5124.3 5128.7 5142.2 5236.4 5265.2 325.3 4763.4 5078.5 5109.3 5158.2 5111.4 5127.5 5149.9 5160.3 5170.3 5153.6 5166.1 5170.1 5188.3 5224.0 5045.0 5122.7 5128.2 5134.9 5203.6 4409.3 5406.7 5420.2 5429.7 5503.9 6036.3 6125.9 6167.8 6170.9 6173.0 6140.6 6142.2 6148.2 6171.1 6186.2 5799.1 5801.6 5802.3 5805.7 5807.4 6125.8 6141.0 6241.8 6250.9 6251.1 6081.4 6089.5 6101.1 6113.7 6124.9 6157.9 6165.0 6167.9 6193.2 6209.2 6034.5 6042.1 6079.5 6110.2 6139.4 6141.4 6142.2 6189.6 6191.3 6211.9 4844.0 4937.3 4937.4 4937.8 4957.4 4312.0 4314.3 4427.6 4472.8 4509.1 5710.9 5725.5 5792.2 5801.3 5871.1 6160.3 6170.0 6175.6 6184.8 6189.7 5602.7 5602.7 5670.4 5679.7 5723.0 5323.0 5389.2 5390.6 5390.8 5405.2 6125.2 6327.4 6335.2 6350.3 6356.9 6087.2 6090.5 6148.8 6150.4 6160.2 6276.3 6287.4 6300.6 6318.1 6349.2 5073.8 5104.5 5343.5 5807.0 6123.7 5146.0 5235.8 5906.6 6117.8 6183.6 6009.1 6027.1 6052.7 6057.1 6071.6 5948.7 6031.5 6050.3 6076.4 6081.0 5830.7 5948.6 5996.4 6027.5 6037.6 6114.0 6128.4 6145.3 6162.4 6165.9 4819.9 5812.1 5927.5 5985.2 6047.3 07:35:18 INFO - PROCESS | 6449 | 07:35:18 INFO - PROCESS | 6449 | [#1] ext.html Cycles:180 Average:57597.24 Median:37465.12 stddev:114351.29 (305.2%) stddev-sans-first:114591.73 07:35:18 INFO - PROCESS | 6449 | Values: 502.4 523.7 538.3 573.1 602.8 36961.0 37693.8 37801.8 37817.8 37829.8 29718.7 34925.5 39428.4 39528.6 39615.0 9228.6 9383.2 9506.5 9514.6 9515.3 9289.3 9472.3 9487.1 9520.4 9522.0 9459.3 9499.9 9505.2 9518.1 9532.4 9407.9 9470.2 9478.6 9479.7 9510.2 9369.3 9389.2 9514.2 9523.9 9539.0 37563.2 37735.0 37912.4 38227.2 38236.4 2791.1 2798.9 3008.1 3043.2 3161.3 26608.7 27055.6 27684.0 27980.2 28603.1 2670.0 2709.9 2716.3 2727.6 2852.9 298733.0 401737.0 401907.0 403166.0 410747.0 59734.4 59998.0 60134.7 60178.5 60300.0 53229.0 58935.1 60556.8 61789.7 62997.7 16771.7 17335.5 17353.1 17374.5 17419.0 13138.9 13176.3 13240.5 13253.5 13274.3 16103.9 19308.4 19346.0 19388.3 19441.5 7868.9 8091.6 8210.8 8245.9 8279.7 818.6 935.3 962.3 1039.7 1132.4 25808.1 27790.2 28759.9 29262.7 29603.6 1099.6 1115.3 1119.5 1214.1 1267.9 14957.0 14985.6 15007.0 15398.8 15399.1 423729.0 451220.0 452145.0 454836.0 506020.0 45773.5 58578.7 59105.1 59555.7 59938.7 1488.0 1504.4 1505.1 1505.6 1510.2 27459.2 28850.6 29619.9 29777.9 30060.2 45608.9 48583.5 50894.5 51730.5 51762.7 408832.0 419513.0 463801.0 468434.0 469294.0 27030.1 27380.5 27385.9 27438.5 27453.0 43507.0 43514.6 44124.0 44185.8 44466.8 36579.6 36587.5 36754.6 37247.4 37367.0 35950.8 35965.6 36412.8 36612.6 36946.0 29568.4 35346.8 35982.0 36972.6 37153.0 29577.6 30933.5 30952.0 31027.2 31399.5 20703.5 23613.9 23757.6 24666.6 25076.6 07:35:18 INFO - PROCESS | 6449 | 07:35:18 INFO - PROCESS | 6449 | [#2] jquery.html Cycles:180 Average:33197.54 Median:13573.78 stddev:101300.74 (746.3%) stddev-sans-first:101554.90 07:35:18 INFO - PROCESS | 6449 | Values: 356.7 374.1 393.0 400.5 408.3 18351.4 20113.3 20166.6 20208.6 20317.0 19661.1 20157.9 20480.1 20562.7 21185.7 5250.4 5664.9 5711.3 5989.7 6008.0 4965.8 5791.9 5819.4 5903.5 5944.8 5594.4 5824.0 5825.6 5846.9 5875.3 5688.1 5748.8 5758.3 5814.2 5815.9 4408.4 4523.6 4986.8 5085.3 5112.6 19814.0 22434.3 24835.8 24867.5 24933.5 2234.4 2250.8 2258.5 2311.8 2497.5 12740.9 13971.7 14546.7 14783.0 15224.0 1772.8 1786.5 1792.9 1799.3 1821.8 92133.0 96427.1 98954.0 98965.5 99594.5 9247.4 10582.7 10799.4 10896.8 11165.2 13582.0 13648.0 13680.6 13703.3 13704.9 7442.0 8549.9 8680.8 8757.4 8802.8 8796.6 8823.1 8837.8 8868.6 8933.9 5642.6 6526.9 6653.5 6718.6 6726.2 1869.2 1927.2 1928.5 1932.6 1968.5 953.7 993.1 1019.8 1020.9 1092.8 19434.0 20299.8 20516.0 20592.4 20779.6 1007.0 1007.1 1032.5 1035.3 1071.5 10091.6 11155.9 11155.9 11188.3 11214.3 599901.0 610626.0 614233.0 618135.0 637451.0 69284.0 87085.1 90368.0 90681.1 96518.0 1019.9 1046.9 1051.7 1062.3 1066.9 18026.6 18149.8 18293.5 18330.6 18795.2 46105.8 46969.5 47848.0 47978.0 48480.0 64262.7 64390.7 64512.4 65251.0 66156.0 7792.8 7832.3 7900.5 8003.2 8005.8 9705.3 11103.9 11486.6 12206.0 12469.4 10529.5 10775.9 10798.9 10987.7 11341.5 10112.9 10551.4 10729.0 10842.6 10929.8 10926.0 11203.0 11244.6 11353.4 11460.4 7157.6 7755.0 7865.4 7932.2 8064.2 7506.4 10037.4 10829.0 11041.6 11090.9 07:35:18 INFO - PROCESS | 6449 | 07:35:18 INFO - PROCESS | 6449 | [#3] mootools.html Cycles:180 Average:5705.00 Median:4948.12 stddev:3148.72 (63.6%) stddev-sans-first:3141.82 07:35:18 INFO - PROCESS | 6449 | Values: 1517.6 1611.5 1861.6 1941.2 1978.8 7849.7 8462.7 8763.4 9098.0 9180.4 8426.6 8535.6 8574.6 8601.9 8620.7 2428.2 2464.0 2466.1 2468.4 2475.7 2432.2 2493.1 2495.0 2498.1 2506.9 2453.7 2458.8 2488.6 2491.6 2507.3 2457.2 2459.9 2474.7 2488.4 2491.0 2453.3 2461.9 2465.5 2466.8 2475.8 8657.7 8661.4 8693.3 8728.6 8746.4 5320.3 5479.2 5502.7 5505.4 5511.3 3595.3 3606.1 3616.6 3672.6 3693.8 1029.7 1036.1 1040.6 1045.5 1047.2 11602.4 11702.7 11733.5 11751.6 11785.5 4835.7 4854.3 4971.0 4972.2 5003.1 9981.9 10063.0 10088.9 10093.1 10148.4 5411.8 5444.4 5477.0 5480.4 5483.5 4391.9 4885.4 4947.9 5056.1 5079.7 3692.4 4085.7 4093.3 4176.8 4177.5 1353.4 1379.0 1385.3 1389.1 1399.8 805.2 827.4 886.0 886.6 944.0 5542.1 5717.1 5842.6 5985.7 6003.7 433.6 445.0 455.5 455.7 469.6 3717.6 3758.4 3764.2 3806.8 3821.0 10464.4 10705.4 10753.5 11071.0 11084.4 8002.0 9070.6 9471.6 9587.8 10403.9 6982.0 7944.5 8329.5 8392.0 8419.5 5859.9 5907.9 6012.5 6024.5 6128.5 8236.9 10221.0 10237.3 10241.6 10308.8 8099.7 10305.2 10378.9 10410.0 10472.1 6841.1 7403.8 7419.0 7693.2 7751.3 8424.7 8474.0 8518.9 8525.9 8526.6 7329.9 7488.7 7591.9 7603.0 7649.7 7354.5 7356.0 7431.3 7458.5 7513.2 7034.4 7078.0 7084.4 7098.4 7117.5 4773.0 4799.6 4948.4 4950.0 5084.0 4876.8 4972.5 5011.4 5017.8 5190.5 07:35:18 INFO - PROCESS | 6449 | 07:35:18 INFO - PROCESS | 6449 | [#4] prototype.html Cycles:180 Average:4823.45 Median:5369.87 stddev:1551.60 (28.9%) stddev-sans-first:1517.99 07:35:18 INFO - PROCESS | 6449 | Values: 278.4 320.7 323.9 325.1 327.5 5050.8 5579.8 5605.6 5647.4 5649.7 5115.7 5245.4 5545.3 5557.7 5566.8 4048.6 4052.8 4143.3 4150.8 4196.2 3921.6 4027.4 4108.7 4166.4 4194.6 3818.8 3977.2 4130.3 4134.9 4142.4 3431.3 3948.1 4009.5 4101.7 4156.3 2936.9 3608.7 3616.8 3618.7 3638.4 4377.6 4814.3 4942.5 5145.5 5238.5 4442.0 4745.2 4751.9 4780.8 4796.1 5865.7 5881.7 5890.8 5907.2 5932.3 3512.7 3960.4 3977.9 3993.0 4002.4 4857.0 4906.2 5460.6 5998.3 6190.3 3976.9 4019.4 4032.2 4036.5 4051.6 3600.9 3661.5 3701.4 4092.0 4108.2 4737.6 4769.3 4769.5 4775.0 4796.4 5580.2 5915.4 5949.3 5967.7 5974.9 1435.5 1447.8 1450.6 1453.4 1460.4 810.9 885.6 940.9 968.2 976.3 5161.0 5822.2 5830.8 5859.2 5875.6 6531.9 6536.5 6545.9 6599.3 6614.0 4224.9 5153.5 5729.3 5833.3 5866.0 3277.6 3395.3 3449.8 3450.9 3475.7 5251.6 6377.9 6658.3 6825.4 6838.8 5340.0 5860.2 5959.8 6734.5 6791.7 5603.6 5797.6 6734.9 6747.8 6810.3 6515.3 6516.9 6533.5 6580.1 6585.3 5448.6 6441.0 6453.1 6459.5 6493.9 5045.4 5887.4 5951.6 6373.2 6394.8 3161.9 3510.9 3967.5 4009.0 4054.1 6039.3 6126.8 6193.8 6207.7 6219.8 5940.8 5946.5 5971.8 5974.4 5977.3 5281.8 5640.4 5903.8 5982.4 6002.2 4853.9 5367.1 5372.6 5822.6 5865.7 5453.1 5704.8 5933.7 5958.9 6000.0 4933.0 4938.5 5733.3 5878.4 5912.6 07:35:18 INFO - PROCESS | 6449 | 07:35:18 INFO - PROCESS | 6449 | [#5] yui.html Cycles:180 Average:17581.06 Median:606.17 stddev:24573.31 (4053.9%) stddev-sans-first:24609.60 07:35:18 INFO - PROCESS | 6449 | Values: 712.7 730.7 732.2 737.2 745.9 14730.0 14807.9 15087.9 15247.9 15275.8 13878.1 14150.2 14177.0 14232.7 14250.4 631.7 722.3 883.7 912.6 924.5 899.7 913.9 918.2 921.3 923.5 961.6 970.7 974.8 977.1 977.2 950.9 951.8 966.0 969.6 973.8 704.5 708.6 711.3 724.5 725.5 14882.1 14976.3 14993.5 14999.6 15020.0 12426.4 12491.5 12665.6 12677.9 12755.4 9859.4 10077.3 10140.6 10273.9 10380.4 3362.7 3476.7 3486.2 3551.7 3559.0 59728.0 63114.1 64538.0 69756.0 81665.0 9470.2 9473.7 9477.7 9524.0 9755.7 21704.7 21889.1 21933.0 22028.9 22088.4 6727.8 7050.5 7277.6 7295.1 7586.6 3276.9 4080.3 4101.2 4139.1 4165.4 3173.4 3345.7 3534.7 3568.4 3605.5 624.6 627.3 653.4 655.8 660.6 554.2 570.6 589.5 604.5 608.5 7870.4 8176.8 8285.2 8320.4 8377.2 540.6 596.9 598.8 598.9 607.9 3610.3 3891.7 3900.3 3940.5 4040.7 89054.0 89537.2 91936.5 96686.0 96983.0 81185.0 81208.4 81431.0 82821.6 82943.8 64764.7 68453.3 69940.7 70621.6 70727.0 8285.1 8373.7 8377.5 8441.6 8467.0 27898.0 40457.8 41259.9 43094.6 44523.6 50989.7 59090.0 65478.7 65638.0 66874.7 10815.6 10832.7 10935.0 10964.4 11123.6 11836.0 11860.3 11883.0 12176.5 12388.7 9200.5 11511.9 11533.5 11538.8 11802.3 11289.5 11335.9 11378.0 11624.9 11793.9 11020.6 11287.3 11315.5 11582.6 11615.3 9585.4 9675.3 9846.0 10181.8 10339.0 9650.1 9674.9 9755.0 9766.4 9894.6 07:35:18 INFO - PROCESS | 6449 | -------- Summary: end -------- 07:35:18 INFO - PROCESS | 6449 | 07:35:19 INFO - TEST-INFO | 6449: exit 0 07:35:19 INFO - TEST-OK | dromaeo_css | took 1111496ms 07:35:19 INFO - TEST-START | kraken 07:35:19 INFO - operating with platform_type : mac_ 07:35:19 INFO - Initialising browser for kraken test... 07:35:19 INFO - TEST-INFO | started process 6454 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpCgeErG/profile http://localhost:61107/getInfo.html) 07:35:22 INFO - PROCESS | 6454 | __metrics Screen width/height:1600/1200 07:35:22 INFO - PROCESS | 6454 | colorDepth:24 07:35:22 INFO - PROCESS | 6454 | Browser inner width/height: 1024/689 07:35:22 INFO - PROCESS | 6454 | __metrics 07:35:22 ERROR - PROCESS | 6454 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:35:23 INFO - TEST-INFO | 6454: exit 0 07:35:23 INFO - Browser initialized. 07:35:23 INFO - Running cycle 1/1 for kraken test... 07:35:23 INFO - TEST-INFO | started process 6459 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpCgeErG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:34 INFO - PROCESS | 6459 | RSS: Main: 249708544 07:35:34 INFO - PROCESS | 6459 | 07:35:37 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:61107/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61107/tests/kraken/driver.html?testName=audio-beat-detection) 07:35:38 INFO - PROCESS | 6459 | RSS: Main: 261734400 07:35:38 INFO - PROCESS | 6459 | 07:35:41 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:61107/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61107/tests/kraken/driver.html?testName=audio-dft) 07:35:41 INFO - PROCESS | 6459 | RSS: Main: 271081472 07:35:41 INFO - PROCESS | 6459 | 07:35:45 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:61107/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61107/tests/kraken/driver.html?testName=audio-fft) 07:35:45 INFO - PROCESS | 6459 | RSS: Main: 273633280 07:35:45 INFO - PROCESS | 6459 | 07:35:47 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:61107/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61107/tests/kraken/driver.html?testName=audio-oscillator) 07:35:48 INFO - PROCESS | 6459 | RSS: Main: 276131840 07:35:48 INFO - PROCESS | 6459 | 07:35:50 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:61107/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61107/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:35:51 INFO - PROCESS | 6459 | RSS: Main: 276889600 07:35:51 INFO - PROCESS | 6459 | 07:35:54 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:61107/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61107/tests/kraken/driver.html?testName=imaging-darkroom) 07:35:54 INFO - PROCESS | 6459 | RSS: Main: 276484096 07:35:54 INFO - PROCESS | 6459 | 07:35:57 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:61107/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61107/tests/kraken/driver.html?testName=imaging-desaturate) 07:35:58 INFO - PROCESS | 6459 | RSS: Main: 276480000 07:35:58 INFO - PROCESS | 6459 | 07:36:01 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:61107/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61107/tests/kraken/driver.html?testName=json-parse-financial) 07:36:01 INFO - PROCESS | 6459 | RSS: Main: 276701184 07:36:01 INFO - PROCESS | 6459 | 07:36:03 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:61107/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61107/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:36:03 INFO - PROCESS | 6459 | RSS: Main: 276557824 07:36:03 INFO - PROCESS | 6459 | 07:36:05 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:61107/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61107/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:36:06 INFO - PROCESS | 6459 | RSS: Main: 276779008 07:36:06 INFO - PROCESS | 6459 | 07:36:08 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:61107/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61107/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:36:09 INFO - PROCESS | 6459 | RSS: Main: 276680704 07:36:09 INFO - PROCESS | 6459 | 07:36:12 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:61107/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:36:12 INFO - PROCESS | 6459 | RSS: Main: 276815872 07:36:12 INFO - PROCESS | 6459 | 07:36:16 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:61107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:36:16 INFO - PROCESS | 6459 | RSS: Main: 276865024 07:36:16 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:61107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61107/tests/kraken/driver.html?testName=ai-astar) 07:36:18 INFO - PROCESS | 6459 | RSS: Main: 278757376 07:36:18 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | __start_tp_report 07:36:18 INFO - PROCESS | 6459 | _x_x_mozilla_page_load 07:36:18 INFO - PROCESS | 6459 | _x_x_mozilla_page_load_details 07:36:18 INFO - PROCESS | 6459 | |i|pagename|runs| 07:36:18 INFO - PROCESS | 6459 | |0;ai-astar;118;109;115;117;115;128;115;116;117;116 07:36:18 INFO - PROCESS | 6459 | |1;audio-beat-detection;192;154;181;172;124;149;146;122;175;124 07:36:18 INFO - PROCESS | 6459 | |2;audio-dft;197;196;234;274;204;198;197;199;197;190 07:36:18 INFO - PROCESS | 6459 | |3;audio-fft;56;109;107;179;83;56;57;61;131;56 07:36:18 INFO - PROCESS | 6459 | |4;audio-oscillator;80;83;140;76;79;80;124;81;83;125 07:36:18 INFO - PROCESS | 6459 | |5;imaging-gaussian-blur;89;88;88;85;103;113;90;88;89;80 07:36:18 INFO - PROCESS | 6459 | |6;imaging-darkroom;94;95;103;96;108;139;125;95;95;94 07:36:18 INFO - PROCESS | 6459 | |7;imaging-desaturate;93;93;91;88;96;87;92;92;92;99 07:36:18 INFO - PROCESS | 6459 | |8;json-parse-financial;57;80;48;54;73;46;53;71;76;83 07:36:18 INFO - PROCESS | 6459 | |9;json-stringify-tinderbox;66;67;74;66;75;58;77;97;98;65 07:36:18 INFO - PROCESS | 6459 | |10;stanford-crypto-aes;86;82;84;83;83;84;82;83;83;83 07:36:18 INFO - PROCESS | 6459 | |11;stanford-crypto-ccm;160;150;137;137;140;140;158;168;206;143 07:36:18 INFO - PROCESS | 6459 | |12;stanford-crypto-pbkdf2;201;198;205;204;203;196;215;200;202;199 07:36:18 INFO - PROCESS | 6459 | |13;stanford-crypto-sha256-iterative;71;70;70;69;70;73;69;88;96;99 07:36:18 INFO - PROCESS | 6459 | __end_tp_report 07:36:18 INFO - PROCESS | 6459 | __start_cc_report 07:36:18 INFO - PROCESS | 6459 | _x_x_mozilla_cycle_collect,1088 07:36:18 INFO - PROCESS | 6459 | __end_cc_report 07:36:18 INFO - PROCESS | 6459 | __startTimestamp1461681378845__endTimestamp 07:36:18 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | ------- Summary: start ------- 07:36:18 INFO - PROCESS | 6459 | Number of tests: 14 07:36:18 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | [#0] ai-astar Cycles:10 Average:116.60 Median:116.50 stddev:4.70 (4.0%) stddev-sans-first:4.95 07:36:18 INFO - PROCESS | 6459 | Values: 118.0 109.0 115.0 117.0 115.0 128.0 115.0 116.0 117.0 116.0 07:36:18 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:163.00 stddev:25.50 (15.6%) stddev-sans-first:23.02 07:36:18 INFO - PROCESS | 6459 | Values: 192.0 154.0 181.0 172.0 124.0 149.0 146.0 122.0 175.0 124.0 07:36:18 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | [#2] audio-dft Cycles:10 Average:208.60 Median:198.50 stddev:25.94 (13.1%) stddev-sans-first:27.17 07:36:18 INFO - PROCESS | 6459 | Values: 197.0 196.0 234.0 274.0 204.0 198.0 197.0 199.0 197.0 190.0 07:36:18 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | [#3] audio-fft Cycles:10 Average:89.50 Median:56.00 stddev:41.76 (74.6%) stddev-sans-first:42.50 07:36:18 INFO - PROCESS | 6459 | Values: 56.0 109.0 107.0 179.0 83.0 56.0 57.0 61.0 131.0 56.0 07:36:18 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:80.00 stddev:24.31 (30.4%) stddev-sans-first:25.16 07:36:18 INFO - PROCESS | 6459 | Values: 80.0 83.0 140.0 76.0 79.0 80.0 124.0 81.0 83.0 125.0 07:36:18 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:88.00 stddev:9.55 (10.8%) stddev-sans-first:10.09 07:36:18 INFO - PROCESS | 6459 | Values: 89.0 88.0 88.0 85.0 103.0 113.0 90.0 88.0 89.0 80.0 07:36:18 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | [#6] imaging-darkroom Cycles:10 Average:104.40 Median:94.50 stddev:15.59 (16.5%) stddev-sans-first:16.08 07:36:18 INFO - PROCESS | 6459 | Values: 94.0 95.0 103.0 96.0 108.0 139.0 125.0 95.0 95.0 94.0 07:36:18 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | [#7] imaging-desaturate Cycles:10 Average:92.30 Median:92.50 stddev:3.47 (3.7%) stddev-sans-first:3.67 07:36:18 INFO - PROCESS | 6459 | Values: 93.0 93.0 91.0 88.0 96.0 87.0 92.0 92.0 92.0 99.0 07:36:18 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:72.00 stddev:13.91 (19.3%) stddev-sans-first:14.51 07:36:18 INFO - PROCESS | 6459 | Values: 57.0 80.0 48.0 54.0 73.0 46.0 53.0 71.0 76.0 83.0 07:36:18 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | [#9] json-stringify-tinderbox Cycles:10 Average:74.30 Median:74.50 stddev:13.45 (18.1%) stddev-sans-first:13.93 07:36:18 INFO - PROCESS | 6459 | Values: 66.0 67.0 74.0 66.0 75.0 58.0 77.0 97.0 98.0 65.0 07:36:18 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:1.16 (1.4%) stddev-sans-first:0.71 07:36:18 INFO - PROCESS | 6459 | Values: 86.0 82.0 84.0 83.0 83.0 84.0 82.0 83.0 83.0 83.0 07:36:18 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | [#11] stanford-crypto-ccm Cycles:10 Average:153.90 Median:154.00 stddev:21.24 (13.8%) stddev-sans-first:22.41 07:36:18 INFO - PROCESS | 6459 | Values: 160.0 150.0 137.0 137.0 140.0 140.0 158.0 168.0 206.0 143.0 07:36:18 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:202.30 Median:202.50 stddev:5.25 (2.6%) stddev-sans-first:5.55 07:36:18 INFO - PROCESS | 6459 | Values: 201.0 198.0 205.0 204.0 203.0 196.0 215.0 200.0 202.0 199.0 07:36:18 INFO - PROCESS | 6459 | 07:36:18 INFO - PROCESS | 6459 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.50 Median:72.00 stddev:11.97 (16.6%) stddev-sans-first:12.47 07:36:18 INFO - PROCESS | 6459 | Values: 71.0 70.0 70.0 69.0 70.0 73.0 69.0 88.0 96.0 99.0 07:36:18 INFO - PROCESS | 6459 | -------- Summary: end -------- 07:36:18 INFO - PROCESS | 6459 | 07:36:19 INFO - TEST-INFO | 6459: exit 0 07:36:19 INFO - TEST-OK | kraken | took 60489ms 07:36:19 INFO - SUITE-END | took 1171s 07:36:19 INFO - Completed test suite (00:19:32) 07:36:19 INFO - javascript benchmark 07:36:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2844.7724182065435, 3179.2846609512853, 3383.221858972436, 3403.8298085095726, 3436.1924947637285, 4706.670533062678, 4967.45358010619, 5601.0, 5622.044252477079, 5654.46282603153, 4582.931256031162, 5086.855457522065, 5511.090670039449, 5614.606977511576, 5729.828105156842, 5124.308218390525, 5128.717920514361, 5142.177251639739, 5236.397814251352, 5265.210218467222, 325.33798730424104, 4763.42821142574, 5078.542931136197, 5109.2591574221715, 5158.174692049273, 5111.386633603973, 5127.487251274862, 5149.9485005149845, 5160.277561141444, 5170.327857378555, 5153.6392452528335, 5166.095933211673, 5170.069387510247, 5188.299579556749, 5223.973880130575, 5044.965782014679, 5122.667026643294, 5128.230765385222, 5134.922976155361, 5203.583713302926, 4409.338599210112, 5406.675599464044, 5420.214068960018, 5429.701366424845, 5503.889922201533, 6036.305824830113, 6125.938740612626, 6167.814965551041, 6170.8765824683705, 6172.969135154295, 6140.62695141751, 6142.170806941095, 6148.200733904609, 6171.074338849164, 6186.226721659793, 5799.101139323411, 5801.564882633777, 5802.303723553201, 5805.738741756589, 5807.419258074201, 6125.785597504155, 6140.995089002448, 6241.843953901189, 6250.874982500324, 6251.12484252205, 6081.391860813883, 6089.543284253698, 6101.084837274444, 6113.663748493876, 6124.877502449926, 6157.9133062010715, 6165.0444181152, 6167.876642467126, 6193.225846769154, 6209.192804935329, 6034.487068599218, 6042.063480160582, 6079.544034197364, 6110.175126357974, 6139.416755408229, 6141.447269745744, 6142.201513803177, 6189.6286222825875, 6191.318954914956, 6211.875762484816, 4844.006978569385, 4937.333459982857, 4937.432195297515, 4937.802487900515, 4957.380327459067, 4311.956880431218, 4314.309710446313, 4427.601515863524, 4472.753998530047, 4509.143262780061, 5710.942890571124, 5725.541956643458, 5792.160136780143, 5801.3038435388025, 5871.060630299132, 6160.322364539897, 6169.96915015422, 6175.59858609189, 6184.81445556634, 6189.721462534197, 5602.691851948182, 5602.747876345574, 5670.432956704297, 5679.6876171810945, 5722.971385143131, 5323.0, 5389.218563308376, 5390.595705322116, 5390.838274851761, 5405.21624364465, 6125.204929265209, 6327.430531252209, 6335.239771227482, 6350.269718982284, 6356.904646430307, 6087.178230938766, 6090.485227154543, 6148.815535533941, 6150.446459818638, 6160.199174107337, 6276.278228003838, 6287.371262873676, 6300.558960872878, 6318.147050148171, 6349.238091429058, 5073.847784566321, 5104.464031276811, 5343.465653434625, 5806.954748145375, 6123.6631985239455, 5146.0, 5235.816746413857, 5906.586538942404, 6117.796956032775, 6183.598066125687, 6009.098635204754, 6027.095935609694, 6052.66710330936, 6057.061155520902, 6071.635701857903, 5948.672822994777, 6031.457168854648, 6050.30421501533, 6076.422739839708, 6080.969595151996, 5830.650160990354, 5948.5538584605465, 5996.370381110095, 6027.487663548647, 6037.577369584087, 6114.0, 6128.448439640454, 6145.262568491631, 6162.352952940056, 6165.876682466415, 4819.855404337875, 5812.099124635688, 5927.496162826208, 5985.191999080243, 6047.334793172659], "value": 5551.374758820232, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.4096686393487, 523.6727045596502, 538.3109619686801, 573.0945106731365, 602.7588964414236, 36961.0, 37693.811530942345, 37801.81099094504, 37817.810910945474, 37829.810850945774, 29718.702812971864, 34925.476117858256, 39428.40857387141, 39528.60471395285, 39615.0, 9228.6308547658, 9383.155516003559, 9506.47714375709, 9514.57184426699, 9515.28635352348, 9289.303302252325, 9472.289578281656, 9487.051294870527, 9520.381175223623, 9522.000189980055, 9459.337846350758, 9499.905000949972, 9505.239580833517, 9518.095780900803, 9532.428054316728, 9407.858882116774, 9470.242380609534, 9478.573464194127, 9479.715608531686, 9510.191633711109, 9369.344145909788, 9389.248860091177, 9514.191293740041, 9523.857142142873, 9539.046095390475, 37563.24873502515, 37735.0, 37912.43131353032, 38227.23545529074, 38236.42645360322, 2791.148699646607, 2798.9300267493477, 3008.052108933236, 3043.223977885647, 3161.2887100402454, 26608.733912661013, 27055.594166087525, 27684.031058913042, 27980.160595181973, 28603.14190574286, 2670.0136923779082, 2709.91870243893, 2716.2666080158247, 2727.6317697111035, 2852.87162077707, 298733.0, 401737.0, 401907.0, 403165.9841700802, 410747.0, 59734.402655973754, 59998.0, 60134.699326503964, 60178.49553761104, 60300.0, 53229.0, 58935.115973260436, 60556.78886422335, 61789.691051544454, 62997.68501157465, 16771.748423773653, 17335.479935601954, 17353.132343382782, 17374.47876563705, 17419.04195269247, 13138.868611313765, 13176.275304858133, 13240.53658121961, 13253.536126235536, 13274.336283185801, 16103.919480402523, 19308.4207473776, 19346.0, 19388.321408750908, 19441.513962150777, 7868.921310786934, 8091.635876385577, 8210.753677389688, 8245.876311855327, 8279.710210142615, 818.60706860706, 935.3125452792192, 962.3263715399248, 1039.6673064619401, 1132.4337831084458, 25808.09671661483, 27790.166295011182, 28759.856200718863, 29262.707372926423, 29603.555946660817, 1099.6316234061678, 1115.3363748569589, 1119.4906317625462, 1214.1379620469388, 1267.8732126787431, 14956.953013289183, 14985.550433487013, 15007.024543404645, 15398.769018464733, 15399.076055436486, 423729.0, 451220.0, 452145.0, 454836.0, 506020.0, 45773.54226457693, 58578.70710646419, 59105.11342329869, 59555.70222148862, 59938.70030649819, 1488.040214061924, 1504.4358365612895, 1505.0668585477074, 1505.631120375515, 1510.2448775612195, 27459.17622471329, 28850.567241491815, 29619.85190074036, 29777.85111074431, 30060.24849378783, 45608.85977850448, 48583.5141648579, 50894.49105509045, 51730.48269517257, 51762.741186293824, 408832.0, 419513.0, 463801.0, 468434.0, 469294.0, 27030.05394811251, 27380.452390951672, 27385.863070684518, 27438.45123097567, 27453.0, 43507.0, 43514.564854351054, 44124.0, 44185.779071104436, 44466.77766611146, 36579.63420365869, 36587.45118823273, 36754.63245367512, 37247.44128838124, 37367.0, 35950.82024589965, 35965.64034359623, 36412.81793591015, 36612.633873660925, 36946.0, 29568.408631827675, 35346.82326588454, 35982.0, 36972.630273696916, 37153.0, 29577.556336654536, 30933.535996959614, 30952.0, 31027.224319392197, 31399.529007064455, 20703.482412939797, 23613.881930590236, 23757.64363534514, 24666.630000550365, 25076.62385064189], "value": 19038.351134953642, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.69324381032305, 374.1282811050252, 392.99999999999983, 400.45538068227216, 408.28957613752044, 18351.449456516308, 20113.296034638755, 20166.59666806665, 20208.59582808343, 20316.984150792458, 19661.05084237365, 20157.899210503925, 20480.078396472156, 20562.69155962662, 21185.68221476679, 5250.422453530108, 5664.858378540528, 5711.343195532505, 5989.700514974255, 6007.969960150193, 4965.776540055706, 5791.942080579203, 5819.447152520504, 5903.4686878180955, 5944.762209511614, 5594.356648985378, 5823.9708801456145, 5825.621334613258, 5846.853828654275, 5875.324337701177, 5688.11834165705, 5748.798792042258, 5758.251427314443, 5814.215080964079, 5815.88368232633, 4408.382826404306, 4523.592876641118, 4986.800527978877, 5085.313482679865, 5112.590992720573, 19814.0, 22434.32697019092, 24835.751642483523, 24867.50264994708, 24933.5013299733, 2234.430220293831, 2250.7861753133425, 2258.525709600986, 2311.8150547956293, 2497.5379554782426, 12740.936295318465, 13971.720565588734, 14546.709065818624, 14783.039102458413, 15224.0, 1772.831580999803, 1786.4729904678152, 1792.856571474279, 1799.3072667023291, 1821.790494093183, 92133.0, 96427.07145857114, 98954.0, 98965.51551726658, 99594.50202749012, 9247.352685312098, 10582.735431614272, 10799.352038877692, 10896.836547451794, 11165.162612804072, 13581.981351398685, 13648.0, 13680.589582312547, 13703.314834258248, 13704.931475342759, 7441.958125862384, 8549.914500855037, 8680.826383472295, 8757.386982911135, 8802.823943521094, 8796.648134074565, 8823.073577274294, 8837.779055523662, 8868.556572171366, 8933.865992009994, 5642.576806739511, 6526.934730652632, 6653.500987425962, 6718.596884186867, 6726.22648395431, 1869.2055876252539, 1927.2483731344787, 1928.5150434165614, 1932.6327997680396, 1968.4783532363936, 953.68051702679, 993.1409330928839, 1019.8373853806667, 1020.9285350025427, 1092.7705181911729, 19434.028298585014, 20299.79700202979, 20515.974201289875, 20592.382228533166, 20779.58440831205, 1006.9748256293651, 1007.1137399088755, 1032.4837581209395, 1035.316690983947, 1071.539238127597, 10091.646792362379, 11155.888441115647, 11155.944220279009, 11188.272762270426, 11214.327140371604, 599901.0004950034, 610626.0, 614233.0, 618135.0, 637451.0, 69284.0, 87085.12914870896, 90368.0, 90681.09318906859, 96518.0, 1019.887812340642, 1046.942418167008, 1051.731808388856, 1062.2776511971779, 1066.871975362946, 18026.63946721032, 18149.818501814814, 18293.451196464128, 18330.633387332444, 18795.154218060492, 46105.76947115243, 46969.53030469651, 47848.0, 47978.0, 48480.0, 64262.67868660627, 64390.678046609464, 64512.354876450634, 65251.02123468247, 66156.0, 7792.84414311722, 7832.334251588451, 7900.486468379537, 8003.239692229229, 8005.839883202187, 9705.272104592043, 11103.889611038832, 11486.597969071043, 12206.0, 12469.438875250455, 10529.473526323807, 10775.892241077489, 10798.892011079788, 10987.670369888916, 11341.546338146381, 10112.949435252776, 10551.419671918118, 10729.034386904903, 10842.620508282173, 10929.836052459379, 10926.0, 11203.047740942111, 11244.55021799119, 11353.37556434404, 11460.426978650867, 7157.57054576727, 7755.0, 7865.410094243069, 7932.16712245206, 8064.193580641889, 7506.361959233526, 10037.397756134655, 10829.0, 11041.613543525938, 11090.944545277222], "value": 9381.9353500616, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.5674932644197, 1611.484325015995, 1861.6276744651072, 1941.2429152630477, 1978.821906028459, 7849.68601255949, 8462.661493540267, 8763.386562940597, 9098.044705305938, 9180.357374983745, 8426.578671066438, 8535.57322133894, 8574.614142363593, 8601.91398086019, 8620.74137775866, 2428.2229686500327, 2463.987680061597, 2466.05057053035, 2468.4445999650115, 2475.6905386826647, 2432.2460037388378, 2493.13986674597, 2494.950100997988, 2498.100683753856, 2506.9373265668323, 2453.668754718117, 2458.840175388603, 2488.6142647889606, 2491.613799861015, 2507.2728908616477, 2457.1891275878916, 2459.86470744109, 2474.653548503211, 2488.4276616378243, 2491.028498885436, 2453.2640207937548, 2461.938451538708, 2465.506898620283, 2466.802655787533, 2475.8390704604144, 8657.740267791976, 8661.393702440831, 8693.261072808818, 8728.563571821383, 8746.431481953652, 5320.334958130234, 5479.150731636602, 5502.697351645658, 5505.421930697299, 5511.311086114236, 3595.2989167112423, 3606.1165014571334, 3616.6437585905287, 3672.6143754905615, 3693.8153092345274, 1029.711680729397, 1036.0778906772978, 1040.583766493401, 1045.5347370420166, 1047.1570385839395, 11602.419879006016, 11702.707432314175, 11733.4719937603, 11751.588694395656, 11785.469653865597, 4835.661503694778, 4854.344663470457, 4970.975145124251, 4972.229304457815, 5003.074431230234, 9981.850272245922, 10063.0, 10088.890222075566, 10093.142082922886, 10148.441835699108, 5411.756470958738, 5444.373897001896, 5477.0, 5480.424555421623, 5483.479069488392, 4391.8682439526865, 4885.389326334208, 4947.876303092451, 5056.06462804375, 5079.746012699424, 3692.3538380783257, 4085.722182737134, 4093.345064789679, 4176.791160441966, 4177.540470548237, 1353.363918958108, 1378.9586312410643, 1385.3211926156312, 1389.1248513436672, 1399.818023656918, 805.1746959366697, 827.3546633625782, 885.9601317940708, 886.6054605700401, 943.9528023598792, 5542.140968149944, 5717.142428635655, 5842.649441033552, 5985.670788106609, 6003.729832157476, 433.5989209980755, 445.04537766490694, 455.5217022126754, 455.67191622032084, 469.6477641768673, 3717.628237176261, 3758.4362345648374, 3764.247150569897, 3806.7906265155684, 3821.0, 10464.372137671764, 10705.411202383788, 10753.51609177589, 11071.0, 11084.390358530198, 8002.0, 9070.591823367964, 9471.621135154655, 9587.808243835085, 10403.895961040293, 6982.0, 7944.483608565541, 8329.50022998622, 8391.958040209882, 8419.452735572046, 5859.857327821034, 5907.881842363215, 6012.458878700938, 6024.487918526975, 6128.509719222362, 8236.876446853423, 10221.029002244775, 10237.334573253012, 10241.641542545975, 10308.845367319345, 8099.716509922125, 10305.175585952957, 10378.896211037792, 10410.0, 10472.10987066108, 6841.076454678555, 7403.8149046274275, 7419.0, 7693.230676932486, 7751.3411360035025, 8424.663013479638, 8473.95763021181, 8518.872216916876, 8525.914740852511, 8526.616302266537, 7329.926700733137, 7488.737894173678, 7591.924080759121, 7602.961985190039, 7649.6557654904545, 7354.521956072838, 7356.006939063158, 7431.29402706742, 7458.5151965122095, 7513.211112833293, 7034.402075823407, 7078.0, 7084.433245340258, 7098.43212542985, 7117.537360071578, 4772.976135119302, 4799.640026998059, 4948.356713627206, 4949.950500494949, 5084.034033533617, 4876.756162191805, 4972.477889821516, 5011.4487406386, 5017.774200161075, 5190.480951904779], "value": 4547.262632457981, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.3833808115025, 320.66810850769457, 323.90444818778457, 325.1335191714082, 327.4744035822505, 5050.772715227814, 5579.832605021856, 5605.607607467474, 5647.407022262654, 5649.745761440729, 5115.718635475047, 5245.423003469616, 5545.334559852813, 5557.749901254443, 5566.805161819327, 4048.6153815387565, 4052.7770972596495, 4143.274926887798, 4150.813213405404, 4196.244675958326, 3921.64701179293, 4027.4224496322377, 4108.678596592916, 4166.395872598471, 4194.643455306303, 3818.7589033564063, 3977.2443235785254, 4130.277201489727, 4134.917301653965, 4142.440770495989, 3431.330890476358, 3948.0919388540797, 4009.5470160581585, 4101.671866250693, 4156.334986402177, 2936.9118926432243, 3608.7293452990866, 3616.8191590420374, 3618.7466877318598, 3638.43604241343, 4377.584129507692, 4814.277858321279, 4942.498901888745, 5145.459726728677, 5238.5023422774775, 4441.955580444219, 4745.1695953208055, 4751.904961900777, 4780.80876764929, 4796.088743138827, 5865.677387743673, 5881.67650779207, 5890.764369425261, 5907.172995780594, 5932.317783454915, 3512.7189824813954, 3960.386140148282, 3977.925959990815, 3992.960070399317, 4002.3590327965394, 4857.0, 4906.239532872411, 5460.590455715837, 5998.250218722616, 6190.2571691397325, 3976.940345894814, 4019.437278780973, 4032.1532478179324, 4036.455078564415, 4051.6353528182017, 3600.855965761393, 3661.5240018797385, 3701.444783282529, 4091.97954010228, 4108.239975604522, 4737.573618374363, 4769.260764581495, 4769.499202583679, 4775.0, 4796.35249241348, 5580.246666700024, 5915.438033386908, 5949.286085669747, 5967.701614919237, 5974.880502389928, 1435.468876515696, 1447.8190226221723, 1450.6010847016944, 1453.3677850135225, 1460.4085345435117, 810.9148539403395, 885.5970533407414, 940.9304756926321, 968.2012339819677, 976.2580438866513, 5161.0, 5822.184894114827, 5830.7959221427045, 5859.150423188614, 5875.588708790429, 6531.872480103097, 6536.542442029012, 6545.934540654628, 6599.274079851212, 6614.040964060185, 4224.894377640584, 5153.484651534892, 5729.25519682447, 5833.270841144857, 5866.032104702762, 3277.5903012123485, 3395.2530443302435, 3449.8443021587545, 3450.896473105811, 3475.6871881530783, 5251.579873610102, 6377.904331435032, 6658.300878407795, 6825.385715285648, 6838.829029274308, 5340.038793017294, 5860.157823455621, 5959.791407300723, 6734.45107625249, 6791.72833086671, 5603.6077474577205, 5797.565182611321, 6734.932650673529, 6747.797566073025, 6810.250872404032, 6515.250746164252, 6516.869662606627, 6533.509986750918, 6580.144581204413, 6585.341465853377, 5448.618596698193, 6441.033844923111, 6453.128827608401, 6459.515536334888, 6493.935060649522, 5045.351190624804, 5887.381824908323, 5951.613145145551, 6373.171487706569, 6394.808155755335, 3161.9051428457183, 3510.8771193008124, 3967.4643923070016, 4009.0, 4054.1283624020975, 6039.33918172506, 6126.816195514141, 6193.783217587363, 6207.689615519296, 6219.782307619212, 5940.762369505172, 5946.524278057658, 5971.820845374646, 5974.4324289192455, 5977.310210405422, 5281.811592391835, 5640.435956404491, 5903.822885313448, 5982.371850955587, 6002.249718785152, 4853.9029219416125, 5367.114426119802, 5372.62391632582, 5822.621529600562, 5865.677387743715, 5453.100238460768, 5704.771809127755, 5933.732982015733, 5958.914379966977, 5999.970000149971, 4932.988737308915, 4938.456769755396, 5733.31200255972, 5878.441548052928, 5912.556558258234], "value": 4331.454358318251, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.7327252280395, 730.6638946084801, 732.2055569706868, 737.2443245673185, 745.903032605761, 14730.0, 14807.889408294368, 15087.924560377196, 15247.923760381183, 15275.847241527581, 13878.097923634956, 14150.150990940525, 14177.0, 14232.71534569308, 14250.4299828007, 631.7094136697114, 722.3498851034059, 883.6951251818112, 912.6212621761961, 924.4545718026396, 899.6896070855545, 913.8720579118929, 918.1507105927025, 921.258386998466, 923.5336155241628, 961.5817119552981, 970.6845275285525, 974.8050389922043, 977.1205914676776, 977.1986970684042, 950.9191718703919, 951.8048799996053, 966.0, 969.5733877094056, 973.795502944379, 704.4962851561107, 708.5677736580682, 711.2531841566334, 724.5109551053071, 725.4595326481805, 14882.107073575511, 14976.251187440585, 14993.475228366955, 14999.550013499613, 15020.0, 12426.378681066, 12491.504417702834, 12665.620031399072, 12677.936610316981, 12755.36223188846, 9859.408435493822, 10077.344972576833, 10140.594376224943, 10273.897261027369, 10380.377177369306, 3362.714169295613, 3476.704480119193, 3486.180747524355, 3551.662592053751, 3558.9644103558894, 59728.0, 63114.053289200696, 64537.99999999953, 69756.0, 81665.0, 9470.195033422237, 9473.668421605349, 9477.668281610111, 9523.952380238194, 9755.658551950648, 21704.674429883566, 21889.12443502274, 21933.01301441439, 22028.88985555062, 22088.447788805086, 6727.764528241488, 7050.4727157045045, 7277.599732014684, 7295.088113985752, 7586.62066896653, 3276.9344613107605, 4080.265552200573, 4101.241270364992, 4139.068709540329, 4165.354370072643, 3173.444647186779, 3345.6988871001727, 3534.699550538233, 3568.411212149966, 3605.4772058051435, 624.5628060357768, 627.2535682537857, 653.3825534869598, 655.77048033188, 660.6366498425847, 554.1715135871897, 570.6347937320119, 589.5254320272222, 604.4771272848953, 608.5496732417979, 7870.370370370357, 8176.836463270702, 8285.171482851667, 8320.37597180214, 8377.162283771697, 540.5891522442971, 596.9373215812277, 598.8202052248089, 598.9309083286313, 607.8541150123939, 3610.332088563624, 3891.747036442679, 3900.278448487039, 3940.4877365942243, 4040.7370224413526, 89054.0, 89537.20925581452, 91936.54031729799, 96686.0, 96983.0, 81185.0, 81208.37583248301, 81431.0, 82821.58589207016, 82943.7558436624, 64764.67617661976, 68453.3154668447, 69940.65029674921, 70621.64689176624, 70727.0, 8285.130061343472, 8373.706920257762, 8377.45546539473, 8441.577921104043, 8466.957665211634, 27898.0, 40457.797711011255, 41259.93700314912, 43094.56905430905, 44523.55476445194, 50989.66587840075, 59090.0, 65478.67260663666, 65638.0, 66874.66562667156, 10815.621453249098, 10832.67501974942, 10935.015848573667, 10964.396958167377, 11123.615001363502, 11836.0, 11860.34768087729, 11883.0, 12176.512939482322, 12388.690282743004, 9200.539973001189, 11511.942440287745, 11533.538658453568, 11538.76922461563, 11802.291862488279, 11289.548418063185, 11335.943320283346, 11378.0, 11624.941875290908, 11793.941030294794, 11020.614278500534, 11287.266327688674, 11315.547378104784, 11582.594609188638, 11615.303081815118, 9585.424874507551, 9675.274354423305, 9846.0, 10181.84727229107, 10339.0, 9650.131488166098, 9674.85487717699, 9755.0, 9766.414015159113, 9894.604215831574], "value": 6815.076781955408, "unit": "score"}], "name": "dromaeo_css", "value": 7145.563778859225, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 109.0, 115.0, 117.0, 115.0, 128.0, 115.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 154.0, 181.0, 172.0, 124.0, 149.0, 146.0, 122.0, 175.0, 124.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 196.0, 234.0, 274.0, 204.0, 198.0, 197.0, 199.0, 197.0, 190.0], "value": 208.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 109.0, 107.0, 179.0, 83.0, 56.0, 57.0, 61.0, 131.0, 56.0], "value": 89.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 140.0, 76.0, 79.0, 80.0, 124.0, 81.0, 83.0, 125.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 88.0, 85.0, 103.0, 113.0, 90.0, 88.0, 89.0, 80.0], "value": 91.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 103.0, 96.0, 108.0, 139.0, 125.0, 95.0, 95.0, 94.0], "value": 104.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 91.0, 88.0, 96.0, 87.0, 92.0, 92.0, 92.0, 99.0], "value": 92.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 80.0, 48.0, 54.0, 73.0, 46.0, 53.0, 71.0, 76.0, 83.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 74.0, 66.0, 75.0, 58.0, 77.0, 97.0, 98.0, 65.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 84.0, 83.0, 83.0, 84.0, 82.0, 83.0, 83.0, 83.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 150.0, 137.0, 137.0, 140.0, 140.0, 158.0, 168.0, 206.0, 143.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 198.0, 205.0, 204.0, 203.0, 196.0, 215.0, 200.0, 202.0, 199.0], "value": 202.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 69.0, 70.0, 73.0, 69.0, 88.0, 96.0, 99.0], "value": 77.5, "unit": "score"}], "name": "kraken", "value": 1607.1, "alertThreshold": 2.0}]} 07:36:20 INFO - Return code: 0 07:36:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:36:20 ERROR - # TBPL SUCCESS # 07:36:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:36:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:36:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:36:20 INFO - 2016-04-26 07:36:20.145 screenresolution[6464:113675] starting screenresolution argv=screenresolution get 07:36:20 INFO - 2016-04-26 07:36:20.147 screenresolution[6464:113675] Display 0: 1600x1200x32@60 07:36:20 INFO - 2016-04-26 07:36:20.154 screenresolution[6465:113677] starting screenresolution argv=screenresolution list 07:36:20 INFO - Available Modes on Display 0 07:36:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:36:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:36:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:36:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:36:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:36:20 INFO - Intel Iris: 07:36:20 INFO - Chipset Model: Intel Iris 07:36:20 INFO - Type: GPU 07:36:20 INFO - Bus: Built-In 07:36:20 INFO - VRAM (Dynamic, Max): 1536 MB 07:36:20 INFO - Vendor: Intel (0x8086) 07:36:20 INFO - Device ID: 0x0a2e 07:36:20 INFO - Revision ID: 0x0009 07:36:20 INFO - Displays: 07:36:20 INFO - Display: 07:36:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:36:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:36:20 INFO - Display Serial Number: 1600x1200 60 07:36:20 INFO - Main Display: Yes 07:36:20 INFO - Mirror: Off 07:36:20 INFO - Online: Yes 07:36:20 INFO - Rotation: Supported 07:36:20 INFO - Return code: 0 07:36:20 INFO - Running post-action listener: _resource_record_post_action 07:36:20 INFO - Running post-run listener: _resource_record_post_run 07:36:21 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 1224704; Write bytes: 699942912; Read time: 13; Write time: 1949 07:36:21 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 386652672; Write bytes: 380384768; Read time: 28618; Write time: 687 07:36:21 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 1224704; Write bytes: 301838848; Read time: 13; Write time: 1220 07:36:21 INFO - Running post-run listener: _upload_blobber_files 07:36:21 INFO - Blob upload gear active. 07:36:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:36:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:36:21 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:36:21 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:36:21 INFO - (blobuploader) - INFO - Open directory for files ... 07:36:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:36:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:36:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:23 INFO - (blobuploader) - INFO - Done attempting. 07:36:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:36:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:36:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:24 INFO - (blobuploader) - INFO - Done attempting. 07:36:24 INFO - (blobuploader) - INFO - Iteration through files over. 07:36:24 INFO - Return code: 0 07:36:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:36:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:36:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b64883900af62224d57831d10931d7ff34643332673fc1ef230c1b688d9afa5333a3b163ed4be57198097d227c98671c610e60b729111cbcc1689789b5a2372a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a3c16cfdfc76cf20ea4dc4667d20a2cb6357cb727e15354848cbe130e372af3a12cdc3cfb6dfd2560fc515a87c33bdd617d0db08b1ecfc61cd8dc9ef886acca"} 07:36:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:36:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:36:24 INFO - Contents: 07:36:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b64883900af62224d57831d10931d7ff34643332673fc1ef230c1b688d9afa5333a3b163ed4be57198097d227c98671c610e60b729111cbcc1689789b5a2372a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a3c16cfdfc76cf20ea4dc4667d20a2cb6357cb727e15354848cbe130e372af3a12cdc3cfb6dfd2560fc515a87c33bdd617d0db08b1ecfc61cd8dc9ef886acca"} 07:36:24 INFO - Running post-run listener: copy_logs_to_upload_dir 07:36:24 INFO - Copying logs to upload dir... 07:36:24 INFO - mkdir: /builds/slave/test/build/upload/logs 07:36:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.861352 ========= master_lag: 5.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-04-26 07:36:29.393144) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 7 secs) (at 2016-04-26 07:36:29.394273) ========= 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.Eex3ethMNk/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.icMvRAxBCA/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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/Firefox/sha512/b64883900af62224d57831d10931d7ff34643332673fc1ef230c1b688d9afa5333a3b163ed4be57198097d227c98671c610e60b729111cbcc1689789b5a2372a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a3c16cfdfc76cf20ea4dc4667d20a2cb6357cb727e15354848cbe130e372af3a12cdc3cfb6dfd2560fc515a87c33bdd617d0db08b1ecfc61cd8dc9ef886acca"} build_url:https://queue.taskcluster.net/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/a9P__UFFSeufcc-tgULqxA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b64883900af62224d57831d10931d7ff34643332673fc1ef230c1b688d9afa5333a3b163ed4be57198097d227c98671c610e60b729111cbcc1689789b5a2372a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a3c16cfdfc76cf20ea4dc4667d20a2cb6357cb727e15354848cbe130e372af3a12cdc3cfb6dfd2560fc515a87c33bdd617d0db08b1ecfc61cd8dc9ef886acca"}' ========= master_lag: 7.56 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 7 secs) (at 2016-04-26 07:36:36.966355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 7 secs) (at 2016-04-26 07:36:36.966871) ========= 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.Eex3ethMNk/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.icMvRAxBCA/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.005242 ========= master_lag: 7.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 7 secs) (at 2016-04-26 07:36:44.135078) ========= ========= Started reboot skipped (results: 3, elapsed: 6 secs) (at 2016-04-26 07:36:44.138227) ========= ========= Finished reboot skipped (results: 3, elapsed: 6 secs) (at 2016-04-26 07:36:50.608202) ========= ========= Total master_lag: 49.12 =========