builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0299 starttime: 1464027099.55 results: success (0) buildid: 20160522193137 builduid: c858fb39af334cefa248ec2a3b22030a revision: 2e8129bd6590404ff56ea35ac30d719cf7f566ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:39.552593) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:39.553085) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:39.553363) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:39.666813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:39.667096) ========= 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.sCyLeTvWIy/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.0XRmjeW4Wd/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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-05-23 11:11:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2016-05-23 11:11:40 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.626816 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:40.318456) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:40.319100) ========= 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.sCyLeTvWIy/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.0XRmjeW4Wd/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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.025989 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:40.367062) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 11:11:40.367412) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2e8129bd6590404ff56ea35ac30d719cf7f566ae --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2e8129bd6590404ff56ea35ac30d719cf7f566ae --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sCyLeTvWIy/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.0XRmjeW4Wd/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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-05-23 11:11:40,449 truncating revision to first 12 chars 2016-05-23 11:11:40,449 Setting DEBUG logging. 2016-05-23 11:11:40,449 attempt 1/10 2016-05-23 11:11:40,449 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2e8129bd6590?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 11:11:41,639 unpacking tar archive at: mozilla-beta-2e8129bd6590/testing/mozharness/ program finished with exit code 0 elapsedTime=1.590796 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 11:11:41.975250) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:41.975569) ========= script_repo_revision: 2e8129bd6590404ff56ea35ac30d719cf7f566ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:41.975951) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:41.976453) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 11:11:41.991012) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2016-05-23 11:11:41.991412) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sCyLeTvWIy/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.0XRmjeW4Wd/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 11:11:42 INFO - MultiFileLogger online at 20160523 11:11:42 in /builds/slave/test 11:11:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:11:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:11:42 INFO - {'append_to_log': False, 11:11:42 INFO - 'base_work_dir': '/builds/slave/test', 11:11:42 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:11:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:11:42 INFO - 'branch': 'Mozilla-Beta', 11:11:42 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:42 INFO - 'config_files': ('talos/mac_config.py',), 11:11:42 INFO - 'default_actions': ('clobber', 11:11:42 INFO - 'read-buildbot-config', 11:11:42 INFO - 'download-and-extract', 11:11:42 INFO - 'populate-webroot', 11:11:42 INFO - 'create-virtualenv', 11:11:42 INFO - 'install', 11:11:42 INFO - 'run-tests'), 11:11:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:42 INFO - 'download_minidump_stackwalk': True, 11:11:42 INFO - 'download_symbols': 'ondemand', 11:11:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:11:42 INFO - 'tooltool.py': '/tools/tooltool.py', 11:11:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:11:42 INFO - '/tools/misc-python/virtualenv.py')}, 11:11:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:42 INFO - 'installer_path': 'installer.exe', 11:11:42 INFO - 'log_level': 'info', 11:11:42 INFO - 'log_name': 'talos', 11:11:42 INFO - 'log_to_console': True, 11:11:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:11:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:11:42 INFO - 'opt_config_files': (), 11:11:42 INFO - 'pip_index': False, 11:11:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:11:42 INFO - 'cmd': ('bash', 11:11:42 INFO - '-c', 11:11:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:11:42 INFO - 'enabled': True, 11:11:42 INFO - 'halt_on_failure': False, 11:11:42 INFO - 'name': 'check_screen_resolution'},), 11:11:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:11:42 INFO - 'cmd': ('bash', 11:11:42 INFO - '-c', 11:11:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:11:42 INFO - 'enabled': True, 11:11:42 INFO - 'halt_on_failure': False, 11:11:42 INFO - 'name': 'check_screen_resolution'},), 11:11:42 INFO - 'run_cmd_checks_enabled': True, 11:11:42 INFO - 'sps_profile': False, 11:11:42 INFO - 'sps_profile_interval': 0, 11:11:42 INFO - 'suite': 'dromaeojs-e10s', 11:11:42 INFO - 'system_bits': '32', 11:11:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:42 INFO - 'title': 't-yosemite-r7-0299', 11:11:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:42 INFO - 'use_talos_json': True, 11:11:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:11:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:42 INFO - 'work_dir': 'build'} 11:11:42 INFO - ##### 11:11:42 INFO - ##### Running clobber step. 11:11:42 INFO - ##### 11:11:42 INFO - Running pre-action listener: _resource_record_pre_action 11:11:42 INFO - Running main action method: clobber 11:11:42 INFO - rmtree: /builds/slave/test/build 11:11:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:11:44 INFO - Running post-action listener: _resource_record_post_action 11:11:44 INFO - ##### 11:11:44 INFO - ##### Running read-buildbot-config step. 11:11:44 INFO - ##### 11:11:44 INFO - Running pre-action listener: _resource_record_pre_action 11:11:44 INFO - Running main action method: read_buildbot_config 11:11:44 INFO - Using buildbot properties: 11:11:44 INFO - { 11:11:44 INFO - "project": "", 11:11:44 INFO - "product": "firefox", 11:11:44 INFO - "script_repo_revision": "production", 11:11:44 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 11:11:44 INFO - "repository": "", 11:11:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 11:11:44 INFO - "buildid": "20160522193137", 11:11:44 INFO - "pgo_build": "False", 11:11:44 INFO - "basedir": "/builds/slave/test", 11:11:44 INFO - "buildnumber": 85, 11:11:44 INFO - "slavename": "t-yosemite-r7-0299", 11:11:44 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:11:44 INFO - "platform": "yosemite_r7", 11:11:44 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:11:44 INFO - "branch": "mozilla-beta", 11:11:44 INFO - "repo_path": "releases/mozilla-beta", 11:11:44 INFO - "revision": "2e8129bd6590404ff56ea35ac30d719cf7f566ae", 11:11:44 INFO - "stage_platform": "macosx64", 11:11:44 INFO - "builduid": "c858fb39af334cefa248ec2a3b22030a", 11:11:44 INFO - "slavebuilddir": "test" 11:11:44 INFO - } 11:11:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 11:11:44 INFO - Running post-action listener: _resource_record_post_action 11:11:44 INFO - ##### 11:11:44 INFO - ##### Running download-and-extract step. 11:11:44 INFO - ##### 11:11:44 INFO - Running pre-action listener: _resource_record_pre_action 11:11:44 INFO - Running main action method: download_and_extract 11:11:44 INFO - mkdir: /builds/slave/test/build/tests 11:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:44 INFO - https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:11:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 11:11:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 11:11:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 11:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 11:12:14 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json: timed out 11:12:14 INFO - retry: attempt #1 caught exception: timed out 11:12:14 INFO - retry: Failed, sleeping 30 seconds before retrying 11:12:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #2 11:12:49 INFO - Downloaded 1241 bytes. 11:12:49 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 11:12:49 INFO - Using the following test package requirements: 11:12:49 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 11:12:49 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:12:49 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 11:12:49 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:12:49 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 11:12:49 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:12:49 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:12:49 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 11:12:49 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 11:12:49 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:12:49 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 11:12:49 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:12:49 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 11:12:49 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:12:49 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 11:12:49 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 11:12:49 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:12:49 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 11:12:49 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 11:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:49 INFO - https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:12:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 11:12:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 11:12:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 11:12:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 11:12:50 INFO - Downloaded 17747767 bytes. 11:12:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:12:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:12:53 INFO - Return code: 0 11:12:53 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:53 INFO - https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:12:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 11:12:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 11:12:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 11:12:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 11:12:58 INFO - Downloaded 17747767 bytes. 11:12:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:12:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:13:01 INFO - Return code: 0 11:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:01 INFO - https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:13:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 11:13:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 11:13:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 11:13:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 11:13:03 INFO - Downloaded 10845194 bytes. 11:13:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:13:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:13:03 INFO - Return code: 0 11:13: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')]} 11:13:03 INFO - https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 11:13:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg 11:13:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg 11:13:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 11:13:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 11:13:06 INFO - Downloaded 88423479 bytes. 11:13:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg 11:13:06 INFO - mkdir: /builds/slave/test/properties 11:13:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:13:06 INFO - Writing to file /builds/slave/test/properties/build_url 11:13:06 INFO - Contents: 11:13:06 INFO - build_url:https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg 11:13:07 INFO - Running post-action listener: _resource_record_post_action 11:13:07 INFO - Running post-action listener: set_extra_try_arguments 11:13:07 INFO - ##### 11:13:07 INFO - ##### Running populate-webroot step. 11:13:07 INFO - ##### 11:13:07 INFO - Running pre-action listener: _resource_record_pre_action 11:13:07 INFO - Running main action method: populate_webroot 11:13:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:13:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:13:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:13:07 INFO - '--tppagecycles', 11:13:07 INFO - '7'], 11:13:07 INFO - 'tests': ['tsvgm']}}, 11:13:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:13:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:13:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:13:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:13:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:13:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:13:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:07 INFO - 'talos_options': ['--e10s'], 11:13:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:07 INFO - 'tests': ['damp', 'tps']}, 11:13:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:07 INFO - 'talos_options': ['--e10s'], 11:13:07 INFO - 'tests': ['damp', 'tps']}, 11:13:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:13:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:13:07 INFO - 'other': {'tests': ['a11yr', 11:13:07 INFO - 'ts_paint', 11:13:07 INFO - 'tpaint', 11:13:07 INFO - 'sessionrestore', 11:13:07 INFO - 'sessionrestore_no_auto_restore', 11:13:07 INFO - 'tabpaint']}, 11:13:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:13:07 INFO - 'tests': ['a11yr', 11:13:07 INFO - 'ts_paint', 11:13:07 INFO - 'tpaint', 11:13:07 INFO - 'sessionrestore', 11:13:07 INFO - 'sessionrestore_no_auto_restore', 11:13:07 INFO - 'tabpaint']}, 11:13:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:13:07 INFO - 'tests': ['a11yr', 11:13:07 INFO - 'ts_paint', 11:13:07 INFO - 'tpaint', 11:13:07 INFO - 'sessionrestore', 11:13:07 INFO - 'sessionrestore_no_auto_restore', 11:13:07 INFO - 'tabpaint']}, 11:13:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:13:07 INFO - 'tests': ['a11yr', 11:13:07 INFO - 'ts_paint', 11:13:07 INFO - 'tpaint', 11:13:07 INFO - 'sessionrestore', 11:13:07 INFO - 'sessionrestore_no_auto_restore', 11:13:07 INFO - 'tabpaint']}, 11:13:07 INFO - 'other_l64': {'tests': ['a11yr', 11:13:07 INFO - 'ts_paint', 11:13:07 INFO - 'tpaint', 11:13:07 INFO - 'sessionrestore', 11:13:07 INFO - 'sessionrestore_no_auto_restore', 11:13:07 INFO - 'tabpaint']}, 11:13:07 INFO - 'other_nol64': {'tests': ['a11yr', 11:13:07 INFO - 'ts_paint', 11:13:07 INFO - 'tpaint', 11:13:07 INFO - 'sessionrestore', 11:13:07 INFO - 'sessionrestore_no_auto_restore', 11:13:07 INFO - 'tabpaint']}, 11:13:07 INFO - 'svgr': {'tests': ['tsvgx', 11:13:07 INFO - 'tsvgr_opacity', 11:13:07 INFO - 'tart', 11:13:07 INFO - 'tscrollx', 11:13:07 INFO - 'cart']}, 11:13:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:13:07 INFO - 'tests': ['tsvgx', 11:13:07 INFO - 'tsvgr_opacity', 11:13:07 INFO - 'tart', 11:13:07 INFO - 'tscrollx', 11:13:07 INFO - 'cart']}, 11:13:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:07 INFO - 'tests': ['tp5o']}, 11:13:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:07 INFO - 'talos_options': ['--e10s'], 11:13:07 INFO - 'tests': ['tp5o']}, 11:13:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:07 INFO - 'talos_options': ['--xperf_path', 11:13:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:07 INFO - 'tests': ['tp5n']}, 11:13:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:07 INFO - 'talos_options': ['--e10s', 11:13:07 INFO - '--xperf_path', 11:13:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:07 INFO - 'tests': ['tp5n']}}, 11:13:07 INFO - 'talos.zip': {'path': '', 11:13:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:13:07 INFO - Running post-action listener: _resource_record_post_action 11:13:07 INFO - ##### 11:13:07 INFO - ##### Running create-virtualenv step. 11:13:07 INFO - ##### 11:13:07 INFO - Running pre-action listener: _resource_record_pre_action 11:13:07 INFO - Running main action method: create_virtualenv 11:13:07 INFO - Creating virtualenv /builds/slave/test/build/venv 11:13:07 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 11:13:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:13:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:13:07 INFO - Using real prefix '/tools/python27' 11:13:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:13:08 INFO - Installing distribute.............................................................................................................................................................................................done. 11:13:11 INFO - Installing pip.................done. 11:13:11 INFO - Return code: 0 11:13:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:11 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 0x1016dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0d8da1c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101582d30>, '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 0x1013e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101579b20>, '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.sCyLeTvWIy/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.0XRmjeW4Wd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 11:13:11 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 11:13:11 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 11:13:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sCyLeTvWIy/Render', 11:13:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:11 INFO - 'HOME': '/Users/cltbld', 11:13:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:11 INFO - 'LOGNAME': 'cltbld', 11:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:11 INFO - 'MOZ_NO_REMOTE': '1', 11:13:11 INFO - 'NO_EM_RESTART': '1', 11:13:11 INFO - 'PAGER': '/bin/cat', 11:13:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:11 INFO - 'PWD': '/builds/slave/test', 11:13:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:11 INFO - 'SHELL': '/bin/bash', 11:13:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XRmjeW4Wd/Listeners', 11:13:11 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 11:13:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:11 INFO - 'USER': 'cltbld', 11:13:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:11 INFO - 'XPC_FLAGS': '0x0', 11:13:11 INFO - 'XPC_SERVICE_NAME': '0', 11:13:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:11 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 11:13:11 INFO - Cleaning up... 11:13:11 INFO - Return code: 0 11:13:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:11 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 0x1016dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0d8da1c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101582d30>, '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 0x1013e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101579b20>, '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.sCyLeTvWIy/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.0XRmjeW4Wd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 11:13:11 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 11:13:11 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 11:13:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sCyLeTvWIy/Render', 11:13:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:11 INFO - 'HOME': '/Users/cltbld', 11:13:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:11 INFO - 'LOGNAME': 'cltbld', 11:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:11 INFO - 'MOZ_NO_REMOTE': '1', 11:13:11 INFO - 'NO_EM_RESTART': '1', 11:13:11 INFO - 'PAGER': '/bin/cat', 11:13:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:11 INFO - 'PWD': '/builds/slave/test', 11:13:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:11 INFO - 'SHELL': '/bin/bash', 11:13:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XRmjeW4Wd/Listeners', 11:13:11 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 11:13:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:11 INFO - 'USER': 'cltbld', 11:13:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:11 INFO - 'XPC_FLAGS': '0x0', 11:13:11 INFO - 'XPC_SERVICE_NAME': '0', 11:13:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:11 INFO - Downloading/unpacking psutil>=0.7.1 11:13: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 11:13: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 11:13: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 11:13: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 11:13: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 11:13: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 11:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:13:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:15 INFO - Installing collected packages: psutil 11:13:15 INFO - Running setup.py install for psutil 11:13:15 INFO - building 'psutil._psutil_osx' extension 11:13:15 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 11:13:15 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 11:13:15 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 11:13:15 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 11:13:16 INFO - building 'psutil._psutil_posix' extension 11:13:16 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 11:13:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:13:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:13:16 INFO - ^ 11:13:16 INFO - 1 warning generated. 11:13:16 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 11:13:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:16 INFO - Successfully installed psutil 11:13:16 INFO - Cleaning up... 11:13:16 INFO - Return code: 0 11:13:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:16 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 0x1016dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0d8da1c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101582d30>, '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 0x1013e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101579b20>, '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.sCyLeTvWIy/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.0XRmjeW4Wd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 11:13:16 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 11:13:16 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 11:13:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sCyLeTvWIy/Render', 11:13:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:16 INFO - 'HOME': '/Users/cltbld', 11:13:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:16 INFO - 'LOGNAME': 'cltbld', 11:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:16 INFO - 'MOZ_NO_REMOTE': '1', 11:13:16 INFO - 'NO_EM_RESTART': '1', 11:13:16 INFO - 'PAGER': '/bin/cat', 11:13:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:16 INFO - 'PWD': '/builds/slave/test', 11:13:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:16 INFO - 'SHELL': '/bin/bash', 11:13:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XRmjeW4Wd/Listeners', 11:13:16 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 11:13:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:16 INFO - 'USER': 'cltbld', 11:13:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:16 INFO - 'XPC_FLAGS': '0x0', 11:13:16 INFO - 'XPC_SERVICE_NAME': '0', 11:13:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:13:16 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 11:13:16 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 11:13:16 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 11:13:16 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 11:13:16 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 11:13:16 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 11:13:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:13:19 INFO - Installing collected packages: mozsystemmonitor 11:13:19 INFO - Running setup.py install for mozsystemmonitor 11:13:19 INFO - Successfully installed mozsystemmonitor 11:13:19 INFO - Cleaning up... 11:13:19 INFO - Return code: 0 11:13:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:13:19 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')]} 11:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:19 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')]} 11:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:19 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 0x1016dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0d8da1c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101582d30>, '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 0x1013e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101579b20>, '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.sCyLeTvWIy/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.0XRmjeW4Wd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 11:13:19 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 11:13:19 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 11:13:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sCyLeTvWIy/Render', 11:13:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:19 INFO - 'HOME': '/Users/cltbld', 11:13:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:19 INFO - 'LOGNAME': 'cltbld', 11:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:19 INFO - 'MOZ_NO_REMOTE': '1', 11:13:19 INFO - 'NO_EM_RESTART': '1', 11:13:19 INFO - 'PAGER': '/bin/cat', 11:13:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:19 INFO - 'PWD': '/builds/slave/test', 11:13:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:19 INFO - 'SHELL': '/bin/bash', 11:13:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XRmjeW4Wd/Listeners', 11:13:19 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 11:13:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:19 INFO - 'USER': 'cltbld', 11:13:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:19 INFO - 'XPC_FLAGS': '0x0', 11:13:19 INFO - 'XPC_SERVICE_NAME': '0', 11:13:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:19 INFO - Downloading/unpacking blobuploader==1.2.4 11:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:22 INFO - Downloading blobuploader-1.2.4.tar.gz 11:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:13:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:13:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:23 INFO - Downloading docopt-0.6.1.tar.gz 11:13:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:13:23 INFO - Installing collected packages: blobuploader, requests, docopt 11:13:23 INFO - Running setup.py install for blobuploader 11:13:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:13:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:13:23 INFO - Running setup.py install for requests 11:13:24 INFO - Running setup.py install for docopt 11:13:24 INFO - Successfully installed blobuploader requests docopt 11:13:24 INFO - Cleaning up... 11:13:24 INFO - Return code: 0 11:13:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:24 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 0x1016dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0d8da1c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101582d30>, '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 0x1013e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101579b20>, '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.sCyLeTvWIy/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.0XRmjeW4Wd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 11:13:24 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 11:13:24 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 11:13:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sCyLeTvWIy/Render', 11:13:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:24 INFO - 'HOME': '/Users/cltbld', 11:13:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:24 INFO - 'LOGNAME': 'cltbld', 11:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:24 INFO - 'MOZ_NO_REMOTE': '1', 11:13:24 INFO - 'NO_EM_RESTART': '1', 11:13:24 INFO - 'PAGER': '/bin/cat', 11:13:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:24 INFO - 'PWD': '/builds/slave/test', 11:13:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:24 INFO - 'SHELL': '/bin/bash', 11:13:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XRmjeW4Wd/Listeners', 11:13:24 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 11:13:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:24 INFO - 'USER': 'cltbld', 11:13:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:24 INFO - 'XPC_FLAGS': '0x0', 11:13:24 INFO - 'XPC_SERVICE_NAME': '0', 11:13:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:24 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-aK1DKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:24 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-cwz70o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:24 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-UG31Ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:24 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-SXnWI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:24 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-T8wHG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:25 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-CUpUzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:25 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-jKWana-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:25 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-LeYRlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:25 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-VHu8vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:25 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-j6sqrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:25 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-3gSghc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:25 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-F_dMHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:25 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-qYB7WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:25 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-w3QcW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:25 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-02CX9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:26 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-EHR9MU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:26 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-8KnH0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:13:26 INFO - Running setup.py install for manifestparser 11:13:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:13:26 INFO - Running setup.py install for mozcrash 11:13:26 INFO - Running setup.py install for mozdebug 11:13:26 INFO - Running setup.py install for mozdevice 11:13:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:13:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:13:26 INFO - Running setup.py install for mozfile 11:13:27 INFO - Running setup.py install for mozhttpd 11:13:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:13:27 INFO - Running setup.py install for mozinfo 11:13:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:13:27 INFO - Running setup.py install for mozInstall 11:13:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:13:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:13:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:13:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:13:27 INFO - Running setup.py install for mozleak 11:13:27 INFO - Running setup.py install for mozlog 11:13:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:13:27 INFO - Running setup.py install for moznetwork 11:13:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:13:27 INFO - Running setup.py install for mozprocess 11:13:28 INFO - Running setup.py install for mozprofile 11:13:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:13:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:13:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:13:28 INFO - Running setup.py install for mozrunner 11:13:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:13:28 INFO - Running setup.py install for mozscreenshot 11:13:28 INFO - Running setup.py install for moztest 11:13:28 INFO - Running setup.py install for mozversion 11:13:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:13:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:13:28 INFO - Cleaning up... 11:13:28 INFO - Return code: 0 11:13:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:28 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')]} 11:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:28 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')]} 11:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:28 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 0x1016dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0d8da1c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101582d30>, '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 0x1013e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101579b20>, '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.sCyLeTvWIy/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.0XRmjeW4Wd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 11:13:28 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 11:13:28 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 11:13:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sCyLeTvWIy/Render', 11:13:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:28 INFO - 'HOME': '/Users/cltbld', 11:13:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:28 INFO - 'LOGNAME': 'cltbld', 11:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:28 INFO - 'MOZ_NO_REMOTE': '1', 11:13:28 INFO - 'NO_EM_RESTART': '1', 11:13:28 INFO - 'PAGER': '/bin/cat', 11:13:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:28 INFO - 'PWD': '/builds/slave/test', 11:13:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:28 INFO - 'SHELL': '/bin/bash', 11:13:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XRmjeW4Wd/Listeners', 11:13:28 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 11:13:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:28 INFO - 'USER': 'cltbld', 11:13:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:28 INFO - 'XPC_FLAGS': '0x0', 11:13:28 INFO - 'XPC_SERVICE_NAME': '0', 11:13:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:29 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-nrXFyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:29 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)) 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:29 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-Q_unBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:29 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)) 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:29 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-3HFZEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:29 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)) 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:29 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-rEKSGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:29 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)) 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:29 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-hmpF0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:29 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)) 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:29 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-k7poRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:29 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)) 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:29 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-YmdTgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:29 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)) 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:29 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-RxdKUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:29 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)) 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:29 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-pUPhGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:30 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)) 11:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:30 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-fAAc42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:30 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)) 11:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:30 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-xhPhL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:30 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)) 11:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:30 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-2L_jpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:30 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)) 11:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:30 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-36ggQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:30 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)) 11:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:30 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-AbDTnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:30 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)) 11:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:30 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-8RJ7SU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:30 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)) 11:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:30 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-x6Onil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:30 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)) 11:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:30 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-nxgAR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:30 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)) 11:13:30 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)) 11:13:30 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)) 11:13:30 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)) 11:13:30 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)) 11:13:30 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)) 11:13:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:13:30 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 11:13:30 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 11:13:30 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 11:13:30 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 11:13:30 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 11:13:30 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 11:13:33 INFO - Downloading blessings-1.6.tar.gz 11:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:13:33 INFO - Installing collected packages: blessings 11:13:33 INFO - Running setup.py install for blessings 11:13:33 INFO - Successfully installed blessings 11:13:33 INFO - Cleaning up... 11:13:33 INFO - Return code: 0 11:13:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:13:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:34 INFO - Reading from file tmpfile_stdout 11:13:34 INFO - Current package versions: 11:13:34 INFO - blessings == 1.6 11:13:34 INFO - blobuploader == 1.2.4 11:13:34 INFO - docopt == 0.6.1 11:13:34 INFO - manifestparser == 1.1 11:13:34 INFO - mozInstall == 1.12 11:13:34 INFO - mozcrash == 0.17 11:13:34 INFO - mozdebug == 0.1 11:13:34 INFO - mozdevice == 0.48 11:13:34 INFO - mozfile == 1.2 11:13:34 INFO - mozhttpd == 0.7 11:13:34 INFO - mozinfo == 0.9 11:13:34 INFO - mozleak == 0.1 11:13:34 INFO - mozlog == 3.1 11:13:34 INFO - moznetwork == 0.27 11:13:34 INFO - mozprocess == 0.22 11:13:34 INFO - mozprofile == 0.28 11:13:34 INFO - mozrunner == 6.11 11:13:34 INFO - mozscreenshot == 0.1 11:13:34 INFO - mozsystemmonitor == 0.0 11:13:34 INFO - moztest == 0.7 11:13:34 INFO - mozversion == 1.4 11:13:34 INFO - psutil == 3.1.1 11:13:34 INFO - requests == 1.2.3 11:13:34 INFO - wsgiref == 0.1.2 11:13:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:34 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 0x1016dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0d8da1c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101582d30>, '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 0x1013e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101579b20>, '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.sCyLeTvWIy/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.0XRmjeW4Wd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 11:13:34 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 11:13:34 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 11:13:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sCyLeTvWIy/Render', 11:13:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:34 INFO - 'HOME': '/Users/cltbld', 11:13:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:34 INFO - 'LOGNAME': 'cltbld', 11:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:34 INFO - 'MOZ_NO_REMOTE': '1', 11:13:34 INFO - 'NO_EM_RESTART': '1', 11:13:34 INFO - 'PAGER': '/bin/cat', 11:13:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:34 INFO - 'PWD': '/builds/slave/test', 11:13:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:34 INFO - 'SHELL': '/bin/bash', 11:13:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XRmjeW4Wd/Listeners', 11:13:34 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 11:13:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:34 INFO - 'USER': 'cltbld', 11:13:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:34 INFO - 'XPC_FLAGS': '0x0', 11:13:34 INFO - 'XPC_SERVICE_NAME': '0', 11:13:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:34 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)) 11:13:34 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)) 11:13:34 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)) 11:13:34 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)) 11:13:34 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)) 11:13:34 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)) 11:13:34 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)) 11:13:34 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)) 11:13:34 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)) 11:13:34 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)) 11:13:34 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)) 11:13:34 INFO - Cleaning up... 11:13:34 INFO - Return code: 0 11:13:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:34 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 0x1016dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0d8da1c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101582d30>, '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 0x1013e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101579b20>, '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.sCyLeTvWIy/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.0XRmjeW4Wd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 11:13:34 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 11:13:34 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 11:13:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sCyLeTvWIy/Render', 11:13:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:34 INFO - 'HOME': '/Users/cltbld', 11:13:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:34 INFO - 'LOGNAME': 'cltbld', 11:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:34 INFO - 'MOZ_NO_REMOTE': '1', 11:13:34 INFO - 'NO_EM_RESTART': '1', 11:13:34 INFO - 'PAGER': '/bin/cat', 11:13:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:34 INFO - 'PWD': '/builds/slave/test', 11:13:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:34 INFO - 'SHELL': '/bin/bash', 11:13:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XRmjeW4Wd/Listeners', 11:13:34 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 11:13:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:34 INFO - 'USER': 'cltbld', 11:13:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:34 INFO - 'XPC_FLAGS': '0x0', 11:13:34 INFO - 'XPC_SERVICE_NAME': '0', 11:13:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:34 INFO - Downloading/unpacking jsonschema 11:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:13:36 INFO - Downloading/unpacking functools32 (from jsonschema) 11:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:37 INFO - Downloading functools32-3.2.3-2.tar.gz 11:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:13:37 INFO - warning: no files found matching '*.txt' 11:13:37 INFO - no previously-included directories found matching 'build' 11:13:37 INFO - no previously-included directories found matching 'dist' 11:13:37 INFO - no previously-included directories found matching '.git*' 11:13:37 INFO - Installing collected packages: jsonschema, functools32 11:13:37 INFO - Running setup.py install for functools32 11:13:37 INFO - warning: no files found matching '*.txt' 11:13:37 INFO - no previously-included directories found matching 'build' 11:13:37 INFO - no previously-included directories found matching 'dist' 11:13:37 INFO - no previously-included directories found matching '.git*' 11:13:37 INFO - Successfully installed jsonschema functools32 11:13:37 INFO - Cleaning up... 11:13:37 INFO - Return code: 0 11:13:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:37 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 0x1016dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0d8da1c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101582d30>, '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 0x1013e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101579b20>, '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.sCyLeTvWIy/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.0XRmjeW4Wd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 11:13:37 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 11:13:37 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 11:13:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sCyLeTvWIy/Render', 11:13:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:37 INFO - 'HOME': '/Users/cltbld', 11:13:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:37 INFO - 'LOGNAME': 'cltbld', 11:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:37 INFO - 'MOZ_NO_REMOTE': '1', 11:13:37 INFO - 'NO_EM_RESTART': '1', 11:13:37 INFO - 'PAGER': '/bin/cat', 11:13:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:37 INFO - 'PWD': '/builds/slave/test', 11:13:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:37 INFO - 'SHELL': '/bin/bash', 11:13:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XRmjeW4Wd/Listeners', 11:13:37 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 11:13:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:37 INFO - 'USER': 'cltbld', 11:13:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:37 INFO - 'XPC_FLAGS': '0x0', 11:13:37 INFO - 'XPC_SERVICE_NAME': '0', 11:13:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:37 INFO - Downloading/unpacking flake8 11:13:37 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 11:13:37 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 11:13:37 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 11:13:37 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 11:13:37 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 11:13:37 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 11:13:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:13:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:13:41 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 11:13:41 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 11:13:41 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 11:13:41 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 11:13:41 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 11:13:41 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 11:13:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:13:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:13:41 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 11:13:41 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 11:13:41 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 11:13:41 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 11:13:41 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 11:13:41 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 11:13:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:13:41 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 11:13:41 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 11:13:41 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 11:13:41 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 11:13:41 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 11:13:41 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 11:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:13:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:13:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:13:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:13:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:13:42 INFO - no previously-included directories found matching 'docs/_build' 11:13:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:13:42 INFO - Running setup.py install for pep8 11:13:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:13:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:13:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:13:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:13:42 INFO - no previously-included directories found matching 'docs/_build' 11:13:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:13:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:13:42 INFO - Cleaning up... 11:13:42 INFO - Return code: 0 11:13:42 INFO - Running post-action listener: _resource_record_post_action 11:13:42 INFO - Running post-action listener: _start_resource_monitoring 11:13:42 INFO - Starting resource monitoring. 11:13:42 INFO - ##### 11:13:42 INFO - ##### Running install step. 11:13:42 INFO - ##### 11:13:42 INFO - Running pre-action listener: _resource_record_pre_action 11:13:42 INFO - Running main action method: install 11:13:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:43 INFO - Reading from file tmpfile_stdout 11:13:43 INFO - Detecting whether we're running mozinstall >=1.0... 11:13:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:13:43 INFO - Reading from file tmpfile_stdout 11:13:43 INFO - Output received: 11:13:43 INFO - Usage: mozinstall [options] installer 11:13:43 INFO - Options: 11:13:43 INFO - -h, --help show this help message and exit 11:13:43 INFO - -d DEST, --destination=DEST 11:13:43 INFO - Directory to install application into. [default: 11:13:43 INFO - "/builds/slave/test"] 11:13:43 INFO - --app=APP Application being installed. [default: firefox] 11:13:43 INFO - mkdir: /builds/slave/test/build/application 11:13:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:14:05 INFO - Reading from file tmpfile_stdout 11:14:05 INFO - Output received: 11:14:05 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:14:05 INFO - Running post-action listener: _resource_record_post_action 11:14:05 INFO - ##### 11:14:05 INFO - ##### Running run-tests step. 11:14:05 INFO - ##### 11:14:05 INFO - Running pre-action listener: _resource_record_pre_action 11:14:05 INFO - Running main action method: run_tests 11:14:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:14:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:14:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:14:05 INFO - 2016-05-23 11:14:05.608 screenresolution[1653:9136] starting screenresolution argv=screenresolution get 11:14:05 INFO - 2016-05-23 11:14:05.611 screenresolution[1653:9136] Display 0: 1600x1200x32@60 11:14:05 INFO - 2016-05-23 11:14:05.616 screenresolution[1654:9138] starting screenresolution argv=screenresolution list 11:14:05 INFO - Available Modes on Display 0 11:14:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:14:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:14:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:14:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:14:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:14:05 INFO - Intel Iris: 11:14:05 INFO - Chipset Model: Intel Iris 11:14:05 INFO - Type: GPU 11:14:05 INFO - Bus: Built-In 11:14:05 INFO - VRAM (Dynamic, Max): 1536 MB 11:14:05 INFO - Vendor: Intel (0x8086) 11:14:05 INFO - Device ID: 0x0a2e 11:14:05 INFO - Revision ID: 0x0009 11:14:05 INFO - Displays: 11:14:05 INFO - Display: 11:14:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:14:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:14:05 INFO - Display Serial Number: 1600x1200 60 11:14:05 INFO - Main Display: Yes 11:14:05 INFO - Mirror: Off 11:14:05 INFO - Online: Yes 11:14:05 INFO - Rotation: Supported 11:14:05 INFO - Return code: 0 11:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:14:05 INFO - Python 2.7.3 11:14:05 INFO - Return code: 0 11:14:05 INFO - grabbing minidump binary from tooltool 11:14: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')]} 11:14:05 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 0x101582d30>, '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 0x1013e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101579b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:14:05 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 11:14:05 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 11:14:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:14:05 INFO - Return code: 0 11:14:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:14:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:14:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:14:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:14:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:14:07 INFO - Return code: 0 11:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0299', '--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 11:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0299 --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 11:14:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sCyLeTvWIy/Render', 11:14:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:14:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:14:07 INFO - 'HOME': '/Users/cltbld', 11:14:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:14:07 INFO - 'LOGNAME': 'cltbld', 11:14:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:14:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:07 INFO - 'MOZ_NO_REMOTE': '1', 11:14:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:14:07 INFO - 'NO_EM_RESTART': '1', 11:14:07 INFO - 'PAGER': '/bin/cat', 11:14:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:07 INFO - 'PWD': '/builds/slave/test', 11:14:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:14:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:14:07 INFO - 'SHELL': '/bin/bash', 11:14:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0XRmjeW4Wd/Listeners', 11:14:07 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 11:14:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:14:07 INFO - 'USER': 'cltbld', 11:14:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:14:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:07 INFO - 'XPC_FLAGS': '0x0', 11:14:07 INFO - 'XPC_SERVICE_NAME': '0', 11:14:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:14:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0299', '--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 11:14:07 INFO - mozversion application_buildid: 20160522193137 11:14:07 INFO - mozversion application_changeset: 2e8129bd6590404ff56ea35ac30d719cf7f566ae 11:14:07 INFO - mozversion application_display_name: Firefox 11:14:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:14:07 INFO - mozversion application_name: Firefox 11:14:07 INFO - mozversion application_remotingname: firefox 11:14:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:14:07 INFO - mozversion application_vendor: Mozilla 11:14:07 INFO - mozversion application_version: 47.0 11:14:07 INFO - mozversion platform_buildid: 20160522193137 11:14:07 INFO - mozversion platform_changeset: 2e8129bd6590404ff56ea35ac30d719cf7f566ae 11:14:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:14:07 INFO - mozversion platform_version: 47.0 11:14:07 INFO - using testdate: 1464027247 11:14:07 INFO - actual date: 1464027247 11:14:07 INFO - starting webserver on 'localhost:49279' 11:14:07 INFO - SUITE-START | Running 2 tests 11:14:07 INFO - TEST-START | dromaeo_css 11:14:07 INFO - operating with platform_type : mac_ 11:14:07 INFO - Initialising browser for dromaeo_css test... 11:14:07 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpO5330c/profile http://localhost:49279/getInfo.html) 11:14:10 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 11:14:10 INFO - PROCESS | 1672 | colorDepth:24 11:14:10 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 11:14:10 INFO - PROCESS | 1672 | __metrics 11:14:10 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 11:14:10 INFO - TEST-INFO | 1672: exit 0 11:14:10 INFO - Browser initialized. 11:14:10 INFO - Running cycle 1/1 for dromaeo_css test... 11:14:10 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpO5330c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:22 INFO - PROCESS | 1677 | RSS: Main: 168214528 11:14:22 INFO - PROCESS | 1677 | 11:15:12 INFO - PROCESS | 1677 | 1464027312274 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] 11:17:22 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 11:17:23 INFO - PROCESS | 1677 | RSS: Main: 178716672 11:17:23 INFO - PROCESS | 1677 | 11:20:25 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 11:20:25 INFO - PROCESS | 1677 | RSS: Main: 190500864 11:20:25 INFO - PROCESS | 1677 | 11:23:27 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 11:23:28 INFO - PROCESS | 1677 | RSS: Main: 191963136 11:23:28 INFO - PROCESS | 1677 | 11:26:29 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 11:26:30 INFO - PROCESS | 1677 | RSS: Main: 195321856 11:26:30 INFO - PROCESS | 1677 | 11:29:32 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 11:29:33 INFO - PROCESS | 1677 | RSS: Main: 194396160 11:29:33 INFO - PROCESS | 1677 | 11:32:35 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 11:32:35 INFO - PROCESS | 1677 | RSS: Main: 199790592 11:32:35 INFO - PROCESS | 1677 | 11:32:35 INFO - PROCESS | 1677 | __start_tp_report 11:32:35 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 11:32:35 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 11:32:35 INFO - PROCESS | 1677 | |i|pagename|runs| 11:32:35 INFO - PROCESS | 1677 | |0;dojo.html;2726.7273272672724;3626.4016437287846;3642.289753498067;3680.4847321374996;3684.134228456313;5848.736806843692;5857.853553661155;5862.472377486026;5909.379515150912;5911.674857882815;4795.880102997418;5869.911951320733;5900.43945825147;5905.970470147654;5951.6429014259065;5262.815801446941;5352.143657014878;5394.1908713693065;5396.64921780085;5398.757055932492;4573.49691533931;5293.761780719877;5410.513053825155;5417.052015897202;5432.456754324556;4293.570642935712;5350.438203988583;5390.083685773408;5398.109311963522;5447.291852059227;5393.325834270716;5394.73026348681;5395.244665746799;5411.702356370398;5417.64785288957;5272.789088436496;5333.706646134461;5378.220158077096;5382;5415.891682166374;5563;5755.22304488897;5787.71061446926;5902.97048514759;5905.055191169436;6184.165137706397;6241.095041218998;6241.375862413768;6262.780802671885;6270.247570291549;6270.905936410957;6284.151639528651;6285.214348206474;6286.685665716742;6297.748090076391;5933.406659334032;6042.12389203563;6066.605670631439;6090.573659843769;6092.939070609325;6298.7480500780375;6380.457661098766;6388.584741991755;6394.968025159845;6465.191851018622;6256.874862502725;6263.530235232376;6274.529410294246;6284.497240220771;6295.937040629535;6192.628442293387;6231.470325022424;6257.56197066201;6304.022876454157;6320.683965801692;5283.867903302448;6195.504359651217;6237.407446292595;6238.438540531374;6247.344028876993;6154.446099850946;6208.658523781145;6217.844553886189;6258.405451482102;6281.59169653971;4308.5045219799495;4916.164252077156;5022.045811295842;5027.4469808321055;5046.21783623539;4485.0805584855025;4520.095980803852;4521.208788462071;4522.276435770261;4531.524189960007;6014.458698717136;6130.5402094842175;6145;6185.134081228632;6223.159873417121;6277.340879207709;6346.460550853137;6348.77779277723;6355.332690067568;6364.49084073273;6169.660668663177;6195.938040619536;6202.255729312511;6214.130021796952;6215.689215539295;5475.863103422446;5519.530839878656;5549.417311182348;5562.749676264578;5603.299587551556;6358.268799088164;6469.935300647027;6504.544681872224;6512.869742605027;6513.283538810727;6269.592476489013;6297.685115744286;6298.937010630018;6321.936780632135;6340;6338.049292606146;6471.158749362553;6474.2878283387845;6526.738930442919;6545.0182472629485;5746.7701291949525;5826;6233.625982441068;6249.812505624838;6275.121482992476;6265.467435268053;6279.466245369194;6280.27776805655;6287.811365659038;6296.937030629819;6163.260408750979;6183.165272688129;6223.37766223374;6257.155284036597;6286.559940804283;5280.709560974184;5640.5463623323985;6254.593451425642;6257.843553911189;6275.811725648238;5957.046872500379;6176.69116544162;6233.345498722569;6234.563580549499;6266.091416744455;6045.6070355426755;6181.690915454299;6210.130581718473;6215.844603884939;6272.059191121369;5192.766325515286;6175.413335733098;6230.59501132425;6251.187345645037;6275.717592708431 11:32:35 INFO - PROCESS | 1677 | |1;ext.html;477.3126697555518;575.8243735660623;592.8606777407311;596.5168213746864;640.6956695569605;32941.50587741186;39317.80341098294;39991.600293989715;40110.79944600276;40162.39756403649;37078;39359.21281574367;41681.95795105116;41998.58001419985;42070;7945.5232686038735;8817.603207855662;9547.713568592953;9782.119609235167;9802.166815820628;9617.230621550294;9855.901440985606;9897.90102098977;9908.35595686278;9930.006999300085;9835.95082024589;9929.453880036595;9960.103590676837;9986.40081595103;9999.2000639949;9878.308518403715;9884.90115098847;9960.800783984316;9960.850587241197;10044.497775111215;9840.803183936281;9907.058829411195;9914.355566888202;9917.454540000297;9948.751281218027;34701.826490867636;41270.58729412698;41358.966025849295;41665;41777;3192.425363434581;3409.880654177092;3514.7539672222956;3564.803935783531;3679;28987.275318117005;29143.125706228846;29622;29834.55248171279;29974.400511989857;2836.702146274632;2881.927951801201;2896.5799959006035;2916.9562456563167;2925.312551550384;435379;451994;454943.72528137476;455783.7210813958;456972;71367.2863271371;71548;71732.64133679298;71800.64099679468;71873;82313;82967.17032829716;83527.16472835194;83652.58173709092;83685;18758.1558829853;18820.81179188218;18825.246990120242;18957.62084758297;19058.2376704933;14385;14423.278836058154;14490.058146220463;14503.492377766728;14526.709465810625;23512.177073802333;23820.404489887893;23876.283711488337;23913.880430597736;24382.75617243805;9377.812443751087;9565.378250413702;9614.759631009141;9625.407328423751;9640.228781697448;998.1415982255255;1057.4237040812775;1062.4953147254992;1155.2670993509735;1159.4376727287258;30857.845710771304;30969.535456968162;30983;31338.686613134032;31894.521582176287;1059.5285098131258;1083.2654844410913;1245.769532636465;1251.4368534159664;1252.7494501099634;15159.924200378928;15430.314387671679;15443.382264709511;15505.689886202439;15643.452479163174;527507;528221;529056;533395;537555;63933;65567.34432655612;65753.67123164449;65774.01338979919;65868;1324.9602511924659;1556.1363443289083;1569.7174508588334;1576.6137296362235;1577.6529163583994;29570.704292957656;29684.851575742847;29857.5521367184;30247.69752302537;30453.54319685162;54457.455425446824;54551.18173227325;54756.45243547673;54963.45036549583;55047.72476137754;375946.24053760205;418017;435983;499154;521121;36066;36351.90944271676;36562.817185914966;36775.816120919226;46002;46224.7688761554;46666.300005499266;47121.057578848915;47669.52330476789;48019.27971080367;38032.80983595064;38467.61532384752;40506.59493405146;40733.79633101816;41201.38197926973;39419;40140.1971960565;40189;40536.72877517792;41104;35301.823490883406;39576.80211598924;39625;41157.382639259835;42864.35703464513;32781;34886.82556587201;35084.947451576496;35247.82376088206;35339.646603533634;26540;26706.93172273165;26756.59865101986;26860.328491787863;26860.59709104326 11:32:35 INFO - PROCESS | 1677 | |2;jquery.html;379.3248018527023;382.0677546785842;390.7792097464933;392.92927273090845;397.24126917587415;17093.914530427362;19443.416697499062;21456.678149827745;21540.56918861624;23169.884150579222;21600.027998740054;21654.89172554135;21884.89057554714;22036;22116.778832211672;5613.129964855454;6224.595401298901;6225.221847269091;6227.626342419447;6239.906401403982;6011.57918945674;7161.85676286474;7516.3235308822195;7523.774286771406;7526.698932042712;7198.892016619755;7303.561786292839;7471.476996610239;7474.878768184762;7905.565193914333;7621.971033910407;7656.157822639505;7807.180246074137;7878.290953814156;7887.014123234624;7427.14587822402;7467.9626601867185;7483.6258187090425;7486.812829679247;7501.399888008947;29220;29536.409271814657;29813.40373192524;30102.795888164448;30207.546886796717;2443.8289319747623;2474.2577226831877;2570.5244529762053;2784.874680639356;2913.898013569536;15791;15875.920620396939;16056.839431605767;17091.05999170045;17253.91373043139;1976.9209231630718;1981.73246611707;2000.5198752299343;2003.869748466345;2011.939641810748;118415.4079229607;118442.81557184404;119821.80178198281;120173;121747;17134.571635709206;20625.484362890747;21273.93630318478;21471.355859324245;21549.245776398064;14133.798627116605;14572.63568410777;14602.269886505632;28352.291192720346;30517.7792888282;8857.424267422597;9049.819003620023;9150.816983660423;9192.448453092702;9192.81614367709;9366;9454.669086581936;9466;9484.146426821619;9517.381370210915;4620.907581848412;4631.467381251199;4637.489876113625;4639.164950308909;4674.579287864109;1965.1353404501974;1989.0651393844869;1994.3518356534184;2034.3388398770162;2065.235862730799;904.326276923696;914.593006112287;941.2705153506088;953.8044700836311;1015.6187584884551;17509.474715758548;18497.90751046263;19265.13306901193;20819.687704684442;20873.126873126872;983.6213057972589;1026.2046913641839;1034.9793004140026;1080.9891901081046;1087.2389327470803;8596;9217.861732074025;10818.837717434244;10856.13150947938;11022.228444008842;653140;655973;657018;681495;689707;128308;130713;131558.68441315464;131786.34106829597;133057;964.6575465709712;1078.099786678117;1078.5793540519203;1086.6359769477315;1109.8612673415823;18055.736098472982;18106.275748969892;18208.99850508235;18286.35997740126;18739.812601874353;41154.79422602868;47179.76410117927;52199.95600087901;52948.47051529436;54080.459195409116;54349;75656;75733;76032.61983690046;77662.6116869412;8089;8229.79425514367;8319.209675080858;8406.495610263404;8454.365922555957;11859.762804743685;12218.327991960528;12844.550440734529;13136.60590182296;13572.846308063925;11348.829767553658;11523.769524609294;11552.537898484303;11571.942140289244;11979.700507487383;11148.275362101438;11381.658550243506;11496.712582185177;11647.126465514952;11827.17209795306;11248.381339026431;11692.298462092302;11895.345755983504;11911.285322880309;11974.341411222467;8181.631826567937;8182.713605023796;8195.549244791593;8288.668453261802;8536.487810731376;8672.696455624275;11078.58905327514;11844.111691622991;11859.466324015268;12088.032957363566 11:32:35 INFO - PROCESS | 1677 | |3;mootools.html;1677.2787701288448;1695.0338307164918;2057.845661575382;2090.5400811821396;2136.1028368085404;8323.25090741833;8985.95507022464;9048;9191.678291259806;9259.259259259252;9115.407498512608;9139.634414623424;9197.770055748593;9218.07819218078;9270.212031977273;2531.2785856030987;2562.4106455515243;2566.6278389633494;2567;2575.497777933304;2142.2180903970016;2323.1288266899915;2514.6982362116573;2569.396191894903;2576.2915198320425;2540.0347867810206;2541.263033720219;2555.2972932443636;2569.190704927951;2584.6898372195365;2542.8601426921514;2558.7825034872058;2562.3337932137683;2571.7299683533147;2575.227431770471;2548.6559314492492;2558.06630579837;2561.7950563954837;2561.9367962295623;2600.1679462571983;9265.073492650748;9306.767330816716;9347.532623368872;9379.859302110473;9382;5675.893200825841;5711.400302968212;5812.651240925516;5860.853478663025;5896.292444906639;3631.7276204284785;3693.741438099334;3723.888283351504;3730.7015438764834;3754.8498060077563;1076.9192310576739;1082.0263402371718;1092.546593163836;1097.286763603656;1098.5331234225423;12198.329091899943;12346.938265308705;12413.875861241362;12438.56465023729;12498.75002499963;5000.774965126578;5012.624053196025;5119.180931051014;5142.51146141116;5163.741812909339;10562.155027597773;10607.681769546925;10657.14742820588;10661.200409969284;10668.573257069786;5639.7180140993605;5696.601237913389;5706.315242170883;5745.569082318759;5788.044972579477;3933.4099885017476;4976.726280054631;5079.644424890296;5095.490450954875;5141.871453213699;4076.8177228603968;4139.751614903055;4152.294110001247;4182.393552934868;4191.224623444673;1360.5850215684113;1365.556194236877;1387.278615120132;1388.3266615691382;1388.7847383655549;1417.8723914847712;1432.8352239492383;1453.1208618785695;1468.9559313220407;1489.501017159242;8421.831563368698;8498.192671696179;8548.401611887233;8570.74287771368;8615.870761938577;521.8486638874759;537.2103008577385;538.587980195151;541.5045233611202;541.8103663717667;5649.152627105967;6353.205849268841;6414.518911081687;6418.133551970518;6496.675166241669;10350.896491035144;10892.40091794959;11162.553497860157;11162.720931976766;11257.155713321534;10598.20513461478;10940.945295273472;10961.506732197071;11043.83434248487;11119.332840029463;8628.352873534384;8689.087645797226;8741.737747867573;8773.605187766565;8859.06979767115;7989.121196668478;8190.140035296208;8194.549299788569;8204.302634276153;8260.463069900437;9559.713208603753;9874.358166719141;9951.905290418194;9987.851397089427;10009.399436033862;8353.415260931677;8929.553522323728;10258.487075646337;10400.115990140923;10421.74939007324;7764.029496312961;7793.688252469838;8167.83664326722;8433.156684331763;8439.451435656663;8496.532690701824;8517.48895066298;8538.487690738575;8580.14198580137;8780.956095219739;7464.701411943462;7667.271609197117;7791.415643826849;7800.336971357271;7828.725994590162;7493.250674932681;7495.737649182252;7511.248875112664;7609.086909570887;7677.654505547375;8078.757637270891;8104.311133553714;8105.959470202612;8130.87803682957;8280.130586288595;7175.641217939186;7298.890516642148;7308.634568271459;7345.192028876712;7354.1910389856;7384.261573842573;7386.556806591621;7409.851802964018;7442.888356674763;7450.366718828744 11:32:35 INFO - PROCESS | 1677 | |4;prototype.html;335.6207485541338;354.1500399042298;354.35153668786126;354.95563054618174;365.18745790615884;5612.971935140324;6791.76228831991;6817.761378351753;6867.725290988361;6891.346076941535;5457.908418316333;6795.048693182958;6806;6808.863822723542;6816.488763342744;4773.355596994414;4876.2685597160535;4999.675021123633;5002.0996220680445;5081.415637201713;4281.7002809803325;4808.735519546423;4949.158643030693;5001.874953126165;5027.170516864731;4927.113119638464;4941.802327906879;4946.233333833262;4975.2039673652225;4983.700977941317;4299.527052024275;4761.952380476186;4948.554630083309;4974.7015179089185;4983.277424773406;4304.440422745054;4332.783360831946;4334.393184954109;4335.371371151197;4370.082282720632;6294.685265736741;6507.739690412425;6523.804285871432;6540.509461790385;6564.704588293491;5925.377835327315;5969.970150149265;5972.104184372335;5989.850253743648;6017.608855424383;5295.205719142121;6855.794326170223;7197.344610739559;7222.205557388683;7245;4873.415190177201;4877.6341774367065;4883;4885.902281954376;4889.168841296988;7626.61866906658;7637.847243055107;7647.235276472364;7665.846683066307;7675.232476752336;3850.4801851750217;4321.157374312042;4392.011797345635;4702.36518070063;4747.382840230748;4799.784009719571;4843.515648435128;4849.393825771778;4856.17445034345;4875.390576177978;5737.770489180386;5786.623869448473;5817.069268916953;5817.7963771267805;5833.766649334064;7189.748358807521;7211.89182162268;7230.566166030055;7239.20368759436;7254.637268136677;1657.6187476880384;1683.4360489236244;1688.4596928982853;1688.577855536116;1690.2393922734818;1044.4829809244472;1076.8923107689168;1086.576235268246;1087.8640169978753;1096.1997741648481;6770.627615481196;6810.31896810315;6838.14523184602;6863.245043045261;6885.655717214119;7508.511946723445;7517.586532740752;7531.359834414026;7553.660085296175;7573.507721998052;6625.370589793962;6641.501887358468;6894.13823272091;6911.930880691129;6923.2038315593345;3976.980115099406;3997.520297564253;4018.738781979162;4024.2555127301544;4031.3952907064177;7944.006999125109;7963.800904977306;7976.481528700616;7993.68025278994;8003.959980200062;6263.71813268404;7761.379089672812;7799.883001754978;7826.178251283647;7840.33357164636;7933.880991785243;7978.800529986796;7983.960080199678;8003.959980200062;8021.639026243833;7613.961930190535;7637;7646;7656.3874890007555;7718.652660630173;7410.11078670563;7421.480496365202;7426.108866936002;7446.292602202782;7449.515781474187;7664.770056898302;7914.564698941614;7930.841383172419;7959.442839001214;7967;3915.3343931532277;4753.310769938271;4795.256735206049;4804.95195048059;4813.133635945564;7091.11361079865;7524.435667325082;7536.472446928662;7542.962285188539;7544.811379715551;6335.271443784024;6896.793096207121;7308.159561650478;7325.706971721072;7327.230640782855;5857.912131318119;5987.371326010881;7007.264237255014;7296.19741828409;7348.816279593053;6392.488600911823;7066.787996359912;7092.297848516422;7123.323284287984;7146.571205727673;7280.0535930328715;7288.672009759467;7293.781186564412;7303.233160518069;7309.561426314438;5819.476247137778;7031.05080814104;7094.574325540484;7122.465815063994;7155.284471552803 11:32:35 INFO - PROCESS | 1677 | |5;yui.html;729.2088084428394;788.5190034079214;797.1112209885979;805.1505661527086;812.4556547113433;15322.616934576614;15406.92296538517;15409.46066887659;15575.376984920618;15579.84420155798;13314.733705325887;14624.85375146251;14747.48383806567;14789.92605036976;14824.925875370634;968.6948611187454;970.4759429907876;1001.8797744270679;1018.9708394521513;1024.1499555369026;963.4075043848053;1010.9292349535535;1023.912967397772;1027.409239687179;1027.7995790820794;1032.0866033560278;1083.5449111373202;1084.354808888714;1085.907697845684;1091.045335331585;1035.5857656937285;1048.6749107776614;1070.6145787516489;1076.9084627806646;1080.573173596429;768.7655265144128;805.5891495337362;809.7732634862248;811.3549727966222;815.233680340478;13760.793588096187;13866.93066534671;13891.305434728325;13972.161670299814;14132.364043618061;9691.321607487478;9905.90094099057;11815.172937894351;11828.940855295754;12166.087543434189;9621.615135394646;9645.42127472354;9808.950955245178;9916.454594997273;9938.9503052485;3431.8455669494933;3462.5325581046486;3466.4280393735003;3553.9644603553893;3763.717721170923;71977.28022719758;80599.19400806034;81673.59163204145;83275;83552.58223708904;9082.318826087938;9627.951860240653;9843.704688859345;10292.536835842406;10378;21321.25375611846;22773;23013.53972920532;23180.304590862303;23217.535649287256;6937.791866244021;7856.7250146244605;7965;8025.277725004661;8118.918810811934;4286.228478873771;4292.763897985641;4316.136772645484;4344.218040752695;4347.5652434756275;3646.908827279286;3698.667119959163;3700.3709369407266;3702.72229582777;3726.832292546842;666.0608541955916;673.1484671890063;674.5581644023173;678.7760039187057;686.2759788423261;613.8097189871154;619.1919544993826;622.6668732228236;643.3052303512195;652.4584594786317;7127.92872071283;8489.830203395897;8583.65665373378;8608.69869554575;8745.47527148373;589.8731772668897;609.7103875659116;619.6746707978348;644.4779728419995;647.896336586144;3640.908977275589;3785.9432108518395;3953.110550126256;4014.397840323916;4188.643965262926;92188.53905730562;92313.53843230741;93961;94122;97626.51186744163;77981;78279.825802613;78666;79136.20863791289;79484.80772788412;67321.99017014749;67593;69159.65420172867;72676.63661681763;73545.26454735384;7208.71165153388;8658.567071646266;8783.5169065702;8883.911160888309;9013.63945442175;49608.255876162606;50429.74785126198;50584.494155057975;51963.480365195865;52336.738316308176;67100.66449667915;69583.65208173927;71497.92753108604;71694.77373518099;73879;10497.632582859564;10986.340819550853;11035.724106897393;11185.66443006711;11429.142814288794;11913.940430297793;12025.398730063636;12100.818487722867;12129.608404014785;12449.25304481734;11608.709782255512;11826.349550774446;11863.991560717435;11957.940210298893;11962.58130965412;11706.590269340531;11714.1800073994;11828.82256766132;11888.76222475563;12550.372481375713;11184.105271578092;11276;11544.134189935621;11751.42703713261;11825.763484730429;8246.134155913544;9840.557174927002;9872.210223182272;10028.548715307974;10051.74870628211;9838.852417213891;10023.949880250551;10104.545295461576;10117.190624749855;10143.847842282225 11:32:35 INFO - PROCESS | 1677 | __end_tp_report 11:32:35 INFO - PROCESS | 1677 | __start_cc_report 11:32:35 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,354 11:32:35 INFO - PROCESS | 1677 | __end_cc_report 11:32:35 INFO - PROCESS | 1677 | __startTimestamp1464028355715__endTimestamp 11:32:35 INFO - PROCESS | 1677 | 11:32:35 INFO - PROCESS | 1677 | ------- Summary: start ------- 11:32:35 INFO - PROCESS | 1677 | Number of tests: 6 11:32:35 INFO - PROCESS | 1677 | 11:32:35 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5843.65 Median:6183.17 stddev:667.99 (10.8%) stddev-sans-first:623.68 11:32:35 INFO - PROCESS | 1677 | Values: 2726.7 3626.4 3642.3 3680.5 3684.1 5848.7 5857.9 5862.5 5909.4 5911.7 4795.9 5869.9 5900.4 5906.0 5951.6 5262.8 5352.1 5394.2 5396.6 5398.8 4573.5 5293.8 5410.5 5417.1 5432.5 4293.6 5350.4 5390.1 5398.1 5447.3 5393.3 5394.7 5395.2 5411.7 5417.6 5272.8 5333.7 5378.2 5382.0 5415.9 5563.0 5755.2 5787.7 5903.0 5905.1 6184.2 6241.1 6241.4 6262.8 6270.2 6270.9 6284.2 6285.2 6286.7 6297.7 5933.4 6042.1 6066.6 6090.6 6092.9 6298.7 6380.5 6388.6 6395.0 6465.2 6256.9 6263.5 6274.5 6284.5 6295.9 6192.6 6231.5 6257.6 6304.0 6320.7 5283.9 6195.5 6237.4 6238.4 6247.3 6154.4 6208.7 6217.8 6258.4 6281.6 4308.5 4916.2 5022.0 5027.4 5046.2 4485.1 4520.1 4521.2 4522.3 4531.5 6014.5 6130.5 6145.0 6185.1 6223.2 6277.3 6346.5 6348.8 6355.3 6364.5 6169.7 6195.9 6202.3 6214.1 6215.7 5475.9 5519.5 5549.4 5562.7 5603.3 6358.3 6469.9 6504.5 6512.9 6513.3 6269.6 6297.7 6298.9 6321.9 6340.0 6338.0 6471.2 6474.3 6526.7 6545.0 5746.8 5826.0 6233.6 6249.8 6275.1 6265.5 6279.5 6280.3 6287.8 6296.9 6163.3 6183.2 6223.4 6257.2 6286.6 5280.7 5640.5 6254.6 6257.8 6275.8 5957.0 6176.7 6233.3 6234.6 6266.1 6045.6 6181.7 6210.1 6215.8 6272.1 5192.8 6175.4 6230.6 6251.2 6275.7 11:32:35 INFO - PROCESS | 1677 | 11:32:35 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:64596.76 Median:40347.80 stddev:127281.56 (315.5%) stddev-sans-first:127547.58 11:32:35 INFO - PROCESS | 1677 | Values: 477.3 575.8 592.9 596.5 640.7 32941.5 39317.8 39991.6 40110.8 40162.4 37078.0 39359.2 41682.0 41998.6 42070.0 7945.5 8817.6 9547.7 9782.1 9802.2 9617.2 9855.9 9897.9 9908.4 9930.0 9836.0 9929.5 9960.1 9986.4 9999.2 9878.3 9884.9 9960.8 9960.9 10044.5 9840.8 9907.1 9914.4 9917.5 9948.8 34701.8 41270.6 41359.0 41665.0 41777.0 3192.4 3409.9 3514.8 3564.8 3679.0 28987.3 29143.1 29622.0 29834.6 29974.4 2836.7 2881.9 2896.6 2917.0 2925.3 435379.0 451994.0 454943.7 455783.7 456972.0 71367.3 71548.0 71732.6 71800.6 71873.0 82313.0 82967.2 83527.2 83652.6 83685.0 18758.2 18820.8 18825.2 18957.6 19058.2 14385.0 14423.3 14490.1 14503.5 14526.7 23512.2 23820.4 23876.3 23913.9 24382.8 9377.8 9565.4 9614.8 9625.4 9640.2 998.1 1057.4 1062.5 1155.3 1159.4 30857.8 30969.5 30983.0 31338.7 31894.5 1059.5 1083.3 1245.8 1251.4 1252.7 15159.9 15430.3 15443.4 15505.7 15643.5 527507.0 528221.0 529056.0 533395.0 537555.0 63933.0 65567.3 65753.7 65774.0 65868.0 1325.0 1556.1 1569.7 1576.6 1577.7 29570.7 29684.9 29857.6 30247.7 30453.5 54457.5 54551.2 54756.5 54963.5 55047.7 375946.2 418017.0 435983.0 499154.0 521121.0 36066.0 36351.9 36562.8 36775.8 46002.0 46224.8 46666.3 47121.1 47669.5 48019.3 38032.8 38467.6 40506.6 40733.8 41201.4 39419.0 40140.2 40189.0 40536.7 41104.0 35301.8 39576.8 39625.0 41157.4 42864.4 32781.0 34886.8 35084.9 35247.8 35339.6 26540.0 26706.9 26756.6 26860.3 26860.6 11:32:35 INFO - PROCESS | 1677 | 11:32:35 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:37815.86 Median:2522.39 stddev:110681.88 (4388.0%) stddev-sans-first:110956.68 11:32:35 INFO - PROCESS | 1677 | Values: 379.3 382.1 390.8 392.9 397.2 17093.9 19443.4 21456.7 21540.6 23169.9 21600.0 21654.9 21884.9 22036.0 22116.8 5613.1 6224.6 6225.2 6227.6 6239.9 6011.6 7161.9 7516.3 7523.8 7526.7 7198.9 7303.6 7471.5 7474.9 7905.6 7622.0 7656.2 7807.2 7878.3 7887.0 7427.1 7468.0 7483.6 7486.8 7501.4 29220.0 29536.4 29813.4 30102.8 30207.5 2443.8 2474.3 2570.5 2784.9 2913.9 15791.0 15875.9 16056.8 17091.1 17253.9 1976.9 1981.7 2000.5 2003.9 2011.9 118415.4 118442.8 119821.8 120173.0 121747.0 17134.6 20625.5 21273.9 21471.4 21549.2 14133.8 14572.6 14602.3 28352.3 30517.8 8857.4 9049.8 9150.8 9192.4 9192.8 9366.0 9454.7 9466.0 9484.1 9517.4 4620.9 4631.5 4637.5 4639.2 4674.6 1965.1 1989.1 1994.4 2034.3 2065.2 904.3 914.6 941.3 953.8 1015.6 17509.5 18497.9 19265.1 20819.7 20873.1 983.6 1026.2 1035.0 1081.0 1087.2 8596.0 9217.9 10818.8 10856.1 11022.2 653140.0 655973.0 657018.0 681495.0 689707.0 128308.0 130713.0 131558.7 131786.3 133057.0 964.7 1078.1 1078.6 1086.6 1109.9 18055.7 18106.3 18209.0 18286.4 18739.8 41154.8 47179.8 52200.0 52948.5 54080.5 54349.0 75656.0 75733.0 76032.6 77662.6 8089.0 8229.8 8319.2 8406.5 8454.4 11859.8 12218.3 12844.6 13136.6 13572.8 11348.8 11523.8 11552.5 11571.9 11979.7 11148.3 11381.7 11496.7 11647.1 11827.2 11248.4 11692.3 11895.3 11911.3 11974.3 8181.6 8182.7 8195.5 8288.7 8536.5 8672.7 11078.6 11844.1 11859.5 12088.0 11:32:35 INFO - PROCESS | 1677 | 11:32:35 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:6300.67 Median:537.90 stddev:3322.11 (617.6%) stddev-sans-first:3313.26 11:32:35 INFO - PROCESS | 1677 | Values: 1677.3 1695.0 2057.8 2090.5 2136.1 8323.3 8986.0 9048.0 9191.7 9259.3 9115.4 9139.6 9197.8 9218.1 9270.2 2531.3 2562.4 2566.6 2567.0 2575.5 2142.2 2323.1 2514.7 2569.4 2576.3 2540.0 2541.3 2555.3 2569.2 2584.7 2542.9 2558.8 2562.3 2571.7 2575.2 2548.7 2558.1 2561.8 2561.9 2600.2 9265.1 9306.8 9347.5 9379.9 9382.0 5675.9 5711.4 5812.7 5860.9 5896.3 3631.7 3693.7 3723.9 3730.7 3754.8 1076.9 1082.0 1092.5 1097.3 1098.5 12198.3 12346.9 12413.9 12438.6 12498.8 5000.8 5012.6 5119.2 5142.5 5163.7 10562.2 10607.7 10657.1 10661.2 10668.6 5639.7 5696.6 5706.3 5745.6 5788.0 3933.4 4976.7 5079.6 5095.5 5141.9 4076.8 4139.8 4152.3 4182.4 4191.2 1360.6 1365.6 1387.3 1388.3 1388.8 1417.9 1432.8 1453.1 1469.0 1489.5 8421.8 8498.2 8548.4 8570.7 8615.9 521.8 537.2 538.6 541.5 541.8 5649.2 6353.2 6414.5 6418.1 6496.7 10350.9 10892.4 11162.6 11162.7 11257.2 10598.2 10940.9 10961.5 11043.8 11119.3 8628.4 8689.1 8741.7 8773.6 8859.1 7989.1 8190.1 8194.5 8204.3 8260.5 9559.7 9874.4 9951.9 9987.9 10009.4 8353.4 8929.6 10258.5 10400.1 10421.7 7764.0 7793.7 8167.8 8433.2 8439.5 8496.5 8517.5 8538.5 8580.1 8781.0 7464.7 7667.3 7791.4 7800.3 7828.7 7493.3 7495.7 7511.2 7609.1 7677.7 8078.8 8104.3 8106.0 8130.9 8280.1 7175.6 7298.9 7308.6 7345.2 7354.2 7384.3 7386.6 7409.9 7442.9 7450.4 11:32:35 INFO - PROCESS | 1677 | 11:32:35 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:5906.55 Median:6706.06 stddev:1912.87 (28.5%) stddev-sans-first:1871.97 11:32:35 INFO - PROCESS | 1677 | Values: 335.6 354.2 354.4 355.0 365.2 5613.0 6791.8 6817.8 6867.7 6891.3 5457.9 6795.0 6806.0 6808.9 6816.5 4773.4 4876.3 4999.7 5002.1 5081.4 4281.7 4808.7 4949.2 5001.9 5027.2 4927.1 4941.8 4946.2 4975.2 4983.7 4299.5 4762.0 4948.6 4974.7 4983.3 4304.4 4332.8 4334.4 4335.4 4370.1 6294.7 6507.7 6523.8 6540.5 6564.7 5925.4 5970.0 5972.1 5989.9 6017.6 5295.2 6855.8 7197.3 7222.2 7245.0 4873.4 4877.6 4883.0 4885.9 4889.2 7626.6 7637.8 7647.2 7665.8 7675.2 3850.5 4321.2 4392.0 4702.4 4747.4 4799.8 4843.5 4849.4 4856.2 4875.4 5737.8 5786.6 5817.1 5817.8 5833.8 7189.7 7211.9 7230.6 7239.2 7254.6 1657.6 1683.4 1688.5 1688.6 1690.2 1044.5 1076.9 1086.6 1087.9 1096.2 6770.6 6810.3 6838.1 6863.2 6885.7 7508.5 7517.6 7531.4 7553.7 7573.5 6625.4 6641.5 6894.1 6911.9 6923.2 3977.0 3997.5 4018.7 4024.3 4031.4 7944.0 7963.8 7976.5 7993.7 8004.0 6263.7 7761.4 7799.9 7826.2 7840.3 7933.9 7978.8 7984.0 8004.0 8021.6 7614.0 7637.0 7646.0 7656.4 7718.7 7410.1 7421.5 7426.1 7446.3 7449.5 7664.8 7914.6 7930.8 7959.4 7967.0 3915.3 4753.3 4795.3 4805.0 4813.1 7091.1 7524.4 7536.5 7543.0 7544.8 6335.3 6896.8 7308.2 7325.7 7327.2 5857.9 5987.4 7007.3 7296.2 7348.8 6392.5 7066.8 7092.3 7123.3 7146.6 7280.1 7288.7 7293.8 7303.2 7309.6 5819.5 7031.1 7094.6 7122.5 7155.3 11:32:35 INFO - PROCESS | 1677 | 11:32:35 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:18551.42 Median:4330.18 stddev:26029.51 (601.1%) stddev-sans-first:26068.13 11:32:35 INFO - PROCESS | 1677 | Values: 729.2 788.5 797.1 805.2 812.5 15322.6 15406.9 15409.5 15575.4 15579.8 13314.7 14624.9 14747.5 14789.9 14824.9 968.7 970.5 1001.9 1019.0 1024.1 963.4 1010.9 1023.9 1027.4 1027.8 1032.1 1083.5 1084.4 1085.9 1091.0 1035.6 1048.7 1070.6 1076.9 1080.6 768.8 805.6 809.8 811.4 815.2 13760.8 13866.9 13891.3 13972.2 14132.4 9691.3 9905.9 11815.2 11828.9 12166.1 9621.6 9645.4 9809.0 9916.5 9939.0 3431.8 3462.5 3466.4 3554.0 3763.7 71977.3 80599.2 81673.6 83275.0 83552.6 9082.3 9628.0 9843.7 10292.5 10378.0 21321.3 22773.0 23013.5 23180.3 23217.5 6937.8 7856.7 7965.0 8025.3 8118.9 4286.2 4292.8 4316.1 4344.2 4347.6 3646.9 3698.7 3700.4 3702.7 3726.8 666.1 673.1 674.6 678.8 686.3 613.8 619.2 622.7 643.3 652.5 7127.9 8489.8 8583.7 8608.7 8745.5 589.9 609.7 619.7 644.5 647.9 3640.9 3785.9 3953.1 4014.4 4188.6 92188.5 92313.5 93961.0 94122.0 97626.5 77981.0 78279.8 78666.0 79136.2 79484.8 67322.0 67593.0 69159.7 72676.6 73545.3 7208.7 8658.6 8783.5 8883.9 9013.6 49608.3 50429.7 50584.5 51963.5 52336.7 67100.7 69583.7 71497.9 71694.8 73879.0 10497.6 10986.3 11035.7 11185.7 11429.1 11913.9 12025.4 12100.8 12129.6 12449.3 11608.7 11826.3 11864.0 11957.9 11962.6 11706.6 11714.2 11828.8 11888.8 12550.4 11184.1 11276.0 11544.1 11751.4 11825.8 8246.1 9840.6 9872.2 10028.5 10051.7 9838.9 10023.9 10104.5 10117.2 10143.8 11:32:35 INFO - PROCESS | 1677 | -------- Summary: end -------- 11:32:35 INFO - PROCESS | 1677 | 11:32:36 INFO - TEST-INFO | 1677: exit 0 11:32:36 INFO - TEST-OK | dromaeo_css | took 1108833ms 11:32:36 INFO - TEST-START | kraken 11:32:36 INFO - operating with platform_type : mac_ 11:32:36 INFO - Initialising browser for kraken test... 11:32:36 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpz4fDCn/profile http://localhost:49279/getInfo.html) 11:32:38 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 11:32:38 INFO - PROCESS | 1684 | colorDepth:24 11:32:38 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 11:32:38 INFO - PROCESS | 1684 | __metrics 11:32:38 ERROR - PROCESS | 1684 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 11:32:39 INFO - TEST-INFO | 1684: exit 0 11:32:39 INFO - Browser initialized. 11:32:39 INFO - Running cycle 1/1 for kraken test... 11:32:39 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpz4fDCn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:51 INFO - PROCESS | 1688 | RSS: Main: 168075264 11:32:51 INFO - PROCESS | 1688 | 11:32:53 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 11:32:54 INFO - PROCESS | 1688 | RSS: Main: 179720192 11:32:54 INFO - PROCESS | 1688 | 11:32:57 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 11:32:57 INFO - PROCESS | 1688 | RSS: Main: 189423616 11:32:57 INFO - PROCESS | 1688 | 11:33:00 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 11:33:01 INFO - PROCESS | 1688 | RSS: Main: 192921600 11:33:01 INFO - PROCESS | 1688 | 11:33:03 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 11:33:04 INFO - PROCESS | 1688 | RSS: Main: 193257472 11:33:04 INFO - PROCESS | 1688 | 11:33:06 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:33:06 INFO - PROCESS | 1688 | RSS: Main: 194813952 11:33:06 INFO - PROCESS | 1688 | 11:33:09 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 11:33:10 INFO - PROCESS | 1688 | RSS: Main: 195584000 11:33:10 INFO - PROCESS | 1688 | 11:33:12 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 11:33:13 INFO - PROCESS | 1688 | RSS: Main: 194949120 11:33:13 INFO - PROCESS | 1688 | 11:33:16 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 11:33:17 INFO - PROCESS | 1688 | RSS: Main: 195772416 11:33:17 INFO - PROCESS | 1688 | 11:33:18 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:33:19 INFO - PROCESS | 1688 | RSS: Main: 194936832 11:33:19 INFO - PROCESS | 1688 | 11:33:21 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:33:21 INFO - PROCESS | 1688 | RSS: Main: 195010560 11:33:21 INFO - PROCESS | 1688 | 11:33:23 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:33:24 INFO - PROCESS | 1688 | RSS: Main: 195211264 11:33:24 INFO - PROCESS | 1688 | 11:33:26 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:33:27 INFO - PROCESS | 1688 | RSS: Main: 195297280 11:33:27 INFO - PROCESS | 1688 | 11:33:29 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:33:30 INFO - PROCESS | 1688 | RSS: Main: 195284992 11:33:30 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 11:33:32 INFO - PROCESS | 1688 | RSS: Main: 196247552 11:33:32 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | __start_tp_report 11:33:32 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 11:33:32 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 11:33:32 INFO - PROCESS | 1688 | |i|pagename|runs| 11:33:32 INFO - PROCESS | 1688 | |0;ai-astar;114;111;114;115;116;131;118;116;115;122 11:33:32 INFO - PROCESS | 1688 | |1;audio-beat-detection;184;108;156;174;157;167;169;118;151;118 11:33:32 INFO - PROCESS | 1688 | |2;audio-dft;194;193;201;201;210;193;196;197;194;193 11:33:32 INFO - PROCESS | 1688 | |3;audio-fft;70;78;91;154;70;56;54;59;116;56 11:33:32 INFO - PROCESS | 1688 | |4;audio-oscillator;82;84;116;80;83;84;115;78;79;116 11:33:32 INFO - PROCESS | 1688 | |5;imaging-gaussian-blur;88;85;89;88;87;89;136;129;88;84 11:33:32 INFO - PROCESS | 1688 | |6;imaging-darkroom;94;94;94;94;94;93;94;94;93;128 11:33:32 INFO - PROCESS | 1688 | |7;imaging-desaturate;91;93;124;150;104;149;143;125;92;124 11:33:32 INFO - PROCESS | 1688 | |8;json-parse-financial;55;58;59;59;59;63;81;87;85;45 11:33:32 INFO - PROCESS | 1688 | |9;json-stringify-tinderbox;61;66;71;65;69;69;72;68;65;66 11:33:32 INFO - PROCESS | 1688 | |10;stanford-crypto-aes;83;84;83;80;83;100;76;107;73;86 11:33:32 INFO - PROCESS | 1688 | |11;stanford-crypto-ccm;126;115;126;118;125;116;121;123;130;117 11:33:32 INFO - PROCESS | 1688 | |12;stanford-crypto-pbkdf2;144;172;172;154;132;134;135;138;135;123 11:33:32 INFO - PROCESS | 1688 | |13;stanford-crypto-sha256-iterative;69;66;69;66;67;66;69;66;67;68 11:33:32 INFO - PROCESS | 1688 | __end_tp_report 11:33:32 INFO - PROCESS | 1688 | __start_cc_report 11:33:32 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,898 11:33:32 INFO - PROCESS | 1688 | __end_cc_report 11:33:32 INFO - PROCESS | 1688 | __startTimestamp1464028412492__endTimestamp 11:33:32 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | ------- Summary: start ------- 11:33:32 INFO - PROCESS | 1688 | Number of tests: 14 11:33:32 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | [#0] ai-astar Cycles:10 Average:117.20 Median:116.00 stddev:5.63 (4.9%) stddev-sans-first:5.85 11:33:32 INFO - PROCESS | 1688 | Values: 114.0 111.0 114.0 115.0 116.0 131.0 118.0 116.0 115.0 122.0 11:33:32 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:162.00 stddev:26.41 (16.3%) stddev-sans-first:25.03 11:33:32 INFO - PROCESS | 1688 | Values: 184.0 108.0 156.0 174.0 157.0 167.0 169.0 118.0 151.0 118.0 11:33:32 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | [#2] audio-dft Cycles:10 Average:197.20 Median:196.50 stddev:5.45 (2.8%) stddev-sans-first:5.66 11:33:32 INFO - PROCESS | 1688 | Values: 194.0 193.0 201.0 201.0 210.0 193.0 196.0 197.0 194.0 193.0 11:33:32 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | [#3] audio-fft Cycles:10 Average:80.40 Median:64.50 stddev:32.26 (50.0%) stddev-sans-first:33.99 11:33:32 INFO - PROCESS | 1688 | Values: 70.0 78.0 91.0 154.0 70.0 56.0 54.0 59.0 116.0 56.0 11:33:32 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:81.00 stddev:16.66 (20.6%) stddev-sans-first:17.30 11:33:32 INFO - PROCESS | 1688 | Values: 82.0 84.0 116.0 80.0 83.0 84.0 115.0 78.0 79.0 116.0 11:33:32 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | [#5] imaging-gaussian-blur Cycles:10 Average:96.30 Median:88.00 stddev:19.22 (21.8%) stddev-sans-first:20.15 11:33:32 INFO - PROCESS | 1688 | Values: 88.0 85.0 89.0 88.0 87.0 89.0 136.0 129.0 88.0 84.0 11:33:32 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | [#6] imaging-darkroom Cycles:10 Average:97.20 Median:94.00 stddev:10.83 (11.5%) stddev-sans-first:11.42 11:33:32 INFO - PROCESS | 1688 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 93.0 128.0 11:33:32 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | [#7] imaging-desaturate Cycles:10 Average:119.50 Median:149.50 stddev:23.42 (15.7%) stddev-sans-first:22.45 11:33:32 INFO - PROCESS | 1688 | Values: 91.0 93.0 124.0 150.0 104.0 149.0 143.0 125.0 92.0 124.0 11:33:32 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:61.00 stddev:14.15 (23.2%) stddev-sans-first:14.52 11:33:32 INFO - PROCESS | 1688 | Values: 55.0 58.0 59.0 59.0 59.0 63.0 81.0 87.0 85.0 45.0 11:33:32 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:68.50 stddev:3.26 (4.8%) stddev-sans-first:2.57 11:33:32 INFO - PROCESS | 1688 | Values: 61.0 66.0 71.0 65.0 69.0 69.0 72.0 68.0 65.0 66.0 11:33:32 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:83.00 stddev:10.38 (12.5%) stddev-sans-first:10.97 11:33:32 INFO - PROCESS | 1688 | Values: 83.0 84.0 83.0 80.0 83.0 100.0 76.0 107.0 73.0 86.0 11:33:32 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:124.00 stddev:5.08 (4.1%) stddev-sans-first:5.14 11:33:32 INFO - PROCESS | 1688 | Values: 126.0 115.0 126.0 118.0 125.0 116.0 121.0 123.0 130.0 117.0 11:33:32 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:141.00 stddev:16.84 (11.9%) stddev-sans-first:17.86 11:33:32 INFO - PROCESS | 1688 | Values: 144.0 172.0 172.0 154.0 132.0 134.0 135.0 138.0 135.0 123.0 11:33:32 INFO - PROCESS | 1688 | 11:33:32 INFO - PROCESS | 1688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.34 (2.0%) stddev-sans-first:1.27 11:33:32 INFO - PROCESS | 1688 | Values: 69.0 66.0 69.0 66.0 67.0 66.0 69.0 66.0 67.0 68.0 11:33:32 INFO - PROCESS | 1688 | -------- Summary: end -------- 11:33:32 INFO - PROCESS | 1688 | 11:33:33 INFO - TEST-INFO | 1688: exit 0 11:33:33 INFO - TEST-OK | kraken | took 57114ms 11:33:33 INFO - SUITE-END | took 1165s 11:33:33 INFO - Completed test suite (00:19:26) 11:33:33 INFO - javascript benchmark 11:33:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2726.7273272672724, 3626.4016437287846, 3642.289753498067, 3680.4847321374996, 3684.134228456313, 5848.736806843692, 5857.853553661155, 5862.472377486026, 5909.379515150912, 5911.674857882815, 4795.880102997418, 5869.911951320733, 5900.43945825147, 5905.970470147654, 5951.6429014259065, 5262.815801446941, 5352.143657014878, 5394.1908713693065, 5396.64921780085, 5398.757055932492, 4573.49691533931, 5293.761780719877, 5410.513053825155, 5417.052015897202, 5432.456754324556, 4293.570642935712, 5350.438203988583, 5390.083685773408, 5398.109311963522, 5447.291852059227, 5393.325834270716, 5394.73026348681, 5395.244665746799, 5411.702356370398, 5417.64785288957, 5272.789088436496, 5333.706646134461, 5378.220158077096, 5382.0, 5415.891682166374, 5563.0, 5755.22304488897, 5787.71061446926, 5902.97048514759, 5905.055191169436, 6184.165137706397, 6241.095041218998, 6241.375862413768, 6262.780802671885, 6270.247570291549, 6270.905936410957, 6284.151639528651, 6285.214348206474, 6286.685665716742, 6297.748090076391, 5933.406659334032, 6042.12389203563, 6066.605670631439, 6090.573659843769, 6092.939070609325, 6298.7480500780375, 6380.457661098766, 6388.584741991755, 6394.968025159845, 6465.191851018622, 6256.874862502725, 6263.530235232376, 6274.529410294246, 6284.497240220771, 6295.937040629535, 6192.628442293387, 6231.470325022424, 6257.56197066201, 6304.022876454157, 6320.683965801692, 5283.867903302448, 6195.504359651217, 6237.407446292595, 6238.438540531374, 6247.344028876993, 6154.446099850946, 6208.658523781145, 6217.844553886189, 6258.405451482102, 6281.59169653971, 4308.5045219799495, 4916.164252077156, 5022.045811295842, 5027.4469808321055, 5046.21783623539, 4485.0805584855025, 4520.095980803852, 4521.208788462071, 4522.276435770261, 4531.524189960007, 6014.458698717136, 6130.5402094842175, 6145.0, 6185.134081228632, 6223.159873417121, 6277.340879207709, 6346.460550853137, 6348.77779277723, 6355.332690067568, 6364.49084073273, 6169.660668663177, 6195.938040619536, 6202.255729312511, 6214.130021796952, 6215.689215539295, 5475.863103422446, 5519.530839878656, 5549.417311182348, 5562.749676264578, 5603.299587551556, 6358.268799088164, 6469.935300647027, 6504.544681872224, 6512.869742605027, 6513.283538810727, 6269.592476489013, 6297.685115744286, 6298.937010630018, 6321.936780632135, 6340.0, 6338.049292606146, 6471.158749362553, 6474.2878283387845, 6526.738930442919, 6545.0182472629485, 5746.7701291949525, 5826.0, 6233.625982441068, 6249.812505624838, 6275.121482992476, 6265.467435268053, 6279.466245369194, 6280.27776805655, 6287.811365659038, 6296.937030629819, 6163.260408750979, 6183.165272688129, 6223.37766223374, 6257.155284036597, 6286.559940804283, 5280.709560974184, 5640.5463623323985, 6254.593451425642, 6257.843553911189, 6275.811725648238, 5957.046872500379, 6176.69116544162, 6233.345498722569, 6234.563580549499, 6266.091416744455, 6045.6070355426755, 6181.690915454299, 6210.130581718473, 6215.844603884939, 6272.059191121369, 5192.766325515286, 6175.413335733098, 6230.59501132425, 6251.187345645037, 6275.717592708431], "unit": "score", "name": "dojo.html", "value": 5802.565221031199}, {"lowerIsBetter": false, "replicates": [477.3126697555518, 575.8243735660623, 592.8606777407311, 596.5168213746864, 640.6956695569605, 32941.50587741186, 39317.80341098294, 39991.600293989715, 40110.79944600276, 40162.39756403649, 37078.0, 39359.21281574367, 41681.95795105116, 41998.58001419985, 42070.0, 7945.5232686038735, 8817.603207855662, 9547.713568592953, 9782.119609235167, 9802.166815820628, 9617.230621550294, 9855.901440985606, 9897.90102098977, 9908.35595686278, 9930.006999300085, 9835.95082024589, 9929.453880036595, 9960.103590676837, 9986.40081595103, 9999.2000639949, 9878.308518403715, 9884.90115098847, 9960.800783984316, 9960.850587241197, 10044.497775111215, 9840.803183936281, 9907.058829411195, 9914.355566888202, 9917.454540000297, 9948.751281218027, 34701.826490867636, 41270.58729412698, 41358.966025849295, 41665.0, 41777.0, 3192.425363434581, 3409.880654177092, 3514.7539672222956, 3564.803935783531, 3679.0, 28987.275318117005, 29143.125706228846, 29622.0, 29834.55248171279, 29974.400511989857, 2836.702146274632, 2881.927951801201, 2896.5799959006035, 2916.9562456563167, 2925.312551550384, 435379.0, 451994.0, 454943.72528137476, 455783.7210813958, 456972.0, 71367.2863271371, 71548.0, 71732.64133679298, 71800.64099679468, 71873.0, 82313.0, 82967.17032829716, 83527.16472835194, 83652.58173709092, 83685.0, 18758.1558829853, 18820.81179188218, 18825.246990120242, 18957.62084758297, 19058.2376704933, 14385.0, 14423.278836058154, 14490.058146220463, 14503.492377766728, 14526.709465810625, 23512.177073802333, 23820.404489887893, 23876.283711488337, 23913.880430597736, 24382.75617243805, 9377.812443751087, 9565.378250413702, 9614.759631009141, 9625.407328423751, 9640.228781697448, 998.1415982255255, 1057.4237040812775, 1062.4953147254992, 1155.2670993509735, 1159.4376727287258, 30857.845710771304, 30969.535456968162, 30983.0, 31338.686613134032, 31894.521582176287, 1059.5285098131258, 1083.2654844410913, 1245.769532636465, 1251.4368534159664, 1252.7494501099634, 15159.924200378928, 15430.314387671679, 15443.382264709511, 15505.689886202439, 15643.452479163174, 527507.0, 528221.0, 529056.0, 533395.0, 537555.0, 63933.0, 65567.34432655612, 65753.67123164449, 65774.01338979919, 65868.0, 1324.9602511924659, 1556.1363443289083, 1569.7174508588334, 1576.6137296362235, 1577.6529163583994, 29570.704292957656, 29684.851575742847, 29857.5521367184, 30247.69752302537, 30453.54319685162, 54457.455425446824, 54551.18173227325, 54756.45243547673, 54963.45036549583, 55047.72476137754, 375946.24053760205, 418017.0, 435983.0, 499154.0, 521121.0, 36066.0, 36351.90944271676, 36562.817185914966, 36775.816120919226, 46002.0, 46224.7688761554, 46666.300005499266, 47121.057578848915, 47669.52330476789, 48019.27971080367, 38032.80983595064, 38467.61532384752, 40506.59493405146, 40733.79633101816, 41201.38197926973, 39419.0, 40140.1971960565, 40189.0, 40536.72877517792, 41104.0, 35301.823490883406, 39576.80211598924, 39625.0, 41157.382639259835, 42864.35703464513, 32781.0, 34886.82556587201, 35084.947451576496, 35247.82376088206, 35339.646603533634, 26540.0, 26706.93172273165, 26756.59865101986, 26860.328491787863, 26860.59709104326], "unit": "score", "name": "ext.html", "value": 21016.30585606146}, {"lowerIsBetter": false, "replicates": [379.3248018527023, 382.0677546785842, 390.7792097464933, 392.92927273090845, 397.24126917587415, 17093.914530427362, 19443.416697499062, 21456.678149827745, 21540.56918861624, 23169.884150579222, 21600.027998740054, 21654.89172554135, 21884.89057554714, 22036.0, 22116.778832211672, 5613.129964855454, 6224.595401298901, 6225.221847269091, 6227.626342419447, 6239.906401403982, 6011.57918945674, 7161.85676286474, 7516.3235308822195, 7523.774286771406, 7526.698932042712, 7198.892016619755, 7303.561786292839, 7471.476996610239, 7474.878768184762, 7905.565193914333, 7621.971033910407, 7656.157822639505, 7807.180246074137, 7878.290953814156, 7887.014123234624, 7427.14587822402, 7467.9626601867185, 7483.6258187090425, 7486.812829679247, 7501.399888008947, 29220.0, 29536.409271814657, 29813.40373192524, 30102.795888164448, 30207.546886796717, 2443.8289319747623, 2474.2577226831877, 2570.5244529762053, 2784.874680639356, 2913.898013569536, 15791.0, 15875.920620396939, 16056.839431605767, 17091.05999170045, 17253.91373043139, 1976.9209231630718, 1981.73246611707, 2000.5198752299343, 2003.869748466345, 2011.939641810748, 118415.4079229607, 118442.81557184404, 119821.80178198281, 120173.0, 121747.0, 17134.571635709206, 20625.484362890747, 21273.93630318478, 21471.355859324245, 21549.245776398064, 14133.798627116605, 14572.63568410777, 14602.269886505632, 28352.291192720346, 30517.7792888282, 8857.424267422597, 9049.819003620023, 9150.816983660423, 9192.448453092702, 9192.81614367709, 9366.0, 9454.669086581936, 9466.0, 9484.146426821619, 9517.381370210915, 4620.907581848412, 4631.467381251199, 4637.489876113625, 4639.164950308909, 4674.579287864109, 1965.1353404501974, 1989.0651393844869, 1994.3518356534184, 2034.3388398770162, 2065.235862730799, 904.326276923696, 914.593006112287, 941.2705153506088, 953.8044700836311, 1015.6187584884551, 17509.474715758548, 18497.90751046263, 19265.13306901193, 20819.687704684442, 20873.126873126872, 983.6213057972589, 1026.2046913641839, 1034.9793004140026, 1080.9891901081046, 1087.2389327470803, 8596.0, 9217.861732074025, 10818.837717434244, 10856.13150947938, 11022.228444008842, 653140.0, 655973.0, 657018.0, 681495.0, 689707.0, 128308.0, 130713.0, 131558.68441315464, 131786.34106829597, 133057.0, 964.6575465709712, 1078.099786678117, 1078.5793540519203, 1086.6359769477315, 1109.8612673415823, 18055.736098472982, 18106.275748969892, 18208.99850508235, 18286.35997740126, 18739.812601874353, 41154.79422602868, 47179.76410117927, 52199.95600087901, 52948.47051529436, 54080.459195409116, 54349.0, 75656.0, 75733.0, 76032.61983690046, 77662.6116869412, 8089.0, 8229.79425514367, 8319.209675080858, 8406.495610263404, 8454.365922555957, 11859.762804743685, 12218.327991960528, 12844.550440734529, 13136.60590182296, 13572.846308063925, 11348.829767553658, 11523.769524609294, 11552.537898484303, 11571.942140289244, 11979.700507487383, 11148.275362101438, 11381.658550243506, 11496.712582185177, 11647.126465514952, 11827.17209795306, 11248.381339026431, 11692.298462092302, 11895.345755983504, 11911.285322880309, 11974.341411222467, 8181.631826567937, 8182.713605023796, 8195.549244791593, 8288.668453261802, 8536.487810731376, 8672.696455624275, 11078.58905327514, 11844.111691622991, 11859.466324015268, 12088.032957363566], "unit": "score", "name": "jquery.html", "value": 10514.395960443111}, {"lowerIsBetter": false, "replicates": [1677.2787701288448, 1695.0338307164918, 2057.845661575382, 2090.5400811821396, 2136.1028368085404, 8323.25090741833, 8985.95507022464, 9048.0, 9191.678291259806, 9259.259259259252, 9115.407498512608, 9139.634414623424, 9197.770055748593, 9218.07819218078, 9270.212031977273, 2531.2785856030987, 2562.4106455515243, 2566.6278389633494, 2567.0, 2575.497777933304, 2142.2180903970016, 2323.1288266899915, 2514.6982362116573, 2569.396191894903, 2576.2915198320425, 2540.0347867810206, 2541.263033720219, 2555.2972932443636, 2569.190704927951, 2584.6898372195365, 2542.8601426921514, 2558.7825034872058, 2562.3337932137683, 2571.7299683533147, 2575.227431770471, 2548.6559314492492, 2558.06630579837, 2561.7950563954837, 2561.9367962295623, 2600.1679462571983, 9265.073492650748, 9306.767330816716, 9347.532623368872, 9379.859302110473, 9382.0, 5675.893200825841, 5711.400302968212, 5812.651240925516, 5860.853478663025, 5896.292444906639, 3631.7276204284785, 3693.741438099334, 3723.888283351504, 3730.7015438764834, 3754.8498060077563, 1076.9192310576739, 1082.0263402371718, 1092.546593163836, 1097.286763603656, 1098.5331234225423, 12198.329091899943, 12346.938265308705, 12413.875861241362, 12438.56465023729, 12498.75002499963, 5000.774965126578, 5012.624053196025, 5119.180931051014, 5142.51146141116, 5163.741812909339, 10562.155027597773, 10607.681769546925, 10657.14742820588, 10661.200409969284, 10668.573257069786, 5639.7180140993605, 5696.601237913389, 5706.315242170883, 5745.569082318759, 5788.044972579477, 3933.4099885017476, 4976.726280054631, 5079.644424890296, 5095.490450954875, 5141.871453213699, 4076.8177228603968, 4139.751614903055, 4152.294110001247, 4182.393552934868, 4191.224623444673, 1360.5850215684113, 1365.556194236877, 1387.278615120132, 1388.3266615691382, 1388.7847383655549, 1417.8723914847712, 1432.8352239492383, 1453.1208618785695, 1468.9559313220407, 1489.501017159242, 8421.831563368698, 8498.192671696179, 8548.401611887233, 8570.74287771368, 8615.870761938577, 521.8486638874759, 537.2103008577385, 538.587980195151, 541.5045233611202, 541.8103663717667, 5649.152627105967, 6353.205849268841, 6414.518911081687, 6418.133551970518, 6496.675166241669, 10350.896491035144, 10892.40091794959, 11162.553497860157, 11162.720931976766, 11257.155713321534, 10598.20513461478, 10940.945295273472, 10961.506732197071, 11043.83434248487, 11119.332840029463, 8628.352873534384, 8689.087645797226, 8741.737747867573, 8773.605187766565, 8859.06979767115, 7989.121196668478, 8190.140035296208, 8194.549299788569, 8204.302634276153, 8260.463069900437, 9559.713208603753, 9874.358166719141, 9951.905290418194, 9987.851397089427, 10009.399436033862, 8353.415260931677, 8929.553522323728, 10258.487075646337, 10400.115990140923, 10421.74939007324, 7764.029496312961, 7793.688252469838, 8167.83664326722, 8433.156684331763, 8439.451435656663, 8496.532690701824, 8517.48895066298, 8538.487690738575, 8580.14198580137, 8780.956095219739, 7464.701411943462, 7667.271609197117, 7791.415643826849, 7800.336971357271, 7828.725994590162, 7493.250674932681, 7495.737649182252, 7511.248875112664, 7609.086909570887, 7677.654505547375, 8078.757637270891, 8104.311133553714, 8105.959470202612, 8130.87803682957, 8280.130586288595, 7175.641217939186, 7298.890516642148, 7308.634568271459, 7345.192028876712, 7354.1910389856, 7384.261573842573, 7386.556806591621, 7409.851802964018, 7442.888356674763, 7450.366718828744], "unit": "score", "name": "mootools.html", "value": 5066.856638212682}, {"lowerIsBetter": false, "replicates": [335.6207485541338, 354.1500399042298, 354.35153668786126, 354.95563054618174, 365.18745790615884, 5612.971935140324, 6791.76228831991, 6817.761378351753, 6867.725290988361, 6891.346076941535, 5457.908418316333, 6795.048693182958, 6806.0, 6808.863822723542, 6816.488763342744, 4773.355596994414, 4876.2685597160535, 4999.675021123633, 5002.0996220680445, 5081.415637201713, 4281.7002809803325, 4808.735519546423, 4949.158643030693, 5001.874953126165, 5027.170516864731, 4927.113119638464, 4941.802327906879, 4946.233333833262, 4975.2039673652225, 4983.700977941317, 4299.527052024275, 4761.952380476186, 4948.554630083309, 4974.7015179089185, 4983.277424773406, 4304.440422745054, 4332.783360831946, 4334.393184954109, 4335.371371151197, 4370.082282720632, 6294.685265736741, 6507.739690412425, 6523.804285871432, 6540.509461790385, 6564.704588293491, 5925.377835327315, 5969.970150149265, 5972.104184372335, 5989.850253743648, 6017.608855424383, 5295.205719142121, 6855.794326170223, 7197.344610739559, 7222.205557388683, 7245.0, 4873.415190177201, 4877.6341774367065, 4883.0, 4885.902281954376, 4889.168841296988, 7626.61866906658, 7637.847243055107, 7647.235276472364, 7665.846683066307, 7675.232476752336, 3850.4801851750217, 4321.157374312042, 4392.011797345635, 4702.36518070063, 4747.382840230748, 4799.784009719571, 4843.515648435128, 4849.393825771778, 4856.17445034345, 4875.390576177978, 5737.770489180386, 5786.623869448473, 5817.069268916953, 5817.7963771267805, 5833.766649334064, 7189.748358807521, 7211.89182162268, 7230.566166030055, 7239.20368759436, 7254.637268136677, 1657.6187476880384, 1683.4360489236244, 1688.4596928982853, 1688.577855536116, 1690.2393922734818, 1044.4829809244472, 1076.8923107689168, 1086.576235268246, 1087.8640169978753, 1096.1997741648481, 6770.627615481196, 6810.31896810315, 6838.14523184602, 6863.245043045261, 6885.655717214119, 7508.511946723445, 7517.586532740752, 7531.359834414026, 7553.660085296175, 7573.507721998052, 6625.370589793962, 6641.501887358468, 6894.13823272091, 6911.930880691129, 6923.2038315593345, 3976.980115099406, 3997.520297564253, 4018.738781979162, 4024.2555127301544, 4031.3952907064177, 7944.006999125109, 7963.800904977306, 7976.481528700616, 7993.68025278994, 8003.959980200062, 6263.71813268404, 7761.379089672812, 7799.883001754978, 7826.178251283647, 7840.33357164636, 7933.880991785243, 7978.800529986796, 7983.960080199678, 8003.959980200062, 8021.639026243833, 7613.961930190535, 7637.0, 7646.0, 7656.3874890007555, 7718.652660630173, 7410.11078670563, 7421.480496365202, 7426.108866936002, 7446.292602202782, 7449.515781474187, 7664.770056898302, 7914.564698941614, 7930.841383172419, 7959.442839001214, 7967.0, 3915.3343931532277, 4753.310769938271, 4795.256735206049, 4804.95195048059, 4813.133635945564, 7091.11361079865, 7524.435667325082, 7536.472446928662, 7542.962285188539, 7544.811379715551, 6335.271443784024, 6896.793096207121, 7308.159561650478, 7325.706971721072, 7327.230640782855, 5857.912131318119, 5987.371326010881, 7007.264237255014, 7296.19741828409, 7348.816279593053, 6392.488600911823, 7066.787996359912, 7092.297848516422, 7123.323284287984, 7146.571205727673, 7280.0535930328715, 7288.672009759467, 7293.781186564412, 7303.233160518069, 7309.561426314438, 5819.476247137778, 7031.05080814104, 7094.574325540484, 7122.465815063994, 7155.284471552803], "unit": "score", "name": "prototype.html", "value": 5275.986118628424}, {"lowerIsBetter": false, "replicates": [729.2088084428394, 788.5190034079214, 797.1112209885979, 805.1505661527086, 812.4556547113433, 15322.616934576614, 15406.92296538517, 15409.46066887659, 15575.376984920618, 15579.84420155798, 13314.733705325887, 14624.85375146251, 14747.48383806567, 14789.92605036976, 14824.925875370634, 968.6948611187454, 970.4759429907876, 1001.8797744270679, 1018.9708394521513, 1024.1499555369026, 963.4075043848053, 1010.9292349535535, 1023.912967397772, 1027.409239687179, 1027.7995790820794, 1032.0866033560278, 1083.5449111373202, 1084.354808888714, 1085.907697845684, 1091.045335331585, 1035.5857656937285, 1048.6749107776614, 1070.6145787516489, 1076.9084627806646, 1080.573173596429, 768.7655265144128, 805.5891495337362, 809.7732634862248, 811.3549727966222, 815.233680340478, 13760.793588096187, 13866.93066534671, 13891.305434728325, 13972.161670299814, 14132.364043618061, 9691.321607487478, 9905.90094099057, 11815.172937894351, 11828.940855295754, 12166.087543434189, 9621.615135394646, 9645.42127472354, 9808.950955245178, 9916.454594997273, 9938.9503052485, 3431.8455669494933, 3462.5325581046486, 3466.4280393735003, 3553.9644603553893, 3763.717721170923, 71977.28022719758, 80599.19400806034, 81673.59163204145, 83275.0, 83552.58223708904, 9082.318826087938, 9627.951860240653, 9843.704688859345, 10292.536835842406, 10378.0, 21321.25375611846, 22773.0, 23013.53972920532, 23180.304590862303, 23217.535649287256, 6937.791866244021, 7856.7250146244605, 7965.0, 8025.277725004661, 8118.918810811934, 4286.228478873771, 4292.763897985641, 4316.136772645484, 4344.218040752695, 4347.5652434756275, 3646.908827279286, 3698.667119959163, 3700.3709369407266, 3702.72229582777, 3726.832292546842, 666.0608541955916, 673.1484671890063, 674.5581644023173, 678.7760039187057, 686.2759788423261, 613.8097189871154, 619.1919544993826, 622.6668732228236, 643.3052303512195, 652.4584594786317, 7127.92872071283, 8489.830203395897, 8583.65665373378, 8608.69869554575, 8745.47527148373, 589.8731772668897, 609.7103875659116, 619.6746707978348, 644.4779728419995, 647.896336586144, 3640.908977275589, 3785.9432108518395, 3953.110550126256, 4014.397840323916, 4188.643965262926, 92188.53905730562, 92313.53843230741, 93961.0, 94122.0, 97626.51186744163, 77981.0, 78279.825802613, 78666.0, 79136.20863791289, 79484.80772788412, 67321.99017014749, 67593.0, 69159.65420172867, 72676.63661681763, 73545.26454735384, 7208.71165153388, 8658.567071646266, 8783.5169065702, 8883.911160888309, 9013.63945442175, 49608.255876162606, 50429.74785126198, 50584.494155057975, 51963.480365195865, 52336.738316308176, 67100.66449667915, 69583.65208173927, 71497.92753108604, 71694.77373518099, 73879.0, 10497.632582859564, 10986.340819550853, 11035.724106897393, 11185.66443006711, 11429.142814288794, 11913.940430297793, 12025.398730063636, 12100.818487722867, 12129.608404014785, 12449.25304481734, 11608.709782255512, 11826.349550774446, 11863.991560717435, 11957.940210298893, 11962.58130965412, 11706.590269340531, 11714.1800073994, 11828.82256766132, 11888.76222475563, 12550.372481375713, 11184.105271578092, 11276.0, 11544.134189935621, 11751.42703713261, 11825.763484730429, 8246.134155913544, 9840.557174927002, 9872.210223182272, 10028.548715307974, 10051.74870628211, 9838.852417213891, 10023.949880250551, 10104.545295461576, 10117.190624749855, 10143.847842282225], "unit": "score", "name": "yui.html", "value": 7147.388131736369}], "name": "dromaeo_css", "value": 7910.387504925227}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 111.0, 114.0, 115.0, 116.0, 131.0, 118.0, 116.0, 115.0, 122.0], "unit": "score", "name": "ai-astar", "value": 117.2}, {"lowerIsBetter": true, "replicates": [184.0, 108.0, 156.0, 174.0, 157.0, 167.0, 169.0, 118.0, 151.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 150.2}, {"lowerIsBetter": true, "replicates": [194.0, 193.0, 201.0, 201.0, 210.0, 193.0, 196.0, 197.0, 194.0, 193.0], "unit": "score", "name": "audio-dft", "value": 197.2}, {"lowerIsBetter": true, "replicates": [70.0, 78.0, 91.0, 154.0, 70.0, 56.0, 54.0, 59.0, 116.0, 56.0], "unit": "score", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 116.0, 80.0, 83.0, 84.0, 115.0, 78.0, 79.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 91.7}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 89.0, 88.0, 87.0, 89.0, 136.0, 129.0, 88.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.3}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 93.0, 128.0], "unit": "score", "name": "imaging-darkroom", "value": 97.2}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 124.0, 150.0, 104.0, 149.0, 143.0, 125.0, 92.0, 124.0], "unit": "score", "name": "imaging-desaturate", "value": 119.5}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 59.0, 59.0, 59.0, 63.0, 81.0, 87.0, 85.0, 45.0], "unit": "score", "name": "json-parse-financial", "value": 65.1}, {"lowerIsBetter": true, "replicates": [61.0, 66.0, 71.0, 65.0, 69.0, 69.0, 72.0, 68.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 83.0, 80.0, 83.0, 100.0, 76.0, 107.0, 73.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [126.0, 115.0, 126.0, 118.0, 125.0, 116.0, 121.0, 123.0, 130.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.7}, {"lowerIsBetter": true, "replicates": [144.0, 172.0, 172.0, 154.0, 132.0, 134.0, 135.0, 138.0, 135.0, 123.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 69.0, 66.0, 67.0, 66.0, 69.0, 66.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1500.4}]} 11:33:33 INFO - Return code: 0 11:33:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:33:33 ERROR - # TBPL SUCCESS # 11:33:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:33:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:33:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:33:33 INFO - 2016-05-23 11:33:33.806 screenresolution[1693:11826] starting screenresolution argv=screenresolution get 11:33:33 INFO - 2016-05-23 11:33:33.809 screenresolution[1693:11826] Display 0: 1600x1200x32@60 11:33:33 INFO - 2016-05-23 11:33:33.815 screenresolution[1694:11829] starting screenresolution argv=screenresolution list 11:33:33 INFO - Available Modes on Display 0 11:33:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:33:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:33:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:33:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:33:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:33:34 INFO - Intel Iris: 11:33:34 INFO - Chipset Model: Intel Iris 11:33:34 INFO - Type: GPU 11:33:34 INFO - Bus: Built-In 11:33:34 INFO - VRAM (Dynamic, Max): 1536 MB 11:33:34 INFO - Vendor: Intel (0x8086) 11:33:34 INFO - Device ID: 0x0a2e 11:33:34 INFO - Revision ID: 0x0009 11:33:34 INFO - Displays: 11:33:34 INFO - Display: 11:33:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:33:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:33:34 INFO - Display Serial Number: 1600x1200 60 11:33:34 INFO - Main Display: Yes 11:33:34 INFO - Mirror: Off 11:33:34 INFO - Online: Yes 11:33:34 INFO - Rotation: Supported 11:33:34 INFO - Return code: 0 11:33:34 INFO - Running post-action listener: _resource_record_post_action 11:33:34 INFO - Running post-run listener: _resource_record_post_run 11:33:35 INFO - Total resource usage - Wall time: 1190s; CPU: 53.0%; Read bytes: 30993920; Write bytes: 511670784; Read time: 192; Write time: 1591 11:33:35 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 197575168; Write bytes: 197547520; Read time: 18258; Write time: 439 11:33:35 INFO - run-tests - Wall time: 1168s; CPU: 53.0%; Read bytes: 30072320; Write bytes: 304165888; Read time: 180; Write time: 1118 11:33:35 INFO - Running post-run listener: _upload_blobber_files 11:33:35 INFO - Blob upload gear active. 11:33:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:33:35 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 11:33:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:33:35 INFO - (blobuploader) - INFO - Open directory for files ... 11:33:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:33:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:33:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:37 INFO - (blobuploader) - INFO - Done attempting. 11:33:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:33:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:33:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:38 INFO - (blobuploader) - INFO - Done attempting. 11:33:38 INFO - (blobuploader) - INFO - Iteration through files over. 11:33:38 INFO - Return code: 0 11:33:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:33:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:33:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d04c5676f9fec9d46743a1be67896704a9e4fbff128f1a695a9ad3ece433ae68782a6ef89160968d24046d9cc395e58bcbb308d230092034b148d4b7dcf3482", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/48ac73376037137511580ab351e3f9b184ed97e8c45c0fb27ff53c98a0b5fbdaa5878d318bec688bb74e68cf27e8e8d4ac5fa37213fdcf23c959c8355bb6d4ae"} 11:33:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:33:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:33:38 INFO - Contents: 11:33:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d04c5676f9fec9d46743a1be67896704a9e4fbff128f1a695a9ad3ece433ae68782a6ef89160968d24046d9cc395e58bcbb308d230092034b148d4b7dcf3482", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/48ac73376037137511580ab351e3f9b184ed97e8c45c0fb27ff53c98a0b5fbdaa5878d318bec688bb74e68cf27e8e8d4ac5fa37213fdcf23c959c8355bb6d4ae"} 11:33:38 INFO - Running post-run listener: copy_logs_to_upload_dir 11:33:38 INFO - Copying logs to upload dir... 11:33:38 INFO - mkdir: /builds/slave/test/build/upload/logs 11:33:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.081169 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2016-05-23 11:33:38.239042) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-05-23 11:33:38.242974) ========= 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.sCyLeTvWIy/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.0XRmjeW4Wd/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d04c5676f9fec9d46743a1be67896704a9e4fbff128f1a695a9ad3ece433ae68782a6ef89160968d24046d9cc395e58bcbb308d230092034b148d4b7dcf3482", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/48ac73376037137511580ab351e3f9b184ed97e8c45c0fb27ff53c98a0b5fbdaa5878d318bec688bb74e68cf27e8e8d4ac5fa37213fdcf23c959c8355bb6d4ae"} build_url:https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010684 build_url: 'https://queue.taskcluster.net/v1/task/NchvX2A6SceTu-XKKzWp8w/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d04c5676f9fec9d46743a1be67896704a9e4fbff128f1a695a9ad3ece433ae68782a6ef89160968d24046d9cc395e58bcbb308d230092034b148d4b7dcf3482", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/48ac73376037137511580ab351e3f9b184ed97e8c45c0fb27ff53c98a0b5fbdaa5878d318bec688bb74e68cf27e8e8d4ac5fa37213fdcf23c959c8355bb6d4ae"}' ========= master_lag: 2.35 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-05-23 11:33:40.600136) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:33:40.600498) ========= 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.sCyLeTvWIy/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.0XRmjeW4Wd/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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.005188 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:33:40.626839) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 11:33:40.627145) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 11:33:40.630516) ========= ========= Total master_lag: 2.60 =========