builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0056 starttime: 1461119803.45 results: success (0) buildid: 20160419163752 builduid: 174eada632af4cf794b390a57d2a1342 revision: f60bd9567a058bf0d4d5b35f0d53a46eba0aa500 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 19:36:43.452451) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 19:36:43.452913) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 19:36:43.453204) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 19:36:43.531496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 19:36:43.532001) ========= 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.VcmvkDRReS/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.pIoyruweuw/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-19 19:36:44-- 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% 8.15M=0.001s 2016-04-19 19:36:44 (8.15 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092163 ========= master_lag: 1.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 19:36:44.656837) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 19:36:44.657144) ========= 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.VcmvkDRReS/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.pIoyruweuw/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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.020244 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 19:36:44.708513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 19:36:44.708905) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f60bd9567a058bf0d4d5b35f0d53a46eba0aa500 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f60bd9567a058bf0d4d5b35f0d53a46eba0aa500 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VcmvkDRReS/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.pIoyruweuw/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-19 19:36:44,783 truncating revision to first 12 chars 2016-04-19 19:36:44,784 Setting DEBUG logging. 2016-04-19 19:36:44,784 attempt 1/10 2016-04-19 19:36:44,784 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f60bd9567a05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 19:36:46,137 unpacking tar archive at: fx-team-f60bd9567a05/testing/mozharness/ program finished with exit code 0 elapsedTime=1.592922 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 19:36:46.319173) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 19:36:46.319472) ========= script_repo_revision: f60bd9567a058bf0d4d5b35f0d53a46eba0aa500 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 19:36:46.319872) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 19:36:46.320134) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 19:36:46.332678) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-04-19 19:36:46.333047) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VcmvkDRReS/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.pIoyruweuw/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:36:46 INFO - MultiFileLogger online at 20160419 19:36:46 in /builds/slave/test 19:36:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:36:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:36:46 INFO - {'append_to_log': False, 19:36:46 INFO - 'base_work_dir': '/builds/slave/test', 19:36:46 INFO - 'blob_upload_branch': 'Fx-Team', 19:36:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:36:46 INFO - 'branch': 'Fx-Team', 19:36:46 INFO - 'buildbot_json_path': 'buildprops.json', 19:36:46 INFO - 'config_files': ('talos/mac_config.py',), 19:36:46 INFO - 'default_actions': ('clobber', 19:36:46 INFO - 'read-buildbot-config', 19:36:46 INFO - 'download-and-extract', 19:36:46 INFO - 'populate-webroot', 19:36:46 INFO - 'create-virtualenv', 19:36:46 INFO - 'install', 19:36:46 INFO - 'run-tests'), 19:36:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:36:46 INFO - 'download_minidump_stackwalk': True, 19:36:46 INFO - 'download_symbols': 'ondemand', 19:36:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:36:46 INFO - 'tooltool.py': '/tools/tooltool.py', 19:36:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:36:46 INFO - '/tools/misc-python/virtualenv.py')}, 19:36:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:36:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:36:46 INFO - 'installer_path': 'installer.exe', 19:36:46 INFO - 'log_level': 'info', 19:36:46 INFO - 'log_name': 'talos', 19:36:46 INFO - 'log_to_console': True, 19:36:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:36:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:36:46 INFO - 'opt_config_files': (), 19:36:46 INFO - 'pip_index': False, 19:36:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:36:46 INFO - 'cmd': ('bash', 19:36:46 INFO - '-c', 19:36:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:36:46 INFO - 'enabled': True, 19:36:46 INFO - 'halt_on_failure': False, 19:36:46 INFO - 'name': 'check_screen_resolution'},), 19:36:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:36:46 INFO - 'cmd': ('bash', 19:36:46 INFO - '-c', 19:36:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:36:46 INFO - 'enabled': True, 19:36:46 INFO - 'halt_on_failure': False, 19:36:46 INFO - 'name': 'check_screen_resolution'},), 19:36:46 INFO - 'run_cmd_checks_enabled': True, 19:36:46 INFO - 'sps_profile': False, 19:36:46 INFO - 'sps_profile_interval': 0, 19:36:46 INFO - 'suite': 'dromaeojs-e10s', 19:36:46 INFO - 'system_bits': '32', 19:36:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:36:46 INFO - 'title': 't-yosemite-r7-0056', 19:36:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:36:46 INFO - 'use_talos_json': True, 19:36:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:36:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:36:46 INFO - 'work_dir': 'build'} 19:36:46 INFO - ##### 19:36:46 INFO - ##### Running clobber step. 19:36:46 INFO - ##### 19:36:46 INFO - Running pre-action listener: _resource_record_pre_action 19:36:46 INFO - Running main action method: clobber 19:36:46 INFO - rmtree: /builds/slave/test/build 19:36:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:36:47 INFO - Running post-action listener: _resource_record_post_action 19:36:47 INFO - ##### 19:36:47 INFO - ##### Running read-buildbot-config step. 19:36:47 INFO - ##### 19:36:47 INFO - Running pre-action listener: _resource_record_pre_action 19:36:47 INFO - Running main action method: read_buildbot_config 19:36:47 INFO - Using buildbot properties: 19:36:47 INFO - { 19:36:47 INFO - "project": "", 19:36:47 INFO - "product": "firefox", 19:36:47 INFO - "script_repo_revision": "production", 19:36:47 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 19:36:47 INFO - "repository": "", 19:36:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 19:36:47 INFO - "buildid": "20160419163752", 19:36:47 INFO - "pgo_build": "False", 19:36:47 INFO - "basedir": "/builds/slave/test", 19:36:47 INFO - "buildnumber": 607, 19:36:47 INFO - "slavename": "t-yosemite-r7-0056", 19:36:47 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 19:36:47 INFO - "platform": "yosemite_r7", 19:36:47 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 19:36:47 INFO - "branch": "fx-team", 19:36:47 INFO - "repo_path": "integration/fx-team", 19:36:47 INFO - "revision": "f60bd9567a058bf0d4d5b35f0d53a46eba0aa500", 19:36:47 INFO - "stage_platform": "macosx64", 19:36:47 INFO - "builduid": "174eada632af4cf794b390a57d2a1342", 19:36:47 INFO - "slavebuilddir": "test" 19:36:47 INFO - } 19:36:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 19:36:47 INFO - Running post-action listener: _resource_record_post_action 19:36:47 INFO - ##### 19:36:47 INFO - ##### Running download-and-extract step. 19:36:47 INFO - ##### 19:36:47 INFO - Running pre-action listener: _resource_record_pre_action 19:36:47 INFO - Running main action method: download_and_extract 19:36:47 INFO - mkdir: /builds/slave/test/build/tests 19:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:47 INFO - https://queue.taskcluster.net/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:36:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 19:36:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 19:36:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 19:36:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 19:36:48 INFO - Downloaded 1199 bytes. 19:36:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 19:36:48 INFO - Using the following test package requirements: 19:36:48 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 19:36:48 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:36:48 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 19:36:48 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:36:48 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 19:36:48 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:36:48 INFO - u'jsshell-mac.zip'], 19:36:48 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:36:48 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 19:36:48 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 19:36:48 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:36:48 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 19:36:48 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:36:48 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 19:36:48 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:36:48 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 19:36:48 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:36:48 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 19:36:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:36:48 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')]} 19:36:48 INFO - https://queue.taskcluster.net/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:36:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:36:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:36:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:36:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:36:52 INFO - Downloaded 18095573 bytes. 19:36:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:36:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:36:56 INFO - Return code: 0 19:36:56 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:56 INFO - https://queue.taskcluster.net/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:36:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:36:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:36:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:36:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:37:10 INFO - Downloaded 18095573 bytes. 19:37:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:37:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:37:13 INFO - Return code: 0 19:37:13 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')]} 19:37:13 INFO - https://queue.taskcluster.net/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:37:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:37:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:37:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:37:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:37:16 INFO - Downloaded 10845952 bytes. 19:37:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:37:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:37:16 INFO - Return code: 0 19:37: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')]} 19:37:16 INFO - https://queue.taskcluster.net/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:37:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:37:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:37:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 19:37:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 19:37:19 INFO - Downloaded 109985449 bytes. 19:37:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:37:19 INFO - mkdir: /builds/slave/test/properties 19:37:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:37:19 INFO - Writing to file /builds/slave/test/properties/build_url 19:37:19 INFO - Contents: 19:37:19 INFO - build_url:https://queue.taskcluster.net/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:37:20 INFO - Running post-action listener: _resource_record_post_action 19:37:20 INFO - Running post-action listener: set_extra_try_arguments 19:37:20 INFO - ##### 19:37:20 INFO - ##### Running populate-webroot step. 19:37:20 INFO - ##### 19:37:20 INFO - Running pre-action listener: _resource_record_pre_action 19:37:20 INFO - Running main action method: populate_webroot 19:37:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:37:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:37:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:37:20 INFO - '--tppagecycles', 19:37:20 INFO - '7'], 19:37:20 INFO - 'tests': ['tsvgm']}}, 19:37:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:37:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:37:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:37:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:37:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:37:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:37:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:20 INFO - 'talos_options': ['--disable-e10s'], 19:37:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:37:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:37:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:20 INFO - 'talos_options': ['--disable-e10s'], 19:37:20 INFO - 'tests': ['damp', 'tps']}, 19:37:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:20 INFO - 'tests': ['damp', 'tps']}, 19:37:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:37:20 INFO - 'tests': ['dromaeo_dom']}, 19:37:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:37:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:37:20 INFO - 'tests': ['a11yr', 19:37:20 INFO - 'ts_paint', 19:37:20 INFO - 'tpaint', 19:37:20 INFO - 'sessionrestore', 19:37:20 INFO - 'sessionrestore_no_auto_restore', 19:37:20 INFO - 'tabpaint']}, 19:37:20 INFO - 'other-e10s': {'tests': ['a11yr', 19:37:20 INFO - 'ts_paint', 19:37:20 INFO - 'tpaint', 19:37:20 INFO - 'sessionrestore', 19:37:20 INFO - 'sessionrestore_no_auto_restore', 19:37:20 INFO - 'tabpaint']}, 19:37:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:37:20 INFO - 'ts_paint', 19:37:20 INFO - 'tpaint', 19:37:20 INFO - 'sessionrestore', 19:37:20 INFO - 'sessionrestore_no_auto_restore', 19:37:20 INFO - 'tabpaint']}, 19:37:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:37:20 INFO - 'ts_paint', 19:37:20 INFO - 'tpaint', 19:37:20 INFO - 'sessionrestore', 19:37:20 INFO - 'sessionrestore_no_auto_restore', 19:37:20 INFO - 'tabpaint']}, 19:37:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:37:20 INFO - 'tests': ['a11yr', 19:37:20 INFO - 'ts_paint', 19:37:20 INFO - 'tpaint', 19:37:20 INFO - 'sessionrestore', 19:37:20 INFO - 'sessionrestore_no_auto_restore', 19:37:20 INFO - 'tabpaint']}, 19:37:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:37:20 INFO - 'tests': ['a11yr', 19:37:20 INFO - 'ts_paint', 19:37:20 INFO - 'tpaint', 19:37:20 INFO - 'sessionrestore', 19:37:20 INFO - 'sessionrestore_no_auto_restore', 19:37:20 INFO - 'tabpaint']}, 19:37:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:37:20 INFO - 'tests': ['tsvgx', 19:37:20 INFO - 'tsvgr_opacity', 19:37:20 INFO - 'tart', 19:37:20 INFO - 'tscrollx', 19:37:20 INFO - 'cart']}, 19:37:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:37:20 INFO - 'tsvgr_opacity', 19:37:20 INFO - 'tart', 19:37:20 INFO - 'tscrollx', 19:37:20 INFO - 'cart']}, 19:37:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:20 INFO - 'talos_options': ['--disable-e10s'], 19:37:20 INFO - 'tests': ['tp5o']}, 19:37:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:20 INFO - 'tests': ['tp5o']}, 19:37:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:20 INFO - 'talos_options': ['--disable-e10s', 19:37:20 INFO - '--xperf_path', 19:37:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:37:20 INFO - 'tests': ['tp5n']}, 19:37:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:20 INFO - 'talos_options': ['--xperf_path', 19:37:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:37:20 INFO - 'tests': ['tp5n']}}, 19:37:20 INFO - 'talos.zip': {'path': '', 19:37:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:37:20 INFO - Running post-action listener: _resource_record_post_action 19:37:20 INFO - ##### 19:37:20 INFO - ##### Running create-virtualenv step. 19:37:20 INFO - ##### 19:37:20 INFO - Running pre-action listener: _resource_record_pre_action 19:37:20 INFO - Running main action method: create_virtualenv 19:37:20 INFO - Creating virtualenv /builds/slave/test/build/venv 19:37:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:37:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:37:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:37:20 INFO - Using real prefix '/tools/python27' 19:37:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:37:21 INFO - Installing distribute.............................................................................................................................................................................................done. 19:37:24 INFO - Installing pip.................done. 19:37:24 INFO - Return code: 0 19:37:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:37: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')]} 19:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37: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')]} 19:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105feaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ffa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa3e6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e89e00>, '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 0x105cf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e84b20>, '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.VcmvkDRReS/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.pIoyruweuw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:37:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:37:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:37:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcmvkDRReS/Render', 19:37:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:24 INFO - 'HOME': '/Users/cltbld', 19:37:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:24 INFO - 'LOGNAME': 'cltbld', 19:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:24 INFO - 'MOZ_NO_REMOTE': '1', 19:37:24 INFO - 'NO_EM_RESTART': '1', 19:37:24 INFO - 'PAGER': '/bin/cat', 19:37:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:24 INFO - 'PWD': '/builds/slave/test', 19:37:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:24 INFO - 'SHELL': '/bin/bash', 19:37:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pIoyruweuw/Listeners', 19:37:24 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:37:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:24 INFO - 'USER': 'cltbld', 19:37:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:24 INFO - 'XPC_FLAGS': '0x0', 19:37:24 INFO - 'XPC_SERVICE_NAME': '0', 19:37:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:37:24 INFO - Cleaning up... 19:37:24 INFO - Return code: 0 19:37:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:37: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')]} 19:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37: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')]} 19:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105feaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ffa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa3e6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e89e00>, '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 0x105cf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e84b20>, '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.VcmvkDRReS/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.pIoyruweuw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:37:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:37:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:37:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcmvkDRReS/Render', 19:37:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:24 INFO - 'HOME': '/Users/cltbld', 19:37:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:24 INFO - 'LOGNAME': 'cltbld', 19:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:24 INFO - 'MOZ_NO_REMOTE': '1', 19:37:24 INFO - 'NO_EM_RESTART': '1', 19:37:24 INFO - 'PAGER': '/bin/cat', 19:37:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:24 INFO - 'PWD': '/builds/slave/test', 19:37:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:24 INFO - 'SHELL': '/bin/bash', 19:37:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pIoyruweuw/Listeners', 19:37:24 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:37:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:24 INFO - 'USER': 'cltbld', 19:37:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:24 INFO - 'XPC_FLAGS': '0x0', 19:37:24 INFO - 'XPC_SERVICE_NAME': '0', 19:37:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:24 INFO - Downloading/unpacking psutil>=0.7.1 19:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:37:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:37:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:37:28 INFO - Installing collected packages: psutil 19:37:28 INFO - Running setup.py install for psutil 19:37:28 INFO - building 'psutil._psutil_osx' extension 19:37:28 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 19:37:28 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 19:37:28 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 19:37:28 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 19:37:28 INFO - building 'psutil._psutil_posix' extension 19:37:28 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 19:37:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:37:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:37:28 INFO - ^ 19:37:28 INFO - 1 warning generated. 19:37:28 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 19:37:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:37:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:37:29 INFO - Successfully installed psutil 19:37:29 INFO - Cleaning up... 19:37:29 INFO - Return code: 0 19:37:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:37:29 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')]} 19:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:29 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')]} 19:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:29 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 0x105feaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ffa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa3e6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e89e00>, '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 0x105cf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e84b20>, '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.VcmvkDRReS/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.pIoyruweuw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:37:29 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 19:37:29 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 19:37:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcmvkDRReS/Render', 19:37:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:29 INFO - 'HOME': '/Users/cltbld', 19:37:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:29 INFO - 'LOGNAME': 'cltbld', 19:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:29 INFO - 'MOZ_NO_REMOTE': '1', 19:37:29 INFO - 'NO_EM_RESTART': '1', 19:37:29 INFO - 'PAGER': '/bin/cat', 19:37:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:29 INFO - 'PWD': '/builds/slave/test', 19:37:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:29 INFO - 'SHELL': '/bin/bash', 19:37:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pIoyruweuw/Listeners', 19:37:29 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:37:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:29 INFO - 'USER': 'cltbld', 19:37:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:29 INFO - 'XPC_FLAGS': '0x0', 19:37:29 INFO - 'XPC_SERVICE_NAME': '0', 19:37:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:37:29 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 19:37:29 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 19:37:29 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 19:37:29 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 19:37:29 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 19:37:29 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 19:37:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:37:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:37:31 INFO - Installing collected packages: mozsystemmonitor 19:37:31 INFO - Running setup.py install for mozsystemmonitor 19:37:31 INFO - Successfully installed mozsystemmonitor 19:37:31 INFO - Cleaning up... 19:37:32 INFO - Return code: 0 19:37:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:37:32 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')]} 19:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:32 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')]} 19:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:32 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 0x105feaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ffa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa3e6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e89e00>, '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 0x105cf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e84b20>, '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.VcmvkDRReS/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.pIoyruweuw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:37:32 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 19:37:32 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 19:37:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcmvkDRReS/Render', 19:37:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:32 INFO - 'HOME': '/Users/cltbld', 19:37:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:32 INFO - 'LOGNAME': 'cltbld', 19:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:32 INFO - 'MOZ_NO_REMOTE': '1', 19:37:32 INFO - 'NO_EM_RESTART': '1', 19:37:32 INFO - 'PAGER': '/bin/cat', 19:37:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:32 INFO - 'PWD': '/builds/slave/test', 19:37:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:32 INFO - 'SHELL': '/bin/bash', 19:37:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pIoyruweuw/Listeners', 19:37:32 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:37:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:32 INFO - 'USER': 'cltbld', 19:37:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:32 INFO - 'XPC_FLAGS': '0x0', 19:37:32 INFO - 'XPC_SERVICE_NAME': '0', 19:37:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:32 INFO - Downloading/unpacking blobuploader==1.2.4 19:37:32 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 19:37:32 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 19:37:32 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 19:37:32 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 19:37:32 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 19:37:32 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 19:37:34 INFO - Downloading blobuploader-1.2.4.tar.gz 19:37:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:37:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:37: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 19:37: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 19:37: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 19:37: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 19:37: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 19:37: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 19:37:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:37:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:37:35 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 19:37:35 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 19:37:35 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 19:37:35 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 19:37:35 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 19:37:35 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 19:37:35 INFO - Downloading docopt-0.6.1.tar.gz 19:37:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:37:35 INFO - Installing collected packages: blobuploader, requests, docopt 19:37:35 INFO - Running setup.py install for blobuploader 19:37:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:37:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:37:36 INFO - Running setup.py install for requests 19:37:36 INFO - Running setup.py install for docopt 19:37:36 INFO - Successfully installed blobuploader requests docopt 19:37:36 INFO - Cleaning up... 19:37:36 INFO - Return code: 0 19:37:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:36 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 0x105feaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ffa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa3e6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e89e00>, '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 0x105cf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e84b20>, '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.VcmvkDRReS/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.pIoyruweuw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:37:36 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 19:37:36 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 19:37:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcmvkDRReS/Render', 19:37:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:36 INFO - 'HOME': '/Users/cltbld', 19:37:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:36 INFO - 'LOGNAME': 'cltbld', 19:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:36 INFO - 'MOZ_NO_REMOTE': '1', 19:37:36 INFO - 'NO_EM_RESTART': '1', 19:37:36 INFO - 'PAGER': '/bin/cat', 19:37:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:36 INFO - 'PWD': '/builds/slave/test', 19:37:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:36 INFO - 'SHELL': '/bin/bash', 19:37:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pIoyruweuw/Listeners', 19:37:36 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:37:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:36 INFO - 'USER': 'cltbld', 19:37:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:36 INFO - 'XPC_FLAGS': '0x0', 19:37:36 INFO - 'XPC_SERVICE_NAME': '0', 19:37:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:37:37 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-OIIg8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:37:37 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-T70yMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:37:37 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-II2qmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:37:37 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-hkoGM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:37:37 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-rXI076-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:37:37 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-3Cd_BN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:37:37 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-rIYgjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:37:37 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-ioj8Hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:37:37 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-Tfu_pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:37:38 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-jVKYU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:37:38 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-8xR0IJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:37:38 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-hr18g3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:37:38 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-SgxrvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:37:38 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-TEJ7ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:38 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-p9fuQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:37:38 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-ttM7V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:37:38 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-My24JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:37:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:37:38 INFO - Running setup.py install for manifestparser 19:37:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:37:39 INFO - Running setup.py install for mozcrash 19:37:39 INFO - Running setup.py install for mozdebug 19:37:39 INFO - Running setup.py install for mozdevice 19:37:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:37:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:37:39 INFO - Running setup.py install for mozfile 19:37:39 INFO - Running setup.py install for mozhttpd 19:37:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:37:39 INFO - Running setup.py install for mozinfo 19:37:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:37:39 INFO - Running setup.py install for mozInstall 19:37:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:37:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:37:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:37:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:37:40 INFO - Running setup.py install for mozleak 19:37:40 INFO - Running setup.py install for mozlog 19:37:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:37:40 INFO - Running setup.py install for moznetwork 19:37:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:37:40 INFO - Running setup.py install for mozprocess 19:37:40 INFO - Running setup.py install for mozprofile 19:37:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:37:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:37:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:37:40 INFO - Running setup.py install for mozrunner 19:37:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:37:40 INFO - Running setup.py install for mozscreenshot 19:37:41 INFO - Running setup.py install for moztest 19:37:41 INFO - Running setup.py install for mozversion 19:37:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:37:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:37:41 INFO - Cleaning up... 19:37:41 INFO - Return code: 0 19:37:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:41 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 0x105feaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ffa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa3e6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e89e00>, '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 0x105cf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e84b20>, '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.VcmvkDRReS/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.pIoyruweuw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:37:41 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 19:37:41 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 19:37:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcmvkDRReS/Render', 19:37:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:41 INFO - 'HOME': '/Users/cltbld', 19:37:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:41 INFO - 'LOGNAME': 'cltbld', 19:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:41 INFO - 'MOZ_NO_REMOTE': '1', 19:37:41 INFO - 'NO_EM_RESTART': '1', 19:37:41 INFO - 'PAGER': '/bin/cat', 19:37:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:41 INFO - 'PWD': '/builds/slave/test', 19:37:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:41 INFO - 'SHELL': '/bin/bash', 19:37:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pIoyruweuw/Listeners', 19:37:41 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:37:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:41 INFO - 'USER': 'cltbld', 19:37:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:41 INFO - 'XPC_FLAGS': '0x0', 19:37:41 INFO - 'XPC_SERVICE_NAME': '0', 19:37:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:37:41 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-cHcYJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:37:41 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)) 19:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:37:41 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-2eZSfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:37:41 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)) 19:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:37:41 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-TjRL30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:37:41 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)) 19:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:37:42 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-8BaXph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:37:42 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)) 19:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:37:42 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-ro1D6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:37:42 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)) 19:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:37:42 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-hPsM1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:37:42 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)) 19:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:37:42 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-29zh0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:37:42 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)) 19:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:37:42 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-CPmyyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:37:42 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)) 19:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:37:42 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-vwtvoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:37:42 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)) 19:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:37:42 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-JlVmaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:37:42 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)) 19:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:37:42 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-CwMrfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:37:42 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)) 19:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:37:42 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-8QFMKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:37:42 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)) 19:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:37:42 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-FkMGBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:37:43 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)) 19:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:37:43 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-UdC40j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:37:43 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)) 19:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:43 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-JonV6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:43 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)) 19:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:37:43 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-KXL7BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:37:43 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)) 19:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:37:43 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-KHMOSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:37:43 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)) 19:37:43 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)) 19:37:43 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)) 19:37:43 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)) 19:37:43 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)) 19:37:43 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)) 19:37:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:45 INFO - Downloading blessings-1.6.tar.gz 19:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:37:46 INFO - Installing collected packages: blessings 19:37:46 INFO - Running setup.py install for blessings 19:37:46 INFO - Successfully installed blessings 19:37:46 INFO - Cleaning up... 19:37:46 INFO - Return code: 0 19:37:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:37:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:37:46 INFO - Reading from file tmpfile_stdout 19:37:46 INFO - Current package versions: 19:37:46 INFO - blessings == 1.6 19:37:46 INFO - blobuploader == 1.2.4 19:37:46 INFO - docopt == 0.6.1 19:37:46 INFO - manifestparser == 1.1 19:37:46 INFO - mozInstall == 1.12 19:37:46 INFO - mozcrash == 0.17 19:37:46 INFO - mozdebug == 0.1 19:37:46 INFO - mozdevice == 0.48 19:37:46 INFO - mozfile == 1.2 19:37:46 INFO - mozhttpd == 0.7 19:37:46 INFO - mozinfo == 0.9 19:37:46 INFO - mozleak == 0.1 19:37:46 INFO - mozlog == 3.1 19:37:46 INFO - moznetwork == 0.27 19:37:46 INFO - mozprocess == 0.22 19:37:46 INFO - mozprofile == 0.28 19:37:46 INFO - mozrunner == 6.11 19:37:46 INFO - mozscreenshot == 0.1 19:37:46 INFO - mozsystemmonitor == 0.0 19:37:46 INFO - moztest == 0.7 19:37:46 INFO - mozversion == 1.4 19:37:46 INFO - psutil == 3.1.1 19:37:46 INFO - requests == 1.2.3 19:37:46 INFO - wsgiref == 0.1.2 19:37:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:46 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 0x105feaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ffa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa3e6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e89e00>, '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 0x105cf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e84b20>, '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.VcmvkDRReS/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.pIoyruweuw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:37:46 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 19:37:46 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 19:37:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcmvkDRReS/Render', 19:37:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:46 INFO - 'HOME': '/Users/cltbld', 19:37:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:46 INFO - 'LOGNAME': 'cltbld', 19:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:46 INFO - 'MOZ_NO_REMOTE': '1', 19:37:46 INFO - 'NO_EM_RESTART': '1', 19:37:46 INFO - 'PAGER': '/bin/cat', 19:37:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:46 INFO - 'PWD': '/builds/slave/test', 19:37:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:46 INFO - 'SHELL': '/bin/bash', 19:37:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pIoyruweuw/Listeners', 19:37:46 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:37:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:46 INFO - 'USER': 'cltbld', 19:37:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:46 INFO - 'XPC_FLAGS': '0x0', 19:37:46 INFO - 'XPC_SERVICE_NAME': '0', 19:37:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:46 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)) 19:37:46 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)) 19:37:46 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)) 19:37:46 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)) 19:37:46 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)) 19:37:46 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)) 19:37:46 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)) 19:37:46 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)) 19:37:46 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)) 19:37:46 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)) 19:37:46 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)) 19:37:46 INFO - Cleaning up... 19:37:46 INFO - Return code: 0 19:37:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105feaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ffa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa3e6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e89e00>, '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 0x105cf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e84b20>, '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.VcmvkDRReS/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.pIoyruweuw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:37:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:37:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcmvkDRReS/Render', 19:37:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:46 INFO - 'HOME': '/Users/cltbld', 19:37:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:46 INFO - 'LOGNAME': 'cltbld', 19:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:46 INFO - 'MOZ_NO_REMOTE': '1', 19:37:46 INFO - 'NO_EM_RESTART': '1', 19:37:46 INFO - 'PAGER': '/bin/cat', 19:37:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:46 INFO - 'PWD': '/builds/slave/test', 19:37:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:46 INFO - 'SHELL': '/bin/bash', 19:37:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pIoyruweuw/Listeners', 19:37:46 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:37:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:46 INFO - 'USER': 'cltbld', 19:37:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:46 INFO - 'XPC_FLAGS': '0x0', 19:37:46 INFO - 'XPC_SERVICE_NAME': '0', 19:37:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:47 INFO - Downloading/unpacking jsonschema 19:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:37:49 INFO - Downloading/unpacking functools32 (from jsonschema) 19:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:49 INFO - Downloading functools32-3.2.3-2.tar.gz 19:37:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:37:49 INFO - warning: no files found matching '*.txt' 19:37:49 INFO - no previously-included directories found matching 'build' 19:37:49 INFO - no previously-included directories found matching 'dist' 19:37:49 INFO - no previously-included directories found matching '.git*' 19:37:49 INFO - Installing collected packages: jsonschema, functools32 19:37:50 INFO - Running setup.py install for functools32 19:37:50 INFO - warning: no files found matching '*.txt' 19:37:50 INFO - no previously-included directories found matching 'build' 19:37:50 INFO - no previously-included directories found matching 'dist' 19:37:50 INFO - no previously-included directories found matching '.git*' 19:37:50 INFO - Successfully installed jsonschema functools32 19:37:50 INFO - Cleaning up... 19:37:50 INFO - Return code: 0 19:37:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:37:50 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')]} 19:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:50 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')]} 19:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:50 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 0x105feaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ffa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafa3e6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e89e00>, '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 0x105cf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e84b20>, '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.VcmvkDRReS/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.pIoyruweuw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 19:37:50 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 19:37:50 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 19:37:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcmvkDRReS/Render', 19:37:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:50 INFO - 'HOME': '/Users/cltbld', 19:37:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:50 INFO - 'LOGNAME': 'cltbld', 19:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:50 INFO - 'MOZ_NO_REMOTE': '1', 19:37:50 INFO - 'NO_EM_RESTART': '1', 19:37:50 INFO - 'PAGER': '/bin/cat', 19:37:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:50 INFO - 'PWD': '/builds/slave/test', 19:37:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:50 INFO - 'SHELL': '/bin/bash', 19:37:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pIoyruweuw/Listeners', 19:37:50 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:37:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:50 INFO - 'USER': 'cltbld', 19:37:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:50 INFO - 'XPC_FLAGS': '0x0', 19:37:50 INFO - 'XPC_SERVICE_NAME': '0', 19:37:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:50 INFO - Downloading/unpacking flake8 19:37:50 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 19:37:50 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 19:37:50 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 19:37:50 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 19:37:50 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 19:37:50 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 19:37:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:37:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:37:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:37:53 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 19:37:53 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 19:37:53 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 19:37:53 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 19:37:53 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 19:37:53 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 19:37:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:37:53 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 19:37:53 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 19:37:53 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 19:37:53 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 19:37:53 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 19:37:53 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 19:37:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:37:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:37:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:37:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:37:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:37:54 INFO - no previously-included directories found matching 'docs/_build' 19:37:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:37:54 INFO - Running setup.py install for pep8 19:37:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:37:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:37:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:37:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:37:54 INFO - no previously-included directories found matching 'docs/_build' 19:37:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:37:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:37:54 INFO - Cleaning up... 19:37:54 INFO - Return code: 0 19:37:54 INFO - Running post-action listener: _resource_record_post_action 19:37:54 INFO - Running post-action listener: _start_resource_monitoring 19:37:54 INFO - Starting resource monitoring. 19:37:54 INFO - ##### 19:37:54 INFO - ##### Running install step. 19:37:54 INFO - ##### 19:37:54 INFO - Running pre-action listener: _resource_record_pre_action 19:37:54 INFO - Running main action method: install 19:37:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:37:54 INFO - Reading from file tmpfile_stdout 19:37:54 INFO - Detecting whether we're running mozinstall >=1.0... 19:37:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:37:54 INFO - Reading from file tmpfile_stdout 19:37:54 INFO - Output received: 19:37:54 INFO - Usage: mozinstall [options] installer 19:37:54 INFO - Options: 19:37:54 INFO - -h, --help show this help message and exit 19:37:54 INFO - -d DEST, --destination=DEST 19:37:54 INFO - Directory to install application into. [default: 19:37:54 INFO - "/builds/slave/test"] 19:37:54 INFO - --app=APP Application being installed. [default: firefox] 19:37:54 INFO - mkdir: /builds/slave/test/build/application 19:37:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:38:28 INFO - Reading from file tmpfile_stdout 19:38:28 INFO - Output received: 19:38:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:38:28 INFO - Running post-action listener: _resource_record_post_action 19:38:28 INFO - ##### 19:38:28 INFO - ##### Running run-tests step. 19:38:28 INFO - ##### 19:38:28 INFO - Running pre-action listener: _resource_record_pre_action 19:38:28 INFO - Running main action method: run_tests 19:38:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:38:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:38:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:38:28 INFO - 2016-04-19 19:38:28.415 screenresolution[1946:11998] starting screenresolution argv=screenresolution get 19:38:28 INFO - 2016-04-19 19:38:28.417 screenresolution[1946:11998] Display 0: 1600x1200x32@60 19:38:28 INFO - 2016-04-19 19:38:28.423 screenresolution[1947:12001] starting screenresolution argv=screenresolution list 19:38:28 INFO - Available Modes on Display 0 19:38:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:38:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:38:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:38:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:38:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:38:28 INFO - Intel Iris: 19:38:28 INFO - Chipset Model: Intel Iris 19:38:28 INFO - Type: GPU 19:38:28 INFO - Bus: Built-In 19:38:28 INFO - VRAM (Dynamic, Max): 1536 MB 19:38:28 INFO - Vendor: Intel (0x8086) 19:38:28 INFO - Device ID: 0x0a2e 19:38:28 INFO - Revision ID: 0x0009 19:38:28 INFO - Displays: 19:38:28 INFO - Display: 19:38:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:38:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:38:28 INFO - Display Serial Number: 1600x1200 60 19:38:28 INFO - Main Display: Yes 19:38:28 INFO - Mirror: Off 19:38:28 INFO - Online: Yes 19:38:28 INFO - Rotation: Supported 19:38:28 INFO - Return code: 0 19:38:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:38:28 INFO - Python 2.7.3 19:38:28 INFO - Return code: 0 19:38:28 INFO - grabbing minidump binary from tooltool 19:38: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')]} 19:38:28 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 0x105e89e00>, '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 0x105cf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e84b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:38:28 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 19:38:28 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 19:38:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:38:28 INFO - Return code: 0 19:38:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:38:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:38:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:38:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:38:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:38:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:38:29 INFO - Return code: 0 19:38:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0056', '--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 19:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0056 --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 19:38:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VcmvkDRReS/Render', 19:38:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:38:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:38:29 INFO - 'HOME': '/Users/cltbld', 19:38:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:38:29 INFO - 'LOGNAME': 'cltbld', 19:38:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:38:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:29 INFO - 'MOZ_NO_REMOTE': '1', 19:38:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:38:29 INFO - 'NO_EM_RESTART': '1', 19:38:29 INFO - 'PAGER': '/bin/cat', 19:38:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:29 INFO - 'PWD': '/builds/slave/test', 19:38:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:38:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:38:29 INFO - 'SHELL': '/bin/bash', 19:38:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pIoyruweuw/Listeners', 19:38:29 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 19:38:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:38:29 INFO - 'USER': 'cltbld', 19:38:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:38:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:29 INFO - 'XPC_FLAGS': '0x0', 19:38:29 INFO - 'XPC_SERVICE_NAME': '0', 19:38:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:38:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0056', '--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 19:38:30 INFO - mozversion application_buildid: 20160419163752 19:38:30 INFO - mozversion application_changeset: f60bd9567a058bf0d4d5b35f0d53a46eba0aa500 19:38:30 INFO - mozversion application_display_name: Nightly 19:38:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:38:30 INFO - mozversion application_name: Firefox 19:38:30 INFO - mozversion application_remotingname: firefox 19:38:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:38:30 INFO - mozversion application_vendor: Mozilla 19:38:30 INFO - mozversion application_version: 48.0a1 19:38:30 INFO - mozversion platform_buildid: 20160419163752 19:38:30 INFO - mozversion platform_changeset: f60bd9567a058bf0d4d5b35f0d53a46eba0aa500 19:38:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:38:30 INFO - mozversion platform_version: 48.0a1 19:38:30 INFO - using testdate: 1461119910 19:38:30 INFO - actual date: 1461119910 19:38:30 INFO - starting webserver on 'localhost:49748' 19:38:30 INFO - SUITE-START | Running 2 tests 19:38:30 INFO - TEST-START | dromaeo_css 19:38:30 INFO - operating with platform_type : mac_ 19:38:30 INFO - Initialising browser for dromaeo_css test... 19:38:30 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmpj87Ev_/profile http://localhost:49748/getInfo.html) 19:38:33 INFO - PROCESS | 1965 | __metrics Screen width/height:1600/1200 19:38:33 INFO - PROCESS | 1965 | colorDepth:24 19:38:33 INFO - PROCESS | 1965 | Browser inner width/height: 1024/689 19:38:33 INFO - PROCESS | 1965 | __metrics 19:38:33 ERROR - PROCESS | 1965 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:38:33 INFO - TEST-INFO | 1965: exit 0 19:38:33 INFO - Browser initialized. 19:38:33 INFO - Running cycle 1/1 for dromaeo_css test... 19:38:33 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmpj87Ev_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:38:45 INFO - PROCESS | 1968 | RSS: Main: 247562240 19:38:45 INFO - PROCESS | 1968 | 19:39:35 INFO - PROCESS | 1968 | 1461119975656 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] 19:41:46 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49748/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49748/tests/dromaeo/cssquery-ext.html) 19:41:48 INFO - PROCESS | 1968 | RSS: Main: 260030464 19:41:48 INFO - PROCESS | 1968 | 19:44:50 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49748/tests/dromaeo/cssquery-ext.html (next: http://localhost:49748/tests/dromaeo/cssquery-jquery.html) 19:44:51 INFO - PROCESS | 1968 | RSS: Main: 271847424 19:44:51 INFO - PROCESS | 1968 | 19:47:52 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49748/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49748/tests/dromaeo/cssquery-mootools.html) 19:47:53 INFO - PROCESS | 1968 | RSS: Main: 273698816 19:47:53 INFO - PROCESS | 1968 | 19:50:55 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49748/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49748/tests/dromaeo/cssquery-prototype.html) 19:50:55 INFO - PROCESS | 1968 | RSS: Main: 275443712 19:50:55 INFO - PROCESS | 1968 | 19:53:58 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49748/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49748/tests/dromaeo/cssquery-yui.html) 19:53:59 INFO - PROCESS | 1968 | RSS: Main: 278290432 19:53:59 INFO - PROCESS | 1968 | 19:57:01 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49748/tests/dromaeo/cssquery-yui.html (next: http://localhost:49748/tests/dromaeo/cssquery-dojo.html) 19:57:02 INFO - PROCESS | 1968 | RSS: Main: 279244800 19:57:02 INFO - PROCESS | 1968 | 19:57:02 INFO - PROCESS | 1968 | __start_tp_report 19:57:02 INFO - PROCESS | 1968 | _x_x_mozilla_page_load 19:57:02 INFO - PROCESS | 1968 | _x_x_mozilla_page_load_details 19:57:02 INFO - PROCESS | 1968 | |i|pagename|runs| 19:57:02 INFO - PROCESS | 1968 | |0;dojo.html;2945.9999999999995;3495.0388643123138;3556.0398692353065;3557.7509574329806;3586.874459393922;5840.941590584098;5901.527877769779;5910.615809972349;5939.168516407701;5947.732352044158;5795.072788353864;5893.528517718583;5898;5975.073863551145;6072.848178795522;5266.683998960056;5291.523762861341;5333.306670132897;5333.919991200135;5365.892682146355;104.30934919603179;5206.271122042917;5289.920651190235;5324.068288049576;5327.893442131155;5233.58131349493;5262.131748261532;5267.736613169345;5286.788528458857;5321.946780532203;5258.8159414420315;5301.920471192935;5304.443033481468;5319.414864364917;5321.095413779667;5236.083685355047;5238.899831035487;5335.573154147659;5336.706481143536;5353.384360798519;5643.830685079454;5763.279590051244;5803.361630220672;5820.3888591698105;5838.182654428383;6164;6198.132261483351;6281.560290779647;6286.119943207955;6299.559030867841;6291.968540157316;6343.207099112611;6364.2681091674585;6376;6389.393007664311;6021.337652858182;6027.065804800263;6039.245094363205;6056.21269235001;6087.786927457518;6316.463100636497;6381.138546296191;6445.45213656835;6458.806235812933;6470.708818103197;6101.217066730222;6198.783042593487;6252.155958945484;6277.780277690259;6280.811575652738;6312.968435157886;6342.936570634327;6355.523335749837;6369.363063693593;6369.394907483782;6192.690365481708;6200.3179650238435;6227.564070515021;6257;6286.968565157145;6240.968795155995;6248.218972628421;6265.561410701207;6268.435840774352;6294.590851594632;4997.275395067695;4998.05037042968;5037.596992240612;5040.1179793535985;5047.470015648378;4376.081022985209;4458.687891847604;4491.438570178728;4572.451305843254;4619.745913974696;6005.129256257818;6079.574429789961;6090.786822461193;6093.725782339717;6107.340534417129;5866.266716660418;6225.972714502147;6230.43926046658;6272.717727702265;6284.214473190851;5138.434772175057;5784.652920824764;6066.726997285133;6076.969615151985;6121.234845644294;4610.9164346378575;5487.368952570426;5536.972315138479;5547.694876781816;5550.222968784374;6387.041943708481;6553.377429144223;6559.147310849559;6563.343665633494;6567.080608714784;6261.874762504815;6330.871993685129;6396.264429590657;6399.776007839703;6404.679766011774;6522.902156467562;6537.8692426152165;6563.803085907431;6590.275069742229;6594.076829244005;6137.9286238596105;6189.96905015472;6242.937570624417;6269.435750782452;6278.15244941927;6226.3151053385;6240.625562466266;6279.843003924756;6283.842903927439;6284.277308109443;6054.939450605438;6157.230346206724;6175.289841668086;6182.412670796267;6257.623322868962;5084.720340381166;6190.628562286277;6242.719077641426;6265.404786545271;6267.874642507033;5766.308043034863;6111.40942266768;6118.265808103056;6132.758293649526;6230.719617617308;6249.656268905072;6263.718132683949;6281.12064311006;6282.403171698681;6300.21247344082;6023.969880150571;6108.463491842691;6111.816645500642;6138.263408391022;6215.316315205233 19:57:02 INFO - PROCESS | 1968 | |1;ext.html;492.15595254139123;519.2289450166503;524.177042043991;541.3314556522694;613.1416017575395;36761.81619091904;37557;37603.43594846079;37633.68282110127;37649.81175094124;38082;38604.613953860455;38630.227395452144;38645.42031869517;38792;9280.860787088182;9380.718578442658;9385.812283754354;9500.762480937963;9527.571259293314;9420.152186303232;9645.228381729445;9658.420494770302;9660.372075815085;9678.806423871518;9554;9606.895207051173;9641.807163856718;9644.61421543141;9666.661666841626;9560.713178604654;9610.807783844353;9654.469004204766;9664.275179361506;9669.468179250138;9466.337356385056;9519.190868776162;9577.23382129428;9586.76033099171;9589.136977672042;37173.07067323312;37415.812920935496;37776.43335349972;37814.432783508266;37932.43101353482;2692.7980401469968;2805.789565782554;2979.644261860848;3421.8802341917913;3573.356795776759;26980.59529107065;27250.31874203141;27803.887844486195;28658.856705716546;30075;2744.341358074068;2746.5193591121674;2797.622320986661;2808.817426867247;2876.050903201938;338525.30737346155;402271;403122;408823.9558802217;409011;56844.14733778997;57678.711606442535;57684.846303073704;57795.42204577901;57884.71057644685;61241.38758612446;61885.69057154685;62386.376136238054;64732.352676472634;67003.65992680119;14053.17308749856;16180.919095404683;16543.338266469207;16744.497665070066;16755.83244167567;12798;13009.934950325187;13137.474501019853;13144.751248631364;13175.868241317465;18775.34286299973;18832.623347532972;18860.905695471436;18915.24339026451;18921.621567568847;7728.917951486684;8190.099089100194;8329.916700832913;8345.749627511184;8404.697271922862;902.41794042842;915.208344781759;1052.910502607287;1093.4642025407493;1153.140910022039;29052;29215.269618259714;29559;29715;29760.851195743882;1070.1652710885521;1096.2600244834864;1108.1965574958251;1137.971550711239;1208.4139192491634;13914.443422262995;14225.644358890904;14640.780388294184;14737.410503579737;15099.54701358961;601686.9409570731;605263;611412;611458;614889.5533134013;55988.72005640027;57921;58389.41610583925;58754.41245587575;58799.70600146972;1473.4842805018159;1480.222882986419;1484.9034812737139;1491.1873029199112;1493.492212647705;28971.13086607405;29019.274518137216;29455.26361840971;29569.85215073997;29718;47509;47696.7615161922;48005.27992080191;48031.75984120057;48099.35453550088;513292;535392;539939;541160.5883941267;541826;26133.346666332734;26483;26561;26584.202473925812;26612.802423890585;44401.33397999097;44792.55207447884;44840.87897802581;45313;46270;37192.628073718915;37251.62748372481;37384;37569.2486150281;38085;36270.45594316035;36687.08282292964;36867.893963181144;37500;37583.62416375911;36137.63862361343;36211.094722632144;36396.636033639326;36677.63322366742;36899.81550092233;31424.685753142177;32207.194820129684;32310.35379292448;32397.676023239466;32521.186970325933;24327.02691892375;24388.26835194947;24980.750192497842;25024.999000039796;25053.373665657775 19:57:02 INFO - PROCESS | 1968 | |2;jquery.html;311.85498743084463;322.61447570153666;364.93621094509507;386.7022392757577;402.1273835776365;16079.437219697313;18343.633127337464;19037.904810475964;19709.211631534738;20338.593228135465;19406;19682;20591.794082059176;20632.587348253026;21009.26467573635;6022.638641681513;6085.513158947274;6101.572889897709;6172.629642221458;6227.564070515065;5677.120046392815;6050.062240352752;6074.757009719628;6085.513158947296;6099.725512351933;6038.0942858571125;6057.787977420791;6071.878562428748;6089.238845144357;6727.764528241512;6483.189601299838;6514.837129071764;6537.477001839865;6629.502787290924;6666.966665166668;5624.15637654351;5823.737931793037;5856.76572937082;5933;5987.580869339148;13354.998375121904;13539.796903046463;13613.319334033258;19563.413097607096;21983;2113.397681660719;2147.2162660628915;2167.8590891592;2168.869867807921;2176.880271585062;9947.651832185838;10144.087032167141;10190.59237630494;12201.816972745415;14425.639359016108;1528.1136940574552;1746.711792554227;1760.4630587670756;1779.5106345754891;1795.308806109657;108371.45814270878;114151;114566.99999999917;114895.42552287268;115738.42130789292;11404.372759498141;11598.536058557733;11621.535138594361;11717.597892432032;11838.408079595985;14672.413103475741;14709.779353309708;14785;14786.408543658348;14787.038842475205;8609.870851937227;8796.824063518694;8816.471011739317;8880.8667869982;8911.796907417545;7536.208698086732;8246.515627187044;8724.607392667345;8752.956235218782;8917.464952102764;4540.160070386989;4624.768761561909;4631.282151266559;4681.204195286741;4708.741019243975;1722.888012279198;1771.5305444057335;1896.7818700849302;1948.2888745608034;2058.4030631117107;983.3804703037041;1000.4247557654378;1011.1506334678905;1018.332991890313;1023.6263763726187;18363;19645.607087858163;20233.785972841677;20495.795042049685;20507.384778456373;960.490939801906;973.1873885305707;1017.7353887989028;1035.7565971996576;1048.627737153315;8531.592287272655;10350.741231469274;10622.831488536254;10628.893711062945;10721.35671859691;529851.2231652521;536634;541741;581645;584901;128650;129050.35474822565;129169.77075573186;129892;135030.3248483771;905.7780843693338;909.7998440343114;910.886139232596;921.2215677752289;1023.9129673977795;17300.356466135698;17444.866083704517;17789.110544472984;17825.286988520314;18212.089395530435;36586.26827463489;39896.60103399045;44095.77952110219;45932.7703361481;49725.50274497209;61774.69112654408;64899.67550162219;65595.34404655892;67164.66417667881;69067;7716.305532501877;7936.365090792839;7945.602719863868;7945.8410831784195;8304.543250121302;10886.748023977343;11152.776944461228;11621.244619100069;12314.13801033955;12461.501539938301;5649.265595472727;10716;10798.568057277935;10874.966878146563;10937.453127343442;10602.034087957296;10982.670519884416;10984.395858227874;11207.60773372928;11223.38271395081;8840.823183536164;11134.777304454028;11270.49282782293;11312.886871131512;11354.205205635526;8044.678212871419;8107.310878575151;8257.133001034805;8282.544460054754;8455;9843.163331116935;11208.607698730506;11352.432378381212;11422.828657569977;11444.198906076495 19:57:02 INFO - PROCESS | 1968 | |3;mootools.html;1413.6677880698037;1612.2341887603386;1855.962880742385;1973.4967583266266;1976.4169569976855;8032.759017229492;8558.657653693845;8570.528620925847;8840.911590884089;8847.513386763725;8600.61297241624;8640.654373825055;8709.34679899007;8752.256058235042;8754.212120909116;2415.577273977056;2443.987780061106;2447.779699827015;2449.534588428202;2455.914043008495;2420.225527831095;2435.1111844176926;2467;2467.8272520923542;2479.566075936713;2447.8041756659513;2448.8285819992607;2470.641756945242;2480.578301688717;2490.0537795637724;2407.6027455469825;2432.8175386846056;2445.2664200739705;2449.9387515312083;2457.0663148003823;2008;2405.6391541268777;2421.4309637235237;2435.6346548017764;2460.20043485866;7905.656038473416;8663.35024873137;8839.911600883974;8925.553722313858;8948.418352807046;5234.895302093975;5423.620346575742;5469.371022332443;5470.370907345667;5483.4516548344845;3145.308032232905;3606.5852426970973;3645.2345007548447;3668.853245870162;3704.9629503704887;865.640759084979;1005.1054561440324;1050.054950544516;1050.5902697947806;1051.1380667852363;11586.652400428;11722.296662200295;11739.413029348583;11742.882571174265;11743.7064073398;4686.976565117153;4693.460252070987;4874.19575770001;4899;4957.3059771632;8598.5700714964;9909.35589186715;9946.403215807075;10053.497325133714;10074.992500749866;5402.405735369106;5440.891182176334;5445.1015582429245;5465.59008074396;5480.945190548123;4452.421185245962;4780.737059461763;4941.827036053721;4945.085159245479;4985.775640096204;3959.8416063357718;4012.378081397388;4050.5746896576024;4092.2633925893624;4140.979295103505;1203.6689910274745;1253.2230017389277;1369.349558959506;1375.2023826180991;1385.5427708856053;828.5898480252193;889.8798662180523;908.9954550227206;925.0148591749766;943.6838659049296;5725.599208055396;5736.340320863154;5818.796342128006;5840.912386314209;5900.350961394243;447.7917768237785;453.055379533676;454.7135304757981;1020.5611587017654;1030.8866024737272;3811.7331786774657;3883.902902427462;3894.04595874007;3947.467091942551;3970.7617542946937;10353.327033742782;10612.363258204532;10725.356478611307;10747.516361763739;10821.783564328827;10484;10534.841977370346;10744.979226973424;10846.67459976202;10875.238733288594;8162.30620397261;8177.223163799429;8184.877226841602;8188.263056325079;8230.547319897343;5673.120666296731;5704.971475142598;5713.914291285717;5806.854828629149;5913.58604897653;9464.526773661151;9792.755181120529;9803.656872009446;9807.754806129904;9864.85202721974;9530.761730956781;9945.254105941938;9992.900070999198;10062.094411503;10066.144377727975;6879.277675844164;7272.709091636275;7303.452241081834;7476.5514069156025;7550.244975502405;8329.000519937646;8352;8398.706045288385;8420;8423.578821059045;6341.682915854097;7223.8555228896175;7302.488825782144;7355.080614923135;7540.359069479156;7099.787006389816;7183.748568800276;7261.854762904818;7340.669669864976;7353.742619008309;6880.174379074343;6903.551269167488;6954.617496037767;6980.371766541036;7010.649467526501;4848.3697119375665;4874.439439464365;4896.6572339935865;4910.116179087656;5094.006668699568;4614.777084072656;4903.730294833818;4931.901361972812;4932.383452068491;5127.333446651912 19:57:02 INFO - PROCESS | 1968 | |4;prototype.html;237.03998804840398;280.2447404245559;307.03131619739713;315.34408430464634;326.1341139275225;5562.221289019541;6022.849428764283;6069.211002569666;6152.292486364069;6165.537584681145;5022.447530771612;5571.8328450146455;5741.712914354286;5954.851128721773;6095.481884039862;4569.885752856188;4572.576534436737;4587.449506059277;4607;4608.124456353299;4452.866414007569;4566.611837993774;4593.862184134481;4609.193391156551;4629.976850115761;4086.8773936781945;4279.679024073192;4502;4503.4145561077175;4520.005598768265;4384.342348647697;4563.361129441881;4585.747783871869;4589.839355622571;4590.931136032962;3929.685625149981;3931.8820435386983;3947.9605203948167;3960.1485680578526;3962.1481381502826;5628.521575666074;5822.330432000332;5832.1834943108;5833.754004708176;5862.12068189775;4584.931226031612;4793.209120495114;4924.630652701062;5395.487428694307;5445.646033007842;6516.706748196342;6530.420483908877;6547.083408322838;6557.377049180321;6567.54027218095;4424.513303536608;4453.953320969569;4469.731816091013;4480.462344518679;4482.305242687356;5614.8730682948;6662.233843108056;6881.759138430131;6896.827579310558;6914.896276555855;4498.1003799239625;4502.752348620792;4509.481409637933;4537.115262523776;4556.612687921497;4579.129965306581;4614.284785858197;4626.86119416418;4628.791704373244;4649.86050418488;4458.71018383804;4628.935344870699;5183.533481986639;5184.611154163453;5393.892122157535;6277.905831412532;6380.617162970237;6536.934630653633;6542.934570654233;6631.137952066297;1326.661701266171;1401.9369128389246;1532.869706074974;1587.3650539784178;1592.5938885584103;935.9766005849772;1033.607229252879;1041.146260066753;1045.4406892312577;1066.1257768629648;5140.537351638371;5466.644668096561;6090.756369745249;6092.908606370819;6152.507799376039;5617;6780.593164410151;6810.182778066564;6817.69320380584;6824.556403833735;5943.276449829587;6021.307549631849;6091.66495842724;6100.267967843887;6126.479249263863;3528.206153615416;3545.18460754028;3565.3404120237838;3598.208394153282;3647.6899463545365;6878;7049.506534542636;7058.54119482232;7089.858202836018;7117.537360071578;6178.752849886044;6874.968754686837;6921.653917304115;6972.198197207386;6979.685914133876;6479.930811416064;6781.8643627127185;7004.614746189009;7143.642817859086;7196.784096477009;6319.52603554726;6611.074449576967;6632.668366581555;6731.730730770911;6767.729290828312;5246.973765131303;6068.4538391544975;6555.947520710271;6675.599464032173;6712.758139743968;6987.6855541499735;7039.1553013638695;7071.292870712888;7077.6461176941975;7105.609191494517;3651.5253017108666;4542.909141817079;4583.816647334069;4585.7019293747135;4603.5396460353695;5057.367829021372;6200.883840908499;6405.103285539935;6570.967145164243;6674.324526794226;5714.085746280575;5808.5643576732755;6486.286508484157;6487.935120648922;6585.242697089896;5600.411956744483;6346.692168992839;6542.953127499577;6600.702968366339;6710.865782684416;5583.581231407579;6423.261324947691;6457.515686323639;6467.482601391972;6482.643454610042;6597.967010164918;6612.537122401386;6642.933570664231;6665.866682666417;6683.665816709048;5328.706921119376;5683.403242659461;6427.3251308611925;6427.453666438405;6460.25707043696 19:57:02 INFO - PROCESS | 1968 | |5;yui.html;664.2991643815773;676.7191615479574;735.3161559749433;737.1854101218154;804.4208170117521;13900.235487048221;14613.780793288095;15019.32413041413;15040.646341829219;17139.82860171398;15851.445199418024;15872.603184920383;15988.280527376266;15988.520344389657;15994.360225590992;760.8326168243005;926.6941909169991;933.3793027636648;933.9252859771202;935.6584846531035;718.5904034700224;896.9461832290051;926.7914719188162;931.8788557487517;934.6495064350869;941.6421759731293;970.3401686852937;970.8446648536236;975.7024107647164;977;892.1301730812406;949.9715008549755;960.490939801906;971.130837900079;974.3423189347233;669.4878418010226;718.683779137178;721.6175427023686;722.1406526233817;725.314577724051;15181.240937953058;15291.388344466208;15388.461403850923;15401.306941187673;15436.073835569901;12331.753364932742;12413.317267550281;12487.687807804787;12497.437615307334;12735.426905789262;9814.362066465728;9911;10011;10200.48997550127;10975.50610222542;4043.8989025274605;4193.643540299078;4197.4753155855515;4315.870523884289;4335.89434694151;80879.19120808775;81944.77082843763;82762.58618706868;84612;85398;9286.540000592815;9373.578188981512;9417.293702972305;9423.199028082552;9537.904620953841;20778.376648700563;20871;20966.95165241732;21151.894240528698;21165.576688466146;7225.638718064076;7365.410767138616;7426.134299463964;7467.887981680279;7492.625368731542;3881.223755248905;3962.0689138052535;4002.3396139637216;4017.7176387724494;4032.858849940238;3529.911752206215;3530.046887340404;3627.2745450909397;3627.3108109459117;3640.890773276806;591.6391001489088;595.6366616364102;602.6414283501309;612.5161122713007;624.569047357322;525.5270256768862;548.679022771683;561.6152935239375;580.2891457964045;587.6885250817073;6953.443724502028;7533.1336896257635;7581.786914093718;7730.729424470116;7752.147263800977;540.1600511205114;562.971851407428;578.7181393214051;581.0876923230487;593.9910901336483;3478.89563313101;3717.981410092932;3727.2172843703124;3758.586555478895;3799.335116354682;69398.65300673465;88702;93276.53361733147;95946;95982;79398.6030069846;79660.80508792373;79869;79910.80133797998;80866;70587.64706176436;71823.64088179526;71904.64047679729;72280;73790.63104684443;7280.3083707047745;7299.817504562428;7513.173550909505;7531.548107113591;7553;37285;37824.676136335096;42431.575684242765;43038.56961430346;43318;57974;61259.69370153121;61378.693106534185;61787.691061546204;61992;9654.56554455037;9705.902940970782;9741.853872191781;9777.951110244403;10204.285700001226;10586.206034547286;10701.839472407764;10903.563857445613;11048.668539943814;11450.825909843717;10187.981201879753;10388.324758890649;10422.21833362516;10432.165426765992;10434.582616695247;10059.49702514886;10143.797124057624;10371.58513659445;10426.843597346198;10438.060574548326;8758.737237882873;10151.390916545031;10164.085232329126;10379.06588407047;10421.9478902605;7118.644067796693;8605.569721514024;8647.654093836427;8658.264047556027;9124.483599621562;8664.393492455467;8717.869231961653;8875.467471951704;8893.822123557364;9046.689715978388 19:57:02 INFO - PROCESS | 1968 | __end_tp_report 19:57:02 INFO - PROCESS | 1968 | __start_cc_report 19:57:02 INFO - PROCESS | 1968 | _x_x_mozilla_cycle_collect,404 19:57:02 INFO - PROCESS | 1968 | __end_cc_report 19:57:02 INFO - PROCESS | 1968 | __startTimestamp1461121022037__endTimestamp 19:57:02 INFO - PROCESS | 1968 | 19:57:02 INFO - PROCESS | 1968 | ------- Summary: start ------- 19:57:02 INFO - PROCESS | 1968 | Number of tests: 6 19:57:02 INFO - PROCESS | 1968 | 19:57:02 INFO - PROCESS | 1968 | [#0] dojo.html Cycles:165 Average:5822.69 Median:6111.82 stddev:798.81 (13.1%) stddev-sans-first:768.72 19:57:02 INFO - PROCESS | 1968 | Values: 2946.0 3495.0 3556.0 3557.8 3586.9 5840.9 5901.5 5910.6 5939.2 5947.7 5795.1 5893.5 5898.0 5975.1 6072.8 5266.7 5291.5 5333.3 5333.9 5365.9 104.3 5206.3 5289.9 5324.1 5327.9 5233.6 5262.1 5267.7 5286.8 5321.9 5258.8 5301.9 5304.4 5319.4 5321.1 5236.1 5238.9 5335.6 5336.7 5353.4 5643.8 5763.3 5803.4 5820.4 5838.2 6164.0 6198.1 6281.6 6286.1 6299.6 6292.0 6343.2 6364.3 6376.0 6389.4 6021.3 6027.1 6039.2 6056.2 6087.8 6316.5 6381.1 6445.5 6458.8 6470.7 6101.2 6198.8 6252.2 6277.8 6280.8 6313.0 6342.9 6355.5 6369.4 6369.4 6192.7 6200.3 6227.6 6257.0 6287.0 6241.0 6248.2 6265.6 6268.4 6294.6 4997.3 4998.1 5037.6 5040.1 5047.5 4376.1 4458.7 4491.4 4572.5 4619.7 6005.1 6079.6 6090.8 6093.7 6107.3 5866.3 6226.0 6230.4 6272.7 6284.2 5138.4 5784.7 6066.7 6077.0 6121.2 4610.9 5487.4 5537.0 5547.7 5550.2 6387.0 6553.4 6559.1 6563.3 6567.1 6261.9 6330.9 6396.3 6399.8 6404.7 6522.9 6537.9 6563.8 6590.3 6594.1 6137.9 6190.0 6242.9 6269.4 6278.2 6226.3 6240.6 6279.8 6283.8 6284.3 6054.9 6157.2 6175.3 6182.4 6257.6 5084.7 6190.6 6242.7 6265.4 6267.9 5766.3 6111.4 6118.3 6132.8 6230.7 6249.7 6263.7 6281.1 6282.4 6300.2 6024.0 6108.5 6111.8 6138.3 6215.3 19:57:02 INFO - PROCESS | 1968 | 19:57:02 INFO - PROCESS | 1968 | [#1] ext.html Cycles:180 Average:64753.00 Median:37576.44 stddev:138833.12 (369.5%) stddev-sans-first:139138.74 19:57:02 INFO - PROCESS | 1968 | Values: 492.2 519.2 524.2 541.3 613.1 36761.8 37557.0 37603.4 37633.7 37649.8 38082.0 38604.6 38630.2 38645.4 38792.0 9280.9 9380.7 9385.8 9500.8 9527.6 9420.2 9645.2 9658.4 9660.4 9678.8 9554.0 9606.9 9641.8 9644.6 9666.7 9560.7 9610.8 9654.5 9664.3 9669.5 9466.3 9519.2 9577.2 9586.8 9589.1 37173.1 37415.8 37776.4 37814.4 37932.4 2692.8 2805.8 2979.6 3421.9 3573.4 26980.6 27250.3 27803.9 28658.9 30075.0 2744.3 2746.5 2797.6 2808.8 2876.1 338525.3 402271.0 403122.0 408824.0 409011.0 56844.1 57678.7 57684.8 57795.4 57884.7 61241.4 61885.7 62386.4 64732.4 67003.7 14053.2 16180.9 16543.3 16744.5 16755.8 12798.0 13009.9 13137.5 13144.8 13175.9 18775.3 18832.6 18860.9 18915.2 18921.6 7728.9 8190.1 8329.9 8345.7 8404.7 902.4 915.2 1052.9 1093.5 1153.1 29052.0 29215.3 29559.0 29715.0 29760.9 1070.2 1096.3 1108.2 1138.0 1208.4 13914.4 14225.6 14640.8 14737.4 15099.5 601686.9 605263.0 611412.0 611458.0 614889.6 55988.7 57921.0 58389.4 58754.4 58799.7 1473.5 1480.2 1484.9 1491.2 1493.5 28971.1 29019.3 29455.3 29569.9 29718.0 47509.0 47696.8 48005.3 48031.8 48099.4 513292.0 535392.0 539939.0 541160.6 541826.0 26133.3 26483.0 26561.0 26584.2 26612.8 44401.3 44792.6 44840.9 45313.0 46270.0 37192.6 37251.6 37384.0 37569.2 38085.0 36270.5 36687.1 36867.9 37500.0 37583.6 36137.6 36211.1 36396.6 36677.6 36899.8 31424.7 32207.2 32310.4 32397.7 32521.2 24327.0 24388.3 24980.8 25025.0 25053.4 19:57:02 INFO - PROCESS | 1968 | 19:57:02 INFO - PROCESS | 1968 | [#2] jquery.html Cycles:180 Average:32801.89 Median:20820.93 stddev:92957.12 (446.5%) stddev-sans-first:93185.88 19:57:02 INFO - PROCESS | 1968 | Values: 311.9 322.6 364.9 386.7 402.1 16079.4 18343.6 19037.9 19709.2 20338.6 19406.0 19682.0 20591.8 20632.6 21009.3 6022.6 6085.5 6101.6 6172.6 6227.6 5677.1 6050.1 6074.8 6085.5 6099.7 6038.1 6057.8 6071.9 6089.2 6727.8 6483.2 6514.8 6537.5 6629.5 6667.0 5624.2 5823.7 5856.8 5933.0 5987.6 13355.0 13539.8 13613.3 19563.4 21983.0 2113.4 2147.2 2167.9 2168.9 2176.9 9947.7 10144.1 10190.6 12201.8 14425.6 1528.1 1746.7 1760.5 1779.5 1795.3 108371.5 114151.0 114567.0 114895.4 115738.4 11404.4 11598.5 11621.5 11717.6 11838.4 14672.4 14709.8 14785.0 14786.4 14787.0 8609.9 8796.8 8816.5 8880.9 8911.8 7536.2 8246.5 8724.6 8753.0 8917.5 4540.2 4624.8 4631.3 4681.2 4708.7 1722.9 1771.5 1896.8 1948.3 2058.4 983.4 1000.4 1011.2 1018.3 1023.6 18363.0 19645.6 20233.8 20495.8 20507.4 960.5 973.2 1017.7 1035.8 1048.6 8531.6 10350.7 10622.8 10628.9 10721.4 529851.2 536634.0 541741.0 581645.0 584901.0 128650.0 129050.4 129169.8 129892.0 135030.3 905.8 909.8 910.9 921.2 1023.9 17300.4 17444.9 17789.1 17825.3 18212.1 36586.3 39896.6 44095.8 45932.8 49725.5 61774.7 64899.7 65595.3 67164.7 69067.0 7716.3 7936.4 7945.6 7945.8 8304.5 10886.7 11152.8 11621.2 12314.1 12461.5 5649.3 10716.0 10798.6 10875.0 10937.5 10602.0 10982.7 10984.4 11207.6 11223.4 8840.8 11134.8 11270.5 11312.9 11354.2 8044.7 8107.3 8257.1 8282.5 8455.0 9843.2 11208.6 11352.4 11422.8 11444.2 19:57:02 INFO - PROCESS | 1968 | 19:57:02 INFO - PROCESS | 1968 | [#3] mootools.html Cycles:180 Average:5688.84 Median:4932.14 stddev:3157.89 (64.0%) stddev-sans-first:3150.41 19:57:02 INFO - PROCESS | 1968 | Values: 1413.7 1612.2 1856.0 1973.5 1976.4 8032.8 8558.7 8570.5 8840.9 8847.5 8600.6 8640.7 8709.3 8752.3 8754.2 2415.6 2444.0 2447.8 2449.5 2455.9 2420.2 2435.1 2467.0 2467.8 2479.6 2447.8 2448.8 2470.6 2480.6 2490.1 2407.6 2432.8 2445.3 2449.9 2457.1 2008.0 2405.6 2421.4 2435.6 2460.2 7905.7 8663.4 8839.9 8925.6 8948.4 5234.9 5423.6 5469.4 5470.4 5483.5 3145.3 3606.6 3645.2 3668.9 3705.0 865.6 1005.1 1050.1 1050.6 1051.1 11586.7 11722.3 11739.4 11742.9 11743.7 4687.0 4693.5 4874.2 4899.0 4957.3 8598.6 9909.4 9946.4 10053.5 10075.0 5402.4 5440.9 5445.1 5465.6 5480.9 4452.4 4780.7 4941.8 4945.1 4985.8 3959.8 4012.4 4050.6 4092.3 4141.0 1203.7 1253.2 1369.3 1375.2 1385.5 828.6 889.9 909.0 925.0 943.7 5725.6 5736.3 5818.8 5840.9 5900.4 447.8 453.1 454.7 1020.6 1030.9 3811.7 3883.9 3894.0 3947.5 3970.8 10353.3 10612.4 10725.4 10747.5 10821.8 10484.0 10534.8 10745.0 10846.7 10875.2 8162.3 8177.2 8184.9 8188.3 8230.5 5673.1 5705.0 5713.9 5806.9 5913.6 9464.5 9792.8 9803.7 9807.8 9864.9 9530.8 9945.3 9992.9 10062.1 10066.1 6879.3 7272.7 7303.5 7476.6 7550.2 8329.0 8352.0 8398.7 8420.0 8423.6 6341.7 7223.9 7302.5 7355.1 7540.4 7099.8 7183.7 7261.9 7340.7 7353.7 6880.2 6903.6 6954.6 6980.4 7010.6 4848.4 4874.4 4896.7 4910.1 5094.0 4614.8 4903.7 4931.9 4932.4 5127.3 19:57:02 INFO - PROCESS | 1968 | 19:57:02 INFO - PROCESS | 1968 | [#4] prototype.html Cycles:180 Average:5286.48 Median:5815.45 stddev:1656.65 (28.5%) stddev-sans-first:1617.37 19:57:02 INFO - PROCESS | 1968 | Values: 237.0 280.2 307.0 315.3 326.1 5562.2 6022.8 6069.2 6152.3 6165.5 5022.4 5571.8 5741.7 5954.9 6095.5 4569.9 4572.6 4587.4 4607.0 4608.1 4452.9 4566.6 4593.9 4609.2 4630.0 4086.9 4279.7 4502.0 4503.4 4520.0 4384.3 4563.4 4585.7 4589.8 4590.9 3929.7 3931.9 3948.0 3960.1 3962.1 5628.5 5822.3 5832.2 5833.8 5862.1 4584.9 4793.2 4924.6 5395.5 5445.6 6516.7 6530.4 6547.1 6557.4 6567.5 4424.5 4454.0 4469.7 4480.5 4482.3 5614.9 6662.2 6881.8 6896.8 6914.9 4498.1 4502.8 4509.5 4537.1 4556.6 4579.1 4614.3 4626.9 4628.8 4649.9 4458.7 4628.9 5183.5 5184.6 5393.9 6277.9 6380.6 6536.9 6542.9 6631.1 1326.7 1401.9 1532.9 1587.4 1592.6 936.0 1033.6 1041.1 1045.4 1066.1 5140.5 5466.6 6090.8 6092.9 6152.5 5617.0 6780.6 6810.2 6817.7 6824.6 5943.3 6021.3 6091.7 6100.3 6126.5 3528.2 3545.2 3565.3 3598.2 3647.7 6878.0 7049.5 7058.5 7089.9 7117.5 6178.8 6875.0 6921.7 6972.2 6979.7 6479.9 6781.9 7004.6 7143.6 7196.8 6319.5 6611.1 6632.7 6731.7 6767.7 5247.0 6068.5 6555.9 6675.6 6712.8 6987.7 7039.2 7071.3 7077.6 7105.6 3651.5 4542.9 4583.8 4585.7 4603.5 5057.4 6200.9 6405.1 6571.0 6674.3 5714.1 5808.6 6486.3 6487.9 6585.2 5600.4 6346.7 6543.0 6600.7 6710.9 5583.6 6423.3 6457.5 6467.5 6482.6 6598.0 6612.5 6642.9 6665.9 6683.7 5328.7 5683.4 6427.3 6427.5 6460.3 19:57:02 INFO - PROCESS | 1968 | 19:57:02 INFO - PROCESS | 1968 | [#5] yui.html Cycles:180 Average:17730.68 Median:61889.85 stddev:25313.77 (40.9%) stddev-sans-first:25352.34 19:57:02 INFO - PROCESS | 1968 | Values: 664.3 676.7 735.3 737.2 804.4 13900.2 14613.8 15019.3 15040.6 17139.8 15851.4 15872.6 15988.3 15988.5 15994.4 760.8 926.7 933.4 933.9 935.7 718.6 896.9 926.8 931.9 934.6 941.6 970.3 970.8 975.7 977.0 892.1 950.0 960.5 971.1 974.3 669.5 718.7 721.6 722.1 725.3 15181.2 15291.4 15388.5 15401.3 15436.1 12331.8 12413.3 12487.7 12497.4 12735.4 9814.4 9911.0 10011.0 10200.5 10975.5 4043.9 4193.6 4197.5 4315.9 4335.9 80879.2 81944.8 82762.6 84612.0 85398.0 9286.5 9373.6 9417.3 9423.2 9537.9 20778.4 20871.0 20967.0 21151.9 21165.6 7225.6 7365.4 7426.1 7467.9 7492.6 3881.2 3962.1 4002.3 4017.7 4032.9 3529.9 3530.0 3627.3 3627.3 3640.9 591.6 595.6 602.6 612.5 624.6 525.5 548.7 561.6 580.3 587.7 6953.4 7533.1 7581.8 7730.7 7752.1 540.2 563.0 578.7 581.1 594.0 3478.9 3718.0 3727.2 3758.6 3799.3 69398.7 88702.0 93276.5 95946.0 95982.0 79398.6 79660.8 79869.0 79910.8 80866.0 70587.6 71823.6 71904.6 72280.0 73790.6 7280.3 7299.8 7513.2 7531.5 7553.0 37285.0 37824.7 42431.6 43038.6 43318.0 57974.0 61259.7 61378.7 61787.7 61992.0 9654.6 9705.9 9741.9 9778.0 10204.3 10586.2 10701.8 10903.6 11048.7 11450.8 10188.0 10388.3 10422.2 10432.2 10434.6 10059.5 10143.8 10371.6 10426.8 10438.1 8758.7 10151.4 10164.1 10379.1 10421.9 7118.6 8605.6 8647.7 8658.3 9124.5 8664.4 8717.9 8875.5 8893.8 9046.7 19:57:02 INFO - PROCESS | 1968 | -------- Summary: end -------- 19:57:02 INFO - PROCESS | 1968 | 19:57:02 INFO - TEST-INFO | 1968: exit 0 19:57:02 INFO - TEST-OK | dromaeo_css | took 1112423ms 19:57:02 INFO - TEST-START | kraken 19:57:02 INFO - operating with platform_type : mac_ 19:57:02 INFO - Initialising browser for kraken test... 19:57:02 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmp4Nl7YY/profile http://localhost:49748/getInfo.html) 19:57:05 INFO - PROCESS | 1973 | __metrics Screen width/height:1600/1200 19:57:05 INFO - PROCESS | 1973 | colorDepth:24 19:57:05 INFO - PROCESS | 1973 | Browser inner width/height: 1024/689 19:57:05 INFO - PROCESS | 1973 | __metrics 19:57:05 ERROR - PROCESS | 1973 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:57:06 INFO - TEST-INFO | 1973: exit 0 19:57:06 INFO - Browser initialized. 19:57:06 INFO - Running cycle 1/1 for kraken test... 19:57:06 INFO - TEST-INFO | started process 1976 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmp4Nl7YY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:57:18 INFO - PROCESS | 1976 | RSS: Main: 247914496 19:57:18 INFO - PROCESS | 1976 | 19:57:21 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49748/tests/kraken/driver.html?testName=audio-beat-detection) 19:57:21 INFO - PROCESS | 1976 | RSS: Main: 260124672 19:57:21 INFO - PROCESS | 1976 | 19:57:24 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49748/tests/kraken/driver.html?testName=audio-dft) 19:57:25 INFO - PROCESS | 1976 | RSS: Main: 269000704 19:57:25 INFO - PROCESS | 1976 | 19:57:28 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49748/tests/kraken/driver.html?testName=audio-fft) 19:57:29 INFO - PROCESS | 1976 | RSS: Main: 272166912 19:57:29 INFO - PROCESS | 1976 | 19:57:31 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49748/tests/kraken/driver.html?testName=audio-oscillator) 19:57:32 INFO - PROCESS | 1976 | RSS: Main: 274153472 19:57:32 INFO - PROCESS | 1976 | 19:57:34 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49748/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:57:35 INFO - PROCESS | 1976 | RSS: Main: 274784256 19:57:35 INFO - PROCESS | 1976 | 19:57:37 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49748/tests/kraken/driver.html?testName=imaging-darkroom) 19:57:38 INFO - PROCESS | 1976 | RSS: Main: 274685952 19:57:38 INFO - PROCESS | 1976 | 19:57:41 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49748/tests/kraken/driver.html?testName=imaging-desaturate) 19:57:42 INFO - PROCESS | 1976 | RSS: Main: 274882560 19:57:42 INFO - PROCESS | 1976 | 19:57:45 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49748/tests/kraken/driver.html?testName=json-parse-financial) 19:57:45 INFO - PROCESS | 1976 | RSS: Main: 275083264 19:57:45 INFO - PROCESS | 1976 | 19:57:47 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49748/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:57:47 INFO - PROCESS | 1976 | RSS: Main: 274939904 19:57:47 INFO - PROCESS | 1976 | 19:57:49 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49748/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:57:50 INFO - PROCESS | 1976 | RSS: Main: 274989056 19:57:50 INFO - PROCESS | 1976 | 19:57:52 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49748/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:57:53 INFO - PROCESS | 1976 | RSS: Main: 275832832 19:57:53 INFO - PROCESS | 1976 | 19:57:56 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:57:57 INFO - PROCESS | 1976 | RSS: Main: 275386368 19:57:57 INFO - PROCESS | 1976 | 19:58:00 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:58:00 INFO - PROCESS | 1976 | RSS: Main: 275582976 19:58:00 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49748/tests/kraken/driver.html?testName=ai-astar) 19:58:02 INFO - PROCESS | 1976 | RSS: Main: 276762624 19:58:02 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | __start_tp_report 19:58:02 INFO - PROCESS | 1976 | _x_x_mozilla_page_load 19:58:02 INFO - PROCESS | 1976 | _x_x_mozilla_page_load_details 19:58:02 INFO - PROCESS | 1976 | |i|pagename|runs| 19:58:02 INFO - PROCESS | 1976 | |0;ai-astar;115;109;114;116;115;128;116;117;117;117 19:58:02 INFO - PROCESS | 1976 | |1;audio-beat-detection;157;152;142;163;129;160;183;191;158;125 19:58:02 INFO - PROCESS | 1976 | |2;audio-dft;276;268;243;187;247;287;220;199;198;200 19:58:02 INFO - PROCESS | 1976 | |3;audio-fft;62;69;82;136;56;51;83;58;133;68 19:58:02 INFO - PROCESS | 1976 | |4;audio-oscillator;83;80;127;116;120;69;159;119;112;150 19:58:02 INFO - PROCESS | 1976 | |5;imaging-gaussian-blur;92;88;89;88;92;74;135;88;90;87 19:58:02 INFO - PROCESS | 1976 | |6;imaging-darkroom;94;95;96;95;115;123;97;96;96;96 19:58:02 INFO - PROCESS | 1976 | |7;imaging-desaturate;91;93;138;77;149;150;134;90;89;91 19:58:02 INFO - PROCESS | 1976 | |8;json-parse-financial;62;62;62;61;62;61;61;78;64;61 19:58:02 INFO - PROCESS | 1976 | |9;json-stringify-tinderbox;64;67;66;71;79;72;95;93;99;81 19:58:02 INFO - PROCESS | 1976 | |10;stanford-crypto-aes;106;107;114;111;86;82;84;84;84;81 19:58:02 INFO - PROCESS | 1976 | |11;stanford-crypto-ccm;143;140;140;140;159;173;150;144;195;183 19:58:02 INFO - PROCESS | 1976 | |12;stanford-crypto-pbkdf2;167;181;200;171;228;237;179;174;182;175 19:58:02 INFO - PROCESS | 1976 | |13;stanford-crypto-sha256-iterative;69;70;70;68;71;69;66;74;67;59 19:58:02 INFO - PROCESS | 1976 | __end_tp_report 19:58:02 INFO - PROCESS | 1976 | __start_cc_report 19:58:02 INFO - PROCESS | 1976 | _x_x_mozilla_cycle_collect,1034 19:58:02 INFO - PROCESS | 1976 | __end_cc_report 19:58:02 INFO - PROCESS | 1976 | __startTimestamp1461121082723__endTimestamp 19:58:02 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | ------- Summary: start ------- 19:58:02 INFO - PROCESS | 1976 | Number of tests: 14 19:58:02 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | [#0] ai-astar Cycles:10 Average:116.40 Median:116.50 stddev:4.72 (4.1%) stddev-sans-first:4.98 19:58:02 INFO - PROCESS | 1976 | Values: 115.0 109.0 114.0 116.0 115.0 128.0 116.0 117.0 117.0 117.0 19:58:02 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | [#1] audio-beat-detection Cycles:10 Average:156.00 Median:159.00 stddev:20.89 (13.1%) stddev-sans-first:22.15 19:58:02 INFO - PROCESS | 1976 | Values: 157.0 152.0 142.0 163.0 129.0 160.0 183.0 191.0 158.0 125.0 19:58:02 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | [#2] audio-dft Cycles:10 Average:232.50 Median:245.00 stddev:36.57 (14.9%) stddev-sans-first:35.24 19:58:02 INFO - PROCESS | 1976 | Values: 276.0 268.0 243.0 187.0 247.0 287.0 220.0 199.0 198.0 200.0 19:58:02 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | [#3] audio-fft Cycles:10 Average:79.80 Median:65.00 stddev:30.64 (47.1%) stddev-sans-first:31.81 19:58:02 INFO - PROCESS | 1976 | Values: 62.0 69.0 82.0 136.0 56.0 51.0 83.0 58.0 133.0 68.0 19:58:02 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | [#4] audio-oscillator Cycles:10 Average:113.50 Median:154.50 stddev:29.25 (18.9%) stddev-sans-first:28.86 19:58:02 INFO - PROCESS | 1976 | Values: 83.0 80.0 127.0 116.0 120.0 69.0 159.0 119.0 112.0 150.0 19:58:02 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:88.50 stddev:15.84 (17.9%) stddev-sans-first:16.80 19:58:02 INFO - PROCESS | 1976 | Values: 92.0 88.0 89.0 88.0 92.0 74.0 135.0 88.0 90.0 87.0 19:58:02 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | [#6] imaging-darkroom Cycles:10 Average:100.30 Median:96.00 stddev:10.07 (10.5%) stddev-sans-first:10.42 19:58:02 INFO - PROCESS | 1976 | Values: 94.0 95.0 96.0 95.0 115.0 123.0 97.0 96.0 96.0 96.0 19:58:02 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | [#7] imaging-desaturate Cycles:10 Average:110.20 Median:89.50 stddev:28.72 (32.1%) stddev-sans-first:29.61 19:58:02 INFO - PROCESS | 1976 | Values: 91.0 93.0 138.0 77.0 149.0 150.0 134.0 90.0 89.0 91.0 19:58:02 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:62.00 stddev:5.21 (8.4%) stddev-sans-first:5.50 19:58:02 INFO - PROCESS | 1976 | Values: 62.0 62.0 62.0 61.0 62.0 61.0 61.0 78.0 64.0 61.0 19:58:02 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | [#9] json-stringify-tinderbox Cycles:10 Average:78.70 Median:80.00 stddev:12.94 (16.2%) stddev-sans-first:12.58 19:58:02 INFO - PROCESS | 1976 | Values: 64.0 67.0 66.0 71.0 79.0 72.0 95.0 93.0 99.0 81.0 19:58:02 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | [#10] stanford-crypto-aes Cycles:10 Average:93.90 Median:83.00 stddev:13.66 (16.5%) stddev-sans-first:13.77 19:58:02 INFO - PROCESS | 1976 | Values: 106.0 107.0 114.0 111.0 86.0 82.0 84.0 84.0 84.0 81.0 19:58:02 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | [#11] stanford-crypto-ccm Cycles:10 Average:156.70 Median:154.50 stddev:20.17 (13.1%) stddev-sans-first:20.77 19:58:02 INFO - PROCESS | 1976 | Values: 143.0 140.0 140.0 140.0 159.0 173.0 150.0 144.0 195.0 183.0 19:58:02 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.40 Median:181.50 stddev:24.46 (13.5%) stddev-sans-first:24.57 19:58:02 INFO - PROCESS | 1976 | Values: 167.0 181.0 200.0 171.0 228.0 237.0 179.0 174.0 182.0 175.0 19:58:02 INFO - PROCESS | 1976 | 19:58:02 INFO - PROCESS | 1976 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.50 stddev:3.95 (5.7%) stddev-sans-first:4.18 19:58:02 INFO - PROCESS | 1976 | Values: 69.0 70.0 70.0 68.0 71.0 69.0 66.0 74.0 67.0 59.0 19:58:02 INFO - PROCESS | 1976 | -------- Summary: end -------- 19:58:02 INFO - PROCESS | 1976 | 19:58:03 INFO - TEST-INFO | 1976: exit 0 19:58:03 INFO - TEST-OK | kraken | took 60884ms 19:58:03 INFO - SUITE-END | took 1173s 19:58:03 INFO - Completed test suite (00:19:33) 19:58:03 INFO - javascript benchmark 19:58:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2945.9999999999995, 3495.0388643123138, 3556.0398692353065, 3557.7509574329806, 3586.874459393922, 5840.941590584098, 5901.527877769779, 5910.615809972349, 5939.168516407701, 5947.732352044158, 5795.072788353864, 5893.528517718583, 5898.0, 5975.073863551145, 6072.848178795522, 5266.683998960056, 5291.523762861341, 5333.306670132897, 5333.919991200135, 5365.892682146355, 104.30934919603179, 5206.271122042917, 5289.920651190235, 5324.068288049576, 5327.893442131155, 5233.58131349493, 5262.131748261532, 5267.736613169345, 5286.788528458857, 5321.946780532203, 5258.8159414420315, 5301.920471192935, 5304.443033481468, 5319.414864364917, 5321.095413779667, 5236.083685355047, 5238.899831035487, 5335.573154147659, 5336.706481143536, 5353.384360798519, 5643.830685079454, 5763.279590051244, 5803.361630220672, 5820.3888591698105, 5838.182654428383, 6164.0, 6198.132261483351, 6281.560290779647, 6286.119943207955, 6299.559030867841, 6291.968540157316, 6343.207099112611, 6364.2681091674585, 6376.0, 6389.393007664311, 6021.337652858182, 6027.065804800263, 6039.245094363205, 6056.21269235001, 6087.786927457518, 6316.463100636497, 6381.138546296191, 6445.45213656835, 6458.806235812933, 6470.708818103197, 6101.217066730222, 6198.783042593487, 6252.155958945484, 6277.780277690259, 6280.811575652738, 6312.968435157886, 6342.936570634327, 6355.523335749837, 6369.363063693593, 6369.394907483782, 6192.690365481708, 6200.3179650238435, 6227.564070515021, 6257.0, 6286.968565157145, 6240.968795155995, 6248.218972628421, 6265.561410701207, 6268.435840774352, 6294.590851594632, 4997.275395067695, 4998.05037042968, 5037.596992240612, 5040.1179793535985, 5047.470015648378, 4376.081022985209, 4458.687891847604, 4491.438570178728, 4572.451305843254, 4619.745913974696, 6005.129256257818, 6079.574429789961, 6090.786822461193, 6093.725782339717, 6107.340534417129, 5866.266716660418, 6225.972714502147, 6230.43926046658, 6272.717727702265, 6284.214473190851, 5138.434772175057, 5784.652920824764, 6066.726997285133, 6076.969615151985, 6121.234845644294, 4610.9164346378575, 5487.368952570426, 5536.972315138479, 5547.694876781816, 5550.222968784374, 6387.041943708481, 6553.377429144223, 6559.147310849559, 6563.343665633494, 6567.080608714784, 6261.874762504815, 6330.871993685129, 6396.264429590657, 6399.776007839703, 6404.679766011774, 6522.902156467562, 6537.8692426152165, 6563.803085907431, 6590.275069742229, 6594.076829244005, 6137.9286238596105, 6189.96905015472, 6242.937570624417, 6269.435750782452, 6278.15244941927, 6226.3151053385, 6240.625562466266, 6279.843003924756, 6283.842903927439, 6284.277308109443, 6054.939450605438, 6157.230346206724, 6175.289841668086, 6182.412670796267, 6257.623322868962, 5084.720340381166, 6190.628562286277, 6242.719077641426, 6265.404786545271, 6267.874642507033, 5766.308043034863, 6111.40942266768, 6118.265808103056, 6132.758293649526, 6230.719617617308, 6249.656268905072, 6263.718132683949, 6281.12064311006, 6282.403171698681, 6300.21247344082, 6023.969880150571, 6108.463491842691, 6111.816645500642, 6138.263408391022, 6215.316315205233], "value": 5773.286265384607, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.15595254139123, 519.2289450166503, 524.177042043991, 541.3314556522694, 613.1416017575395, 36761.81619091904, 37557.0, 37603.43594846079, 37633.68282110127, 37649.81175094124, 38082.0, 38604.613953860455, 38630.227395452144, 38645.42031869517, 38792.0, 9280.860787088182, 9380.718578442658, 9385.812283754354, 9500.762480937963, 9527.571259293314, 9420.152186303232, 9645.228381729445, 9658.420494770302, 9660.372075815085, 9678.806423871518, 9554.0, 9606.895207051173, 9641.807163856718, 9644.61421543141, 9666.661666841626, 9560.713178604654, 9610.807783844353, 9654.469004204766, 9664.275179361506, 9669.468179250138, 9466.337356385056, 9519.190868776162, 9577.23382129428, 9586.76033099171, 9589.136977672042, 37173.07067323312, 37415.812920935496, 37776.43335349972, 37814.432783508266, 37932.43101353482, 2692.7980401469968, 2805.789565782554, 2979.644261860848, 3421.8802341917913, 3573.356795776759, 26980.59529107065, 27250.31874203141, 27803.887844486195, 28658.856705716546, 30075.0, 2744.341358074068, 2746.5193591121674, 2797.622320986661, 2808.817426867247, 2876.050903201938, 338525.30737346155, 402271.0, 403122.0, 408823.9558802217, 409011.0, 56844.14733778997, 57678.711606442535, 57684.846303073704, 57795.42204577901, 57884.71057644685, 61241.38758612446, 61885.69057154685, 62386.376136238054, 64732.352676472634, 67003.65992680119, 14053.17308749856, 16180.919095404683, 16543.338266469207, 16744.497665070066, 16755.83244167567, 12798.0, 13009.934950325187, 13137.474501019853, 13144.751248631364, 13175.868241317465, 18775.34286299973, 18832.623347532972, 18860.905695471436, 18915.24339026451, 18921.621567568847, 7728.917951486684, 8190.099089100194, 8329.916700832913, 8345.749627511184, 8404.697271922862, 902.41794042842, 915.208344781759, 1052.910502607287, 1093.4642025407493, 1153.140910022039, 29052.0, 29215.269618259714, 29559.0, 29715.0, 29760.851195743882, 1070.1652710885521, 1096.2600244834864, 1108.1965574958251, 1137.971550711239, 1208.4139192491634, 13914.443422262995, 14225.644358890904, 14640.780388294184, 14737.410503579737, 15099.54701358961, 601686.9409570731, 605263.0, 611412.0, 611458.0, 614889.5533134013, 55988.72005640027, 57921.0, 58389.41610583925, 58754.41245587575, 58799.70600146972, 1473.4842805018159, 1480.222882986419, 1484.9034812737139, 1491.1873029199112, 1493.492212647705, 28971.13086607405, 29019.274518137216, 29455.26361840971, 29569.85215073997, 29718.0, 47509.0, 47696.7615161922, 48005.27992080191, 48031.75984120057, 48099.35453550088, 513292.0, 535392.0, 539939.0, 541160.5883941267, 541826.0, 26133.346666332734, 26483.0, 26561.0, 26584.202473925812, 26612.802423890585, 44401.33397999097, 44792.55207447884, 44840.87897802581, 45313.0, 46270.0, 37192.628073718915, 37251.62748372481, 37384.0, 37569.2486150281, 38085.0, 36270.45594316035, 36687.08282292964, 36867.893963181144, 37500.0, 37583.62416375911, 36137.63862361343, 36211.094722632144, 36396.636033639326, 36677.63322366742, 36899.81550092233, 31424.685753142177, 32207.194820129684, 32310.35379292448, 32397.676023239466, 32521.186970325933, 24327.02691892375, 24388.26835194947, 24980.750192497842, 25024.999000039796, 25053.373665657775], "value": 19441.194292133638, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.85498743084463, 322.61447570153666, 364.93621094509507, 386.7022392757577, 402.1273835776365, 16079.437219697313, 18343.633127337464, 19037.904810475964, 19709.211631534738, 20338.593228135465, 19406.0, 19682.0, 20591.794082059176, 20632.587348253026, 21009.26467573635, 6022.638641681513, 6085.513158947274, 6101.572889897709, 6172.629642221458, 6227.564070515065, 5677.120046392815, 6050.062240352752, 6074.757009719628, 6085.513158947296, 6099.725512351933, 6038.0942858571125, 6057.787977420791, 6071.878562428748, 6089.238845144357, 6727.764528241512, 6483.189601299838, 6514.837129071764, 6537.477001839865, 6629.502787290924, 6666.966665166668, 5624.15637654351, 5823.737931793037, 5856.76572937082, 5933.0, 5987.580869339148, 13354.998375121904, 13539.796903046463, 13613.319334033258, 19563.413097607096, 21983.0, 2113.397681660719, 2147.2162660628915, 2167.8590891592, 2168.869867807921, 2176.880271585062, 9947.651832185838, 10144.087032167141, 10190.59237630494, 12201.816972745415, 14425.639359016108, 1528.1136940574552, 1746.711792554227, 1760.4630587670756, 1779.5106345754891, 1795.308806109657, 108371.45814270878, 114151.0, 114566.99999999917, 114895.42552287268, 115738.42130789292, 11404.372759498141, 11598.536058557733, 11621.535138594361, 11717.597892432032, 11838.408079595985, 14672.413103475741, 14709.779353309708, 14785.0, 14786.408543658348, 14787.038842475205, 8609.870851937227, 8796.824063518694, 8816.471011739317, 8880.8667869982, 8911.796907417545, 7536.208698086732, 8246.515627187044, 8724.607392667345, 8752.956235218782, 8917.464952102764, 4540.160070386989, 4624.768761561909, 4631.282151266559, 4681.204195286741, 4708.741019243975, 1722.888012279198, 1771.5305444057335, 1896.7818700849302, 1948.2888745608034, 2058.4030631117107, 983.3804703037041, 1000.4247557654378, 1011.1506334678905, 1018.332991890313, 1023.6263763726187, 18363.0, 19645.607087858163, 20233.785972841677, 20495.795042049685, 20507.384778456373, 960.490939801906, 973.1873885305707, 1017.7353887989028, 1035.7565971996576, 1048.627737153315, 8531.592287272655, 10350.741231469274, 10622.831488536254, 10628.893711062945, 10721.35671859691, 529851.2231652521, 536634.0, 541741.0, 581645.0, 584901.0, 128650.0, 129050.35474822565, 129169.77075573186, 129892.0, 135030.3248483771, 905.7780843693338, 909.7998440343114, 910.886139232596, 921.2215677752289, 1023.9129673977795, 17300.356466135698, 17444.866083704517, 17789.110544472984, 17825.286988520314, 18212.089395530435, 36586.26827463489, 39896.60103399045, 44095.77952110219, 45932.7703361481, 49725.50274497209, 61774.69112654408, 64899.67550162219, 65595.34404655892, 67164.66417667881, 69067.0, 7716.305532501877, 7936.365090792839, 7945.602719863868, 7945.8410831784195, 8304.543250121302, 10886.748023977343, 11152.776944461228, 11621.244619100069, 12314.13801033955, 12461.501539938301, 5649.265595472727, 10716.0, 10798.568057277935, 10874.966878146563, 10937.453127343442, 10602.034087957296, 10982.670519884416, 10984.395858227874, 11207.60773372928, 11223.38271395081, 8840.823183536164, 11134.777304454028, 11270.49282782293, 11312.886871131512, 11354.205205635526, 8044.678212871419, 8107.310878575151, 8257.133001034805, 8282.544460054754, 8455.0, 9843.163331116935, 11208.607698730506, 11352.432378381212, 11422.828657569977, 11444.198906076495], "value": 9293.12513747777, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.6677880698037, 1612.2341887603386, 1855.962880742385, 1973.4967583266266, 1976.4169569976855, 8032.759017229492, 8558.657653693845, 8570.528620925847, 8840.911590884089, 8847.513386763725, 8600.61297241624, 8640.654373825055, 8709.34679899007, 8752.256058235042, 8754.212120909116, 2415.577273977056, 2443.987780061106, 2447.779699827015, 2449.534588428202, 2455.914043008495, 2420.225527831095, 2435.1111844176926, 2467.0, 2467.8272520923542, 2479.566075936713, 2447.8041756659513, 2448.8285819992607, 2470.641756945242, 2480.578301688717, 2490.0537795637724, 2407.6027455469825, 2432.8175386846056, 2445.2664200739705, 2449.9387515312083, 2457.0663148003823, 2008.0, 2405.6391541268777, 2421.4309637235237, 2435.6346548017764, 2460.20043485866, 7905.656038473416, 8663.35024873137, 8839.911600883974, 8925.553722313858, 8948.418352807046, 5234.895302093975, 5423.620346575742, 5469.371022332443, 5470.370907345667, 5483.4516548344845, 3145.308032232905, 3606.5852426970973, 3645.2345007548447, 3668.853245870162, 3704.9629503704887, 865.640759084979, 1005.1054561440324, 1050.054950544516, 1050.5902697947806, 1051.1380667852363, 11586.652400428, 11722.296662200295, 11739.413029348583, 11742.882571174265, 11743.7064073398, 4686.976565117153, 4693.460252070987, 4874.19575770001, 4899.0, 4957.3059771632, 8598.5700714964, 9909.35589186715, 9946.403215807075, 10053.497325133714, 10074.992500749866, 5402.405735369106, 5440.891182176334, 5445.1015582429245, 5465.59008074396, 5480.945190548123, 4452.421185245962, 4780.737059461763, 4941.827036053721, 4945.085159245479, 4985.775640096204, 3959.8416063357718, 4012.378081397388, 4050.5746896576024, 4092.2633925893624, 4140.979295103505, 1203.6689910274745, 1253.2230017389277, 1369.349558959506, 1375.2023826180991, 1385.5427708856053, 828.5898480252193, 889.8798662180523, 908.9954550227206, 925.0148591749766, 943.6838659049296, 5725.599208055396, 5736.340320863154, 5818.796342128006, 5840.912386314209, 5900.350961394243, 447.7917768237785, 453.055379533676, 454.7135304757981, 1020.5611587017654, 1030.8866024737272, 3811.7331786774657, 3883.902902427462, 3894.04595874007, 3947.467091942551, 3970.7617542946937, 10353.327033742782, 10612.363258204532, 10725.356478611307, 10747.516361763739, 10821.783564328827, 10484.0, 10534.841977370346, 10744.979226973424, 10846.67459976202, 10875.238733288594, 8162.30620397261, 8177.223163799429, 8184.877226841602, 8188.263056325079, 8230.547319897343, 5673.120666296731, 5704.971475142598, 5713.914291285717, 5806.854828629149, 5913.58604897653, 9464.526773661151, 9792.755181120529, 9803.656872009446, 9807.754806129904, 9864.85202721974, 9530.761730956781, 9945.254105941938, 9992.900070999198, 10062.094411503, 10066.144377727975, 6879.277675844164, 7272.709091636275, 7303.452241081834, 7476.5514069156025, 7550.244975502405, 8329.000519937646, 8352.0, 8398.706045288385, 8420.0, 8423.578821059045, 6341.682915854097, 7223.8555228896175, 7302.488825782144, 7355.080614923135, 7540.359069479156, 7099.787006389816, 7183.748568800276, 7261.854762904818, 7340.669669864976, 7353.742619008309, 6880.174379074343, 6903.551269167488, 6954.617496037767, 6980.371766541036, 7010.649467526501, 4848.3697119375665, 4874.439439464365, 4896.6572339935865, 4910.116179087656, 5094.006668699568, 4614.777084072656, 4903.730294833818, 4931.901361972812, 4932.383452068491, 5127.333446651912], "value": 4565.460560111752, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [237.03998804840398, 280.2447404245559, 307.03131619739713, 315.34408430464634, 326.1341139275225, 5562.221289019541, 6022.849428764283, 6069.211002569666, 6152.292486364069, 6165.537584681145, 5022.447530771612, 5571.8328450146455, 5741.712914354286, 5954.851128721773, 6095.481884039862, 4569.885752856188, 4572.576534436737, 4587.449506059277, 4607.0, 4608.124456353299, 4452.866414007569, 4566.611837993774, 4593.862184134481, 4609.193391156551, 4629.976850115761, 4086.8773936781945, 4279.679024073192, 4502.0, 4503.4145561077175, 4520.005598768265, 4384.342348647697, 4563.361129441881, 4585.747783871869, 4589.839355622571, 4590.931136032962, 3929.685625149981, 3931.8820435386983, 3947.9605203948167, 3960.1485680578526, 3962.1481381502826, 5628.521575666074, 5822.330432000332, 5832.1834943108, 5833.754004708176, 5862.12068189775, 4584.931226031612, 4793.209120495114, 4924.630652701062, 5395.487428694307, 5445.646033007842, 6516.706748196342, 6530.420483908877, 6547.083408322838, 6557.377049180321, 6567.54027218095, 4424.513303536608, 4453.953320969569, 4469.731816091013, 4480.462344518679, 4482.305242687356, 5614.8730682948, 6662.233843108056, 6881.759138430131, 6896.827579310558, 6914.896276555855, 4498.1003799239625, 4502.752348620792, 4509.481409637933, 4537.115262523776, 4556.612687921497, 4579.129965306581, 4614.284785858197, 4626.86119416418, 4628.791704373244, 4649.86050418488, 4458.71018383804, 4628.935344870699, 5183.533481986639, 5184.611154163453, 5393.892122157535, 6277.905831412532, 6380.617162970237, 6536.934630653633, 6542.934570654233, 6631.137952066297, 1326.661701266171, 1401.9369128389246, 1532.869706074974, 1587.3650539784178, 1592.5938885584103, 935.9766005849772, 1033.607229252879, 1041.146260066753, 1045.4406892312577, 1066.1257768629648, 5140.537351638371, 5466.644668096561, 6090.756369745249, 6092.908606370819, 6152.507799376039, 5617.0, 6780.593164410151, 6810.182778066564, 6817.69320380584, 6824.556403833735, 5943.276449829587, 6021.307549631849, 6091.66495842724, 6100.267967843887, 6126.479249263863, 3528.206153615416, 3545.18460754028, 3565.3404120237838, 3598.208394153282, 3647.6899463545365, 6878.0, 7049.506534542636, 7058.54119482232, 7089.858202836018, 7117.537360071578, 6178.752849886044, 6874.968754686837, 6921.653917304115, 6972.198197207386, 6979.685914133876, 6479.930811416064, 6781.8643627127185, 7004.614746189009, 7143.642817859086, 7196.784096477009, 6319.52603554726, 6611.074449576967, 6632.668366581555, 6731.730730770911, 6767.729290828312, 5246.973765131303, 6068.4538391544975, 6555.947520710271, 6675.599464032173, 6712.758139743968, 6987.6855541499735, 7039.1553013638695, 7071.292870712888, 7077.6461176941975, 7105.609191494517, 3651.5253017108666, 4542.909141817079, 4583.816647334069, 4585.7019293747135, 4603.5396460353695, 5057.367829021372, 6200.883840908499, 6405.103285539935, 6570.967145164243, 6674.324526794226, 5714.085746280575, 5808.5643576732755, 6486.286508484157, 6487.935120648922, 6585.242697089896, 5600.411956744483, 6346.692168992839, 6542.953127499577, 6600.702968366339, 6710.865782684416, 5583.581231407579, 6423.261324947691, 6457.515686323639, 6467.482601391972, 6482.643454610042, 6597.967010164918, 6612.537122401386, 6642.933570664231, 6665.866682666417, 6683.665816709048, 5328.706921119376, 5683.403242659461, 6427.3251308611925, 6427.453666438405, 6460.25707043696], "value": 4734.8240632443185, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.2991643815773, 676.7191615479574, 735.3161559749433, 737.1854101218154, 804.4208170117521, 13900.235487048221, 14613.780793288095, 15019.32413041413, 15040.646341829219, 17139.82860171398, 15851.445199418024, 15872.603184920383, 15988.280527376266, 15988.520344389657, 15994.360225590992, 760.8326168243005, 926.6941909169991, 933.3793027636648, 933.9252859771202, 935.6584846531035, 718.5904034700224, 896.9461832290051, 926.7914719188162, 931.8788557487517, 934.6495064350869, 941.6421759731293, 970.3401686852937, 970.8446648536236, 975.7024107647164, 977.0, 892.1301730812406, 949.9715008549755, 960.490939801906, 971.130837900079, 974.3423189347233, 669.4878418010226, 718.683779137178, 721.6175427023686, 722.1406526233817, 725.314577724051, 15181.240937953058, 15291.388344466208, 15388.461403850923, 15401.306941187673, 15436.073835569901, 12331.753364932742, 12413.317267550281, 12487.687807804787, 12497.437615307334, 12735.426905789262, 9814.362066465728, 9911.0, 10011.0, 10200.48997550127, 10975.50610222542, 4043.8989025274605, 4193.643540299078, 4197.4753155855515, 4315.870523884289, 4335.89434694151, 80879.19120808775, 81944.77082843763, 82762.58618706868, 84612.0, 85398.0, 9286.540000592815, 9373.578188981512, 9417.293702972305, 9423.199028082552, 9537.904620953841, 20778.376648700563, 20871.0, 20966.95165241732, 21151.894240528698, 21165.576688466146, 7225.638718064076, 7365.410767138616, 7426.134299463964, 7467.887981680279, 7492.625368731542, 3881.223755248905, 3962.0689138052535, 4002.3396139637216, 4017.7176387724494, 4032.858849940238, 3529.911752206215, 3530.046887340404, 3627.2745450909397, 3627.3108109459117, 3640.890773276806, 591.6391001489088, 595.6366616364102, 602.6414283501309, 612.5161122713007, 624.569047357322, 525.5270256768862, 548.679022771683, 561.6152935239375, 580.2891457964045, 587.6885250817073, 6953.443724502028, 7533.1336896257635, 7581.786914093718, 7730.729424470116, 7752.147263800977, 540.1600511205114, 562.971851407428, 578.7181393214051, 581.0876923230487, 593.9910901336483, 3478.89563313101, 3717.981410092932, 3727.2172843703124, 3758.586555478895, 3799.335116354682, 69398.65300673465, 88702.0, 93276.53361733147, 95946.0, 95982.0, 79398.6030069846, 79660.80508792373, 79869.0, 79910.80133797998, 80866.0, 70587.64706176436, 71823.64088179526, 71904.64047679729, 72280.0, 73790.63104684443, 7280.3083707047745, 7299.817504562428, 7513.173550909505, 7531.548107113591, 7553.0, 37285.0, 37824.676136335096, 42431.575684242765, 43038.56961430346, 43318.0, 57974.0, 61259.69370153121, 61378.693106534185, 61787.691061546204, 61992.0, 9654.56554455037, 9705.902940970782, 9741.853872191781, 9777.951110244403, 10204.285700001226, 10586.206034547286, 10701.839472407764, 10903.563857445613, 11048.668539943814, 11450.825909843717, 10187.981201879753, 10388.324758890649, 10422.21833362516, 10432.165426765992, 10434.582616695247, 10059.49702514886, 10143.797124057624, 10371.58513659445, 10426.843597346198, 10438.060574548326, 8758.737237882873, 10151.390916545031, 10164.085232329126, 10379.06588407047, 10421.9478902605, 7118.644067796693, 8605.569721514024, 8647.654093836427, 8658.264047556027, 9124.483599621562, 8664.393492455467, 8717.869231961653, 8875.467471951704, 8893.822123557364, 9046.689715978388], "value": 6705.19583629664, "unit": "score"}], "name": "dromaeo_css", "value": 7298.906002496123, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 114.0, 116.0, 115.0, 128.0, 116.0, 117.0, 117.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 152.0, 142.0, 163.0, 129.0, 160.0, 183.0, 191.0, 158.0, 125.0], "value": 156.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [276.0, 268.0, 243.0, 187.0, 247.0, 287.0, 220.0, 199.0, 198.0, 200.0], "value": 232.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 69.0, 82.0, 136.0, 56.0, 51.0, 83.0, 58.0, 133.0, 68.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 127.0, 116.0, 120.0, 69.0, 159.0, 119.0, 112.0, 150.0], "value": 113.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 89.0, 88.0, 92.0, 74.0, 135.0, 88.0, 90.0, 87.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 115.0, 123.0, 97.0, 96.0, 96.0, 96.0], "value": 100.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 138.0, 77.0, 149.0, 150.0, 134.0, 90.0, 89.0, 91.0], "value": 110.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 62.0, 61.0, 61.0, 78.0, 64.0, 61.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 66.0, 71.0, 79.0, 72.0, 95.0, 93.0, 99.0, 81.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 107.0, 114.0, 111.0, 86.0, 82.0, 84.0, 84.0, 84.0, 81.0], "value": 93.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 140.0, 140.0, 140.0, 159.0, 173.0, 150.0, 144.0, 195.0, 183.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 181.0, 200.0, 171.0, 228.0, 237.0, 179.0, 174.0, 182.0, 175.0], "value": 189.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 68.0, 71.0, 69.0, 66.0, 74.0, 67.0, 59.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1651.4, "alertThreshold": 2.0}]} 19:58:04 INFO - Return code: 0 19:58:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:58:04 ERROR - # TBPL SUCCESS # 19:58:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:58:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:58:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:58:04 INFO - 2016-04-19 19:58:04.072 screenresolution[1981:14526] starting screenresolution argv=screenresolution get 19:58:04 INFO - 2016-04-19 19:58:04.074 screenresolution[1981:14526] Display 0: 1600x1200x32@60 19:58:04 INFO - 2016-04-19 19:58:04.080 screenresolution[1982:14529] starting screenresolution argv=screenresolution list 19:58:04 INFO - Available Modes on Display 0 19:58:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:58:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:58:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:58:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:58:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:58:04 INFO - Intel Iris: 19:58:04 INFO - Chipset Model: Intel Iris 19:58:04 INFO - Type: GPU 19:58:04 INFO - Bus: Built-In 19:58:04 INFO - VRAM (Dynamic, Max): 1536 MB 19:58:04 INFO - Vendor: Intel (0x8086) 19:58:04 INFO - Device ID: 0x0a2e 19:58:04 INFO - Revision ID: 0x0009 19:58:04 INFO - Displays: 19:58:04 INFO - Display: 19:58:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:58:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:58:04 INFO - Display Serial Number: 1600x1200 60 19:58:04 INFO - Main Display: Yes 19:58:04 INFO - Mirror: Off 19:58:04 INFO - Online: Yes 19:58:04 INFO - Rotation: Supported 19:58:04 INFO - Return code: 0 19:58:04 INFO - Running post-action listener: _resource_record_post_action 19:58:04 INFO - Running post-run listener: _resource_record_post_run 19:58:05 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 483328; Write bytes: 696351744; Read time: 10; Write time: 1761 19:58:05 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 377424384; Write bytes: 372205056; Read time: 28067; Write time: 643 19:58:05 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 471040; Write bytes: 298960384; Read time: 9; Write time: 1068 19:58:05 INFO - Running post-run listener: _upload_blobber_files 19:58:05 INFO - Blob upload gear active. 19:58:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:58:05 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 19:58:05 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:58:05 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:58:05 INFO - (blobuploader) - INFO - Open directory for files ... 19:58:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:58:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:58:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:58:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:58:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:58:07 INFO - (blobuploader) - INFO - Done attempting. 19:58:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:58:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:58:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:58:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:58:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:58:09 INFO - (blobuploader) - INFO - Done attempting. 19:58:09 INFO - (blobuploader) - INFO - Iteration through files over. 19:58:09 INFO - Return code: 0 19:58:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:58:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:58:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/819fd2c78249fe1741f2b87a97c349979b7e7585a649a068dec5fea0dd96c1527f01f9fe762b39f0c1277bd08c00258783578a924ff015978c736e47ce34073d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a60e0051155a24b1017d0e57e7981801320bc45773f8fccab79db7ed1722bad8056f0c75951d927232c2cb2b870c1984ba18662786c1bed58ec734a0d1fd19e1"} 19:58:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:58:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:58:09 INFO - Contents: 19:58:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/819fd2c78249fe1741f2b87a97c349979b7e7585a649a068dec5fea0dd96c1527f01f9fe762b39f0c1277bd08c00258783578a924ff015978c736e47ce34073d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a60e0051155a24b1017d0e57e7981801320bc45773f8fccab79db7ed1722bad8056f0c75951d927232c2cb2b870c1984ba18662786c1bed58ec734a0d1fd19e1"} 19:58:09 INFO - Running post-run listener: copy_logs_to_upload_dir 19:58:09 INFO - Copying logs to upload dir... 19:58:09 INFO - mkdir: /builds/slave/test/build/upload/logs 19:58:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.862381 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-04-19 19:58:09.229210) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 19:58:09.233096) ========= 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.VcmvkDRReS/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.pIoyruweuw/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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/Fx-Team/sha512/819fd2c78249fe1741f2b87a97c349979b7e7585a649a068dec5fea0dd96c1527f01f9fe762b39f0c1277bd08c00258783578a924ff015978c736e47ce34073d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a60e0051155a24b1017d0e57e7981801320bc45773f8fccab79db7ed1722bad8056f0c75951d927232c2cb2b870c1984ba18662786c1bed58ec734a0d1fd19e1"} build_url:https://queue.taskcluster.net/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010570 build_url: 'https://queue.taskcluster.net/v1/task/WRjFB5zlT6iONjM4i02uLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/819fd2c78249fe1741f2b87a97c349979b7e7585a649a068dec5fea0dd96c1527f01f9fe762b39f0c1277bd08c00258783578a924ff015978c736e47ce34073d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a60e0051155a24b1017d0e57e7981801320bc45773f8fccab79db7ed1722bad8056f0c75951d927232c2cb2b870c1984ba18662786c1bed58ec734a0d1fd19e1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 19:58:09.260886) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 19:58:09.261259) ========= 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.VcmvkDRReS/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.pIoyruweuw/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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.005301 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 19:58:09.312891) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 19:58:09.313466) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 19:58:09.314203) ========= ========= Total master_lag: 1.18 =========