builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0088 starttime: 1460676821.84 results: success (0) buildid: 20160414144949 builduid: 14c80def27a14174b4e5ddac95dfed06 revision: 159d0cb3c2c360ec38ff965a50a67fc2b5ab736b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 16:33:41.837344) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 16:33:41.837761) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 16:33:41.838034) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 16:33:41.858973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:33:41.859253) ========= 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.jHyzxlqDvm/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.NIHnznA2kK/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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-14 16:33:41-- 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% 11.5M=0.001s 2016-04-14 16:33:41 (11.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089512 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:33:41.968561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:33:41.968871) ========= 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.jHyzxlqDvm/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.NIHnznA2kK/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.026524 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:33:42.016747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 16:33:42.017052) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 159d0cb3c2c360ec38ff965a50a67fc2b5ab736b --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 159d0cb3c2c360ec38ff965a50a67fc2b5ab736b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jHyzxlqDvm/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.NIHnznA2kK/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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-14 16:33:42,093 truncating revision to first 12 chars 2016-04-14 16:33:42,093 Setting DEBUG logging. 2016-04-14 16:33:42,093 attempt 1/10 2016-04-14 16:33:42,093 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/159d0cb3c2c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 16:33:43,241 unpacking tar archive at: fx-team-159d0cb3c2c3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.392930 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 16:33:43.429213) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 16:33:43.432570) ========= script_repo_revision: 159d0cb3c2c360ec38ff965a50a67fc2b5ab736b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 16:33:43.432952) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 16:33:43.433213) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 16:33:43.446328) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-14 16:33:43.446628) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.jHyzxlqDvm/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.NIHnznA2kK/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 16:33:43 INFO - MultiFileLogger online at 20160414 16:33:43 in /builds/slave/test 16:33:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:33:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:33:43 INFO - {'append_to_log': False, 16:33:43 INFO - 'base_work_dir': '/builds/slave/test', 16:33:43 INFO - 'blob_upload_branch': 'Fx-Team', 16:33:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:33:43 INFO - 'branch': 'Fx-Team', 16:33:43 INFO - 'buildbot_json_path': 'buildprops.json', 16:33:43 INFO - 'config_files': ('talos/mac_config.py',), 16:33:43 INFO - 'default_actions': ('clobber', 16:33:43 INFO - 'read-buildbot-config', 16:33:43 INFO - 'download-and-extract', 16:33:43 INFO - 'populate-webroot', 16:33:43 INFO - 'create-virtualenv', 16:33:43 INFO - 'install', 16:33:43 INFO - 'run-tests'), 16:33:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:33:43 INFO - 'download_minidump_stackwalk': True, 16:33:43 INFO - 'download_symbols': 'ondemand', 16:33:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:33:43 INFO - 'tooltool.py': '/tools/tooltool.py', 16:33:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:33:43 INFO - '/tools/misc-python/virtualenv.py')}, 16:33:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:33:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:33:43 INFO - 'installer_path': 'installer.exe', 16:33:43 INFO - 'log_level': 'info', 16:33:43 INFO - 'log_name': 'talos', 16:33:43 INFO - 'log_to_console': True, 16:33:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:33:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:33:43 INFO - 'opt_config_files': (), 16:33:43 INFO - 'pip_index': False, 16:33:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:33:43 INFO - 'cmd': ('bash', 16:33:43 INFO - '-c', 16:33:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:33:43 INFO - 'enabled': True, 16:33:43 INFO - 'halt_on_failure': False, 16:33:43 INFO - 'name': 'check_screen_resolution'},), 16:33:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:33:43 INFO - 'cmd': ('bash', 16:33:43 INFO - '-c', 16:33:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:33:43 INFO - 'enabled': True, 16:33:43 INFO - 'halt_on_failure': False, 16:33:43 INFO - 'name': 'check_screen_resolution'},), 16:33:43 INFO - 'run_cmd_checks_enabled': True, 16:33:43 INFO - 'sps_profile': False, 16:33:43 INFO - 'sps_profile_interval': 0, 16:33:43 INFO - 'suite': 'dromaeojs', 16:33:43 INFO - 'system_bits': '32', 16:33:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:33:43 INFO - 'title': 't-yosemite-r7-0088', 16:33:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:33:43 INFO - 'use_talos_json': True, 16:33:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:33:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:33:43 INFO - 'work_dir': 'build'} 16:33:43 INFO - ##### 16:33:43 INFO - ##### Running clobber step. 16:33:43 INFO - ##### 16:33:43 INFO - Running pre-action listener: _resource_record_pre_action 16:33:43 INFO - Running main action method: clobber 16:33:43 INFO - rmtree: /builds/slave/test/build 16:33:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:33:45 INFO - Running post-action listener: _resource_record_post_action 16:33:45 INFO - ##### 16:33:45 INFO - ##### Running read-buildbot-config step. 16:33:45 INFO - ##### 16:33:45 INFO - Running pre-action listener: _resource_record_pre_action 16:33:45 INFO - Running main action method: read_buildbot_config 16:33:45 INFO - Using buildbot properties: 16:33:45 INFO - { 16:33:45 INFO - "project": "", 16:33:45 INFO - "product": "firefox", 16:33:45 INFO - "script_repo_revision": "production", 16:33:45 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 16:33:45 INFO - "repository": "", 16:33:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 16:33:45 INFO - "buildid": "20160414144949", 16:33:45 INFO - "pgo_build": "False", 16:33:45 INFO - "basedir": "/builds/slave/test", 16:33:45 INFO - "buildnumber": 722, 16:33:45 INFO - "slavename": "t-yosemite-r7-0088", 16:33:45 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:33:45 INFO - "platform": "yosemite_r7", 16:33:45 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:33:45 INFO - "branch": "fx-team", 16:33:45 INFO - "repo_path": "integration/fx-team", 16:33:45 INFO - "revision": "159d0cb3c2c360ec38ff965a50a67fc2b5ab736b", 16:33:45 INFO - "stage_platform": "macosx64", 16:33:45 INFO - "builduid": "14c80def27a14174b4e5ddac95dfed06", 16:33:45 INFO - "slavebuilddir": "test" 16:33:45 INFO - } 16:33:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 16:33:45 INFO - Running post-action listener: _resource_record_post_action 16:33:45 INFO - ##### 16:33:45 INFO - ##### Running download-and-extract step. 16:33:45 INFO - ##### 16:33:45 INFO - Running pre-action listener: _resource_record_pre_action 16:33:45 INFO - Running main action method: download_and_extract 16:33:45 INFO - mkdir: /builds/slave/test/build/tests 16:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:33:45 INFO - https://queue.taskcluster.net/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:33:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 16:33:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 16:33:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/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 16:33:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/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 16:33:46 INFO - Downloaded 1199 bytes. 16:33:46 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 16:33:46 INFO - Using the following test package requirements: 16:33:46 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 16:33:46 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:33:46 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 16:33:46 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:33:46 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 16:33:46 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:33:46 INFO - u'jsshell-mac.zip'], 16:33:46 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:33:46 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 16:33:46 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 16:33:46 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:33:46 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 16:33:46 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:33:46 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 16:33:46 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:33:46 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 16:33:46 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:33:46 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 16:33:46 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:33: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')]} 16:33:46 INFO - https://queue.taskcluster.net/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:33:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:33:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:33:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/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 16:33:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/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 16:33:48 INFO - Downloaded 18031206 bytes. 16:33:48 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'] 16:33:48 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 16:33:51 INFO - Return code: 0 16:33:51 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 16:33:51 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')]} 16:33:51 INFO - https://queue.taskcluster.net/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:33:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:33:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:33:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/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 16:33:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/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 16:33:53 INFO - Downloaded 18031206 bytes. 16:33:53 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'] 16:33:53 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 16:33:56 INFO - Return code: 0 16:33: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')]} 16:33:56 INFO - https://queue.taskcluster.net/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:33:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:33:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:33:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/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 16:33:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/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 16:33:58 INFO - Downloaded 10841076 bytes. 16:33:58 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'] 16:33:58 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 16:33:58 INFO - Return code: 0 16:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:33:58 INFO - https://queue.taskcluster.net/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:33:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:33:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:33:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 16:33:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RsCum-53QiqcsL7WFVVdrA/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 16:34:01 INFO - Downloaded 109836258 bytes. 16:34:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:34:01 INFO - mkdir: /builds/slave/test/properties 16:34:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:34:01 INFO - Writing to file /builds/slave/test/properties/build_url 16:34:01 INFO - Contents: 16:34:01 INFO - build_url:https://queue.taskcluster.net/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:34:02 INFO - Running post-action listener: _resource_record_post_action 16:34:02 INFO - Running post-action listener: set_extra_try_arguments 16:34:02 INFO - ##### 16:34:02 INFO - ##### Running populate-webroot step. 16:34:02 INFO - ##### 16:34:02 INFO - Running pre-action listener: _resource_record_pre_action 16:34:02 INFO - Running main action method: populate_webroot 16:34:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:34:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:34:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:34:02 INFO - '--tppagecycles', 16:34:02 INFO - '7'], 16:34:02 INFO - 'tests': ['tsvgm']}}, 16:34:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:34:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:34:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:34:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:34:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:34:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:34:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:02 INFO - 'talos_options': ['--disable-e10s'], 16:34:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:34:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:34:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:02 INFO - 'talos_options': ['--disable-e10s'], 16:34:02 INFO - 'tests': ['damp', 'tps']}, 16:34:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:02 INFO - 'tests': ['damp', 'tps']}, 16:34:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:34:02 INFO - 'tests': ['dromaeo_dom']}, 16:34:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:34:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:34:02 INFO - 'tests': ['a11yr', 16:34:02 INFO - 'ts_paint', 16:34:02 INFO - 'tpaint', 16:34:02 INFO - 'sessionrestore', 16:34:02 INFO - 'sessionrestore_no_auto_restore', 16:34:02 INFO - 'tabpaint']}, 16:34:02 INFO - 'other-e10s': {'tests': ['a11yr', 16:34:02 INFO - 'ts_paint', 16:34:02 INFO - 'tpaint', 16:34:02 INFO - 'sessionrestore', 16:34:02 INFO - 'sessionrestore_no_auto_restore', 16:34:02 INFO - 'tabpaint']}, 16:34:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:34:02 INFO - 'ts_paint', 16:34:02 INFO - 'tpaint', 16:34:02 INFO - 'sessionrestore', 16:34:02 INFO - 'sessionrestore_no_auto_restore', 16:34:02 INFO - 'tabpaint']}, 16:34:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:34:02 INFO - 'ts_paint', 16:34:02 INFO - 'tpaint', 16:34:02 INFO - 'sessionrestore', 16:34:02 INFO - 'sessionrestore_no_auto_restore', 16:34:02 INFO - 'tabpaint']}, 16:34:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:34:02 INFO - 'tests': ['a11yr', 16:34:02 INFO - 'ts_paint', 16:34:02 INFO - 'tpaint', 16:34:02 INFO - 'sessionrestore', 16:34:02 INFO - 'sessionrestore_no_auto_restore', 16:34:02 INFO - 'tabpaint']}, 16:34:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:34:02 INFO - 'tests': ['a11yr', 16:34:02 INFO - 'ts_paint', 16:34:02 INFO - 'tpaint', 16:34:02 INFO - 'sessionrestore', 16:34:02 INFO - 'sessionrestore_no_auto_restore', 16:34:02 INFO - 'tabpaint']}, 16:34:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:34:02 INFO - 'tests': ['tsvgx', 16:34:02 INFO - 'tsvgr_opacity', 16:34:02 INFO - 'tart', 16:34:02 INFO - 'tscrollx', 16:34:02 INFO - 'cart']}, 16:34:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:34:02 INFO - 'tsvgr_opacity', 16:34:02 INFO - 'tart', 16:34:02 INFO - 'tscrollx', 16:34:02 INFO - 'cart']}, 16:34:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:02 INFO - 'talos_options': ['--disable-e10s'], 16:34:02 INFO - 'tests': ['tp5o']}, 16:34:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:02 INFO - 'tests': ['tp5o']}, 16:34:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:02 INFO - 'talos_options': ['--disable-e10s', 16:34:02 INFO - '--xperf_path', 16:34:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:34:02 INFO - 'tests': ['tp5n']}, 16:34:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:02 INFO - 'talos_options': ['--xperf_path', 16:34:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:34:02 INFO - 'tests': ['tp5n']}}, 16:34:02 INFO - 'talos.zip': {'path': '', 16:34:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:34:02 INFO - Running post-action listener: _resource_record_post_action 16:34:02 INFO - ##### 16:34:02 INFO - ##### Running create-virtualenv step. 16:34:02 INFO - ##### 16:34:02 INFO - Running pre-action listener: _resource_record_pre_action 16:34:02 INFO - Running main action method: create_virtualenv 16:34:02 INFO - Creating virtualenv /builds/slave/test/build/venv 16:34:02 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 16:34:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:34:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:34:03 INFO - Using real prefix '/tools/python27' 16:34:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:34:03 INFO - Installing distribute.............................................................................................................................................................................................done. 16:34:06 INFO - Installing pip.................done. 16:34:06 INFO - Return code: 0 16:34:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:34:06 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')]} 16:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:06 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')]} 16:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:06 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 0x10d5d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d249d2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d477e00>, '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 0x10d2a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d472b20>, '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.jHyzxlqDvm/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.NIHnznA2kK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 16:34:06 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 16:34:06 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 16:34:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jHyzxlqDvm/Render', 16:34:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:06 INFO - 'HOME': '/Users/cltbld', 16:34:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:06 INFO - 'LOGNAME': 'cltbld', 16:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:06 INFO - 'MOZ_NO_REMOTE': '1', 16:34:06 INFO - 'NO_EM_RESTART': '1', 16:34:06 INFO - 'PAGER': '/bin/cat', 16:34:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:06 INFO - 'PWD': '/builds/slave/test', 16:34:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:06 INFO - 'SHELL': '/bin/bash', 16:34:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NIHnznA2kK/Listeners', 16:34:06 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 16:34:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:06 INFO - 'USER': 'cltbld', 16:34:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:06 INFO - 'XPC_FLAGS': '0x0', 16:34:06 INFO - 'XPC_SERVICE_NAME': '0', 16:34:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:06 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 16:34:06 INFO - Cleaning up... 16:34:06 INFO - Return code: 0 16:34:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:34:06 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')]} 16:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:06 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')]} 16:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:06 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 0x10d5d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d249d2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d477e00>, '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 0x10d2a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d472b20>, '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.jHyzxlqDvm/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.NIHnznA2kK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 16:34:06 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 16:34:06 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 16:34:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jHyzxlqDvm/Render', 16:34:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:06 INFO - 'HOME': '/Users/cltbld', 16:34:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:06 INFO - 'LOGNAME': 'cltbld', 16:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:06 INFO - 'MOZ_NO_REMOTE': '1', 16:34:06 INFO - 'NO_EM_RESTART': '1', 16:34:06 INFO - 'PAGER': '/bin/cat', 16:34:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:06 INFO - 'PWD': '/builds/slave/test', 16:34:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:06 INFO - 'SHELL': '/bin/bash', 16:34:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NIHnznA2kK/Listeners', 16:34:06 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 16:34:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:06 INFO - 'USER': 'cltbld', 16:34:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:06 INFO - 'XPC_FLAGS': '0x0', 16:34:06 INFO - 'XPC_SERVICE_NAME': '0', 16:34:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:07 INFO - Downloading/unpacking psutil>=0.7.1 16:34:07 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 16:34:07 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 16:34:07 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 16:34:07 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 16:34:07 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 16:34:07 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 16:34:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:34:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:34:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:34:10 INFO - Installing collected packages: psutil 16:34:10 INFO - Running setup.py install for psutil 16:34:10 INFO - building 'psutil._psutil_osx' extension 16:34:10 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 16:34:10 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 16:34:10 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 16:34:10 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 16:34:11 INFO - building 'psutil._psutil_posix' extension 16:34:11 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 16:34:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:34:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:34:11 INFO - ^ 16:34:11 INFO - 1 warning generated. 16:34:11 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 16:34:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:34:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:34:11 INFO - Successfully installed psutil 16:34:11 INFO - Cleaning up... 16:34:11 INFO - Return code: 0 16:34:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d5d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d249d2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d477e00>, '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 0x10d2a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d472b20>, '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.jHyzxlqDvm/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.NIHnznA2kK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 16:34:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:34:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jHyzxlqDvm/Render', 16:34:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:11 INFO - 'HOME': '/Users/cltbld', 16:34:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:11 INFO - 'LOGNAME': 'cltbld', 16:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:11 INFO - 'MOZ_NO_REMOTE': '1', 16:34:11 INFO - 'NO_EM_RESTART': '1', 16:34:11 INFO - 'PAGER': '/bin/cat', 16:34:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:11 INFO - 'PWD': '/builds/slave/test', 16:34:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:11 INFO - 'SHELL': '/bin/bash', 16:34:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NIHnznA2kK/Listeners', 16:34:11 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 16:34:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:11 INFO - 'USER': 'cltbld', 16:34:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:11 INFO - 'XPC_FLAGS': '0x0', 16:34:11 INFO - 'XPC_SERVICE_NAME': '0', 16:34:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:34:14 INFO - Installing collected packages: mozsystemmonitor 16:34:14 INFO - Running setup.py install for mozsystemmonitor 16:34:14 INFO - Successfully installed mozsystemmonitor 16:34:14 INFO - Cleaning up... 16:34:14 INFO - Return code: 0 16:34:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:34:14 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')]} 16:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:14 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')]} 16:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:14 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 0x10d5d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d249d2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d477e00>, '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 0x10d2a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d472b20>, '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.jHyzxlqDvm/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.NIHnznA2kK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 16:34:14 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 16:34:14 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 16:34:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jHyzxlqDvm/Render', 16:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:14 INFO - 'HOME': '/Users/cltbld', 16:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:14 INFO - 'LOGNAME': 'cltbld', 16:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:14 INFO - 'MOZ_NO_REMOTE': '1', 16:34:14 INFO - 'NO_EM_RESTART': '1', 16:34:14 INFO - 'PAGER': '/bin/cat', 16:34:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:14 INFO - 'PWD': '/builds/slave/test', 16:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:14 INFO - 'SHELL': '/bin/bash', 16:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NIHnznA2kK/Listeners', 16:34:14 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 16:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:14 INFO - 'USER': 'cltbld', 16:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:14 INFO - 'XPC_FLAGS': '0x0', 16:34:14 INFO - 'XPC_SERVICE_NAME': '0', 16:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:14 INFO - Downloading/unpacking blobuploader==1.2.4 16:34:14 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 16:34:14 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 16:34:14 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 16:34:14 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 16:34:14 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 16:34:14 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 16:34:17 INFO - Downloading blobuploader-1.2.4.tar.gz 16:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:34:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:34:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:18 INFO - Downloading docopt-0.6.1.tar.gz 16:34:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:34:18 INFO - Installing collected packages: blobuploader, requests, docopt 16:34:18 INFO - Running setup.py install for blobuploader 16:34:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:34:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:34:18 INFO - Running setup.py install for requests 16:34:19 INFO - Running setup.py install for docopt 16:34:19 INFO - Successfully installed blobuploader requests docopt 16:34:19 INFO - Cleaning up... 16:34:19 INFO - Return code: 0 16:34:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:19 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 0x10d5d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d249d2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d477e00>, '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 0x10d2a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d472b20>, '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.jHyzxlqDvm/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.NIHnznA2kK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 16:34:19 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 16:34:19 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 16:34:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jHyzxlqDvm/Render', 16:34:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:19 INFO - 'HOME': '/Users/cltbld', 16:34:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:19 INFO - 'LOGNAME': 'cltbld', 16:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:19 INFO - 'MOZ_NO_REMOTE': '1', 16:34:19 INFO - 'NO_EM_RESTART': '1', 16:34:19 INFO - 'PAGER': '/bin/cat', 16:34:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:19 INFO - 'PWD': '/builds/slave/test', 16:34:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:19 INFO - 'SHELL': '/bin/bash', 16:34:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NIHnznA2kK/Listeners', 16:34:19 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 16:34:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:19 INFO - 'USER': 'cltbld', 16:34:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:19 INFO - 'XPC_FLAGS': '0x0', 16:34:19 INFO - 'XPC_SERVICE_NAME': '0', 16:34:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:34:19 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-HbBO8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:34:19 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-mnMNjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:34:19 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-uPTNmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:34:19 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-MQOm4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:34:19 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-RMZF7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:34:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-p2vfsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:34:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-8q7ZkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:34:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-t_8PuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:34:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-W16QAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:34:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-D3coPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:34:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-VCWc63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:34:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-HAR0DS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:34:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-wpLdB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:34:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-jx8iiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-JLQHMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:34:21 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-_oMwe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:34:21 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-61U8dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:34:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:34:21 INFO - Running setup.py install for manifestparser 16:34:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:34:21 INFO - Running setup.py install for mozcrash 16:34:21 INFO - Running setup.py install for mozdebug 16:34:21 INFO - Running setup.py install for mozdevice 16:34:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:34:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:34:21 INFO - Running setup.py install for mozfile 16:34:22 INFO - Running setup.py install for mozhttpd 16:34:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:34:22 INFO - Running setup.py install for mozinfo 16:34:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:34:22 INFO - Running setup.py install for mozInstall 16:34:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:34:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:34:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:34:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:34:22 INFO - Running setup.py install for mozleak 16:34:22 INFO - Running setup.py install for mozlog 16:34:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:34:22 INFO - Running setup.py install for moznetwork 16:34:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:34:22 INFO - Running setup.py install for mozprocess 16:34:23 INFO - Running setup.py install for mozprofile 16:34:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:34:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:34:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:34:23 INFO - Running setup.py install for mozrunner 16:34:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:34:23 INFO - Running setup.py install for mozscreenshot 16:34:23 INFO - Running setup.py install for moztest 16:34:23 INFO - Running setup.py install for mozversion 16:34:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:34:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:34:23 INFO - Cleaning up... 16:34:23 INFO - Return code: 0 16:34:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:23 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 0x10d5d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d249d2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d477e00>, '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 0x10d2a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d472b20>, '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.jHyzxlqDvm/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.NIHnznA2kK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 16:34:23 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 16:34:23 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 16:34:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jHyzxlqDvm/Render', 16:34:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:23 INFO - 'HOME': '/Users/cltbld', 16:34:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:23 INFO - 'LOGNAME': 'cltbld', 16:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:23 INFO - 'MOZ_NO_REMOTE': '1', 16:34:23 INFO - 'NO_EM_RESTART': '1', 16:34:23 INFO - 'PAGER': '/bin/cat', 16:34:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:23 INFO - 'PWD': '/builds/slave/test', 16:34:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:23 INFO - 'SHELL': '/bin/bash', 16:34:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NIHnznA2kK/Listeners', 16:34:23 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 16:34:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:23 INFO - 'USER': 'cltbld', 16:34:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:23 INFO - 'XPC_FLAGS': '0x0', 16:34:23 INFO - 'XPC_SERVICE_NAME': '0', 16:34:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:34:24 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-aNAwsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:34:24 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)) 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:34:24 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-FgIYYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:34:24 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)) 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:34:24 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-O4eFPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:34:24 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)) 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:34:24 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-OU1iQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:34:24 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)) 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:34:24 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-bVQzj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:34:24 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)) 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:34:24 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-_pop5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:34:24 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)) 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:34:24 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-sIvGfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:34:24 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)) 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:34:24 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Cmbaur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:34:24 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)) 16:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:34:24 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-OlWEwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:34:25 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-rlj0Xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:34:25 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Uix1aK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:34:25 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-srbjm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:34:25 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-2CQ0wL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:34:25 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-XGNjbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:25 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-x6igCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:34:25 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-H9HkVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:34:25 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)) 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:34:25 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-EUUHFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:34:25 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)) 16:34:25 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)) 16:34:25 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)) 16:34:25 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)) 16:34:25 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)) 16:34:25 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)) 16:34:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:34:25 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 16:34:25 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 16:34:25 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 16:34:25 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 16:34:25 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 16:34:25 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 16:34:28 INFO - Downloading blessings-1.6.tar.gz 16:34:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:34:28 INFO - Installing collected packages: blessings 16:34:28 INFO - Running setup.py install for blessings 16:34:28 INFO - Successfully installed blessings 16:34:28 INFO - Cleaning up... 16:34:28 INFO - Return code: 0 16:34:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:34:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:34:29 INFO - Reading from file tmpfile_stdout 16:34:29 INFO - Current package versions: 16:34:29 INFO - blessings == 1.6 16:34:29 INFO - blobuploader == 1.2.4 16:34:29 INFO - docopt == 0.6.1 16:34:29 INFO - manifestparser == 1.1 16:34:29 INFO - mozInstall == 1.12 16:34:29 INFO - mozcrash == 0.17 16:34:29 INFO - mozdebug == 0.1 16:34:29 INFO - mozdevice == 0.48 16:34:29 INFO - mozfile == 1.2 16:34:29 INFO - mozhttpd == 0.7 16:34:29 INFO - mozinfo == 0.9 16:34:29 INFO - mozleak == 0.1 16:34:29 INFO - mozlog == 3.1 16:34:29 INFO - moznetwork == 0.27 16:34:29 INFO - mozprocess == 0.22 16:34:29 INFO - mozprofile == 0.28 16:34:29 INFO - mozrunner == 6.11 16:34:29 INFO - mozscreenshot == 0.1 16:34:29 INFO - mozsystemmonitor == 0.0 16:34:29 INFO - moztest == 0.7 16:34:29 INFO - mozversion == 1.4 16:34:29 INFO - psutil == 3.1.1 16:34:29 INFO - requests == 1.2.3 16:34:29 INFO - wsgiref == 0.1.2 16:34:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34: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')]} 16:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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')]} 16:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:29 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 0x10d5d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d249d2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d477e00>, '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 0x10d2a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d472b20>, '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.jHyzxlqDvm/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.NIHnznA2kK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 16:34:29 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 16:34:29 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 16:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jHyzxlqDvm/Render', 16:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:29 INFO - 'HOME': '/Users/cltbld', 16:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:29 INFO - 'LOGNAME': 'cltbld', 16:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:29 INFO - 'MOZ_NO_REMOTE': '1', 16:34:29 INFO - 'NO_EM_RESTART': '1', 16:34:29 INFO - 'PAGER': '/bin/cat', 16:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:29 INFO - 'PWD': '/builds/slave/test', 16:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:29 INFO - 'SHELL': '/bin/bash', 16:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NIHnznA2kK/Listeners', 16:34:29 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 16:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:29 INFO - 'USER': 'cltbld', 16:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:29 INFO - 'XPC_FLAGS': '0x0', 16:34:29 INFO - 'XPC_SERVICE_NAME': '0', 16:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 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)) 16:34:29 INFO - Cleaning up... 16:34:29 INFO - Return code: 0 16:34:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:34: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')]} 16:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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')]} 16:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d249d2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d477e00>, '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 0x10d2a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d472b20>, '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.jHyzxlqDvm/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.NIHnznA2kK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 16:34: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', 'jsonschema'] in /builds/slave/test/build 16:34: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 jsonschema 16:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jHyzxlqDvm/Render', 16:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:29 INFO - 'HOME': '/Users/cltbld', 16:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:29 INFO - 'LOGNAME': 'cltbld', 16:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:29 INFO - 'MOZ_NO_REMOTE': '1', 16:34:29 INFO - 'NO_EM_RESTART': '1', 16:34:29 INFO - 'PAGER': '/bin/cat', 16:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:29 INFO - 'PWD': '/builds/slave/test', 16:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:29 INFO - 'SHELL': '/bin/bash', 16:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NIHnznA2kK/Listeners', 16:34:29 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 16:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:29 INFO - 'USER': 'cltbld', 16:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:29 INFO - 'XPC_FLAGS': '0x0', 16:34:29 INFO - 'XPC_SERVICE_NAME': '0', 16:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:29 INFO - Downloading/unpacking jsonschema 16:34: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 16:34: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 16:34: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 16:34: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 16:34: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 16:34: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 16:34:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:34:32 INFO - Downloading/unpacking functools32 (from jsonschema) 16:34: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 16:34: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 16:34: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 16:34: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 16:34: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 16:34: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 16:34:32 INFO - Downloading functools32-3.2.3-2.tar.gz 16:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:34:32 INFO - warning: no files found matching '*.txt' 16:34:32 INFO - no previously-included directories found matching 'build' 16:34:32 INFO - no previously-included directories found matching 'dist' 16:34:32 INFO - no previously-included directories found matching '.git*' 16:34:32 INFO - Installing collected packages: jsonschema, functools32 16:34:32 INFO - Running setup.py install for functools32 16:34:32 INFO - warning: no files found matching '*.txt' 16:34:32 INFO - no previously-included directories found matching 'build' 16:34:32 INFO - no previously-included directories found matching 'dist' 16:34:32 INFO - no previously-included directories found matching '.git*' 16:34:32 INFO - Successfully installed jsonschema functools32 16:34:32 INFO - Cleaning up... 16:34:32 INFO - Return code: 0 16:34:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:34: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')]} 16:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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')]} 16:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d249d2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d477e00>, '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 0x10d2a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d472b20>, '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.jHyzxlqDvm/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.NIHnznA2kK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 16:34: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', 'flake8'] in /builds/slave/test/build 16:34: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 flake8 16:34:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jHyzxlqDvm/Render', 16:34:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:32 INFO - 'HOME': '/Users/cltbld', 16:34:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:32 INFO - 'LOGNAME': 'cltbld', 16:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:32 INFO - 'MOZ_NO_REMOTE': '1', 16:34:32 INFO - 'NO_EM_RESTART': '1', 16:34:32 INFO - 'PAGER': '/bin/cat', 16:34:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:32 INFO - 'PWD': '/builds/slave/test', 16:34:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:32 INFO - 'SHELL': '/bin/bash', 16:34:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NIHnznA2kK/Listeners', 16:34:32 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 16:34:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:32 INFO - 'USER': 'cltbld', 16:34:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:32 INFO - 'XPC_FLAGS': '0x0', 16:34:32 INFO - 'XPC_SERVICE_NAME': '0', 16:34:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:33 INFO - Downloading/unpacking flake8 16:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:34:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:34: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 16:34: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 16:34: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 16:34: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 16:34: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 16:34: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 16:34:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:34:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:34:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:34:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:34:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:34:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:34:36 INFO - no previously-included directories found matching 'docs/_build' 16:34:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:34:37 INFO - Running setup.py install for pep8 16:34:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:34:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:34:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:34:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:34:37 INFO - no previously-included directories found matching 'docs/_build' 16:34:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:34:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:34:37 INFO - Cleaning up... 16:34:37 INFO - Return code: 0 16:34:37 INFO - Running post-action listener: _resource_record_post_action 16:34:37 INFO - Running post-action listener: _start_resource_monitoring 16:34:37 INFO - Starting resource monitoring. 16:34:37 INFO - ##### 16:34:37 INFO - ##### Running install step. 16:34:37 INFO - ##### 16:34:37 INFO - Running pre-action listener: _resource_record_pre_action 16:34:37 INFO - Running main action method: install 16:34:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:34:37 INFO - Reading from file tmpfile_stdout 16:34:37 INFO - Detecting whether we're running mozinstall >=1.0... 16:34:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:34:37 INFO - Reading from file tmpfile_stdout 16:34:37 INFO - Output received: 16:34:37 INFO - Usage: mozinstall [options] installer 16:34:37 INFO - Options: 16:34:37 INFO - -h, --help show this help message and exit 16:34:37 INFO - -d DEST, --destination=DEST 16:34:37 INFO - Directory to install application into. [default: 16:34:37 INFO - "/builds/slave/test"] 16:34:37 INFO - --app=APP Application being installed. [default: firefox] 16:34:37 INFO - mkdir: /builds/slave/test/build/application 16:34:37 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'] 16:34:37 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 16:35:10 INFO - Reading from file tmpfile_stdout 16:35:10 INFO - Output received: 16:35:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:35:10 INFO - Running post-action listener: _resource_record_post_action 16:35:10 INFO - ##### 16:35:10 INFO - ##### Running run-tests step. 16:35:10 INFO - ##### 16:35:10 INFO - Running pre-action listener: _resource_record_pre_action 16:35:10 INFO - Running main action method: run_tests 16:35:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:35:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:35:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:35:10 INFO - 2016-04-14 16:35:10.749 screenresolution[1641:7654] starting screenresolution argv=screenresolution get 16:35:10 INFO - 2016-04-14 16:35:10.752 screenresolution[1641:7654] Display 0: 1600x1200x32@60 16:35:10 INFO - 2016-04-14 16:35:10.758 screenresolution[1642:7656] starting screenresolution argv=screenresolution list 16:35:10 INFO - Available Modes on Display 0 16:35:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:35:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:35:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:35:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:35:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:35:10 INFO - Intel Iris: 16:35:10 INFO - Chipset Model: Intel Iris 16:35:10 INFO - Type: GPU 16:35:10 INFO - Bus: Built-In 16:35:10 INFO - VRAM (Dynamic, Max): 1536 MB 16:35:10 INFO - Vendor: Intel (0x8086) 16:35:10 INFO - Device ID: 0x0a2e 16:35:10 INFO - Revision ID: 0x0009 16:35:10 INFO - Displays: 16:35:10 INFO - Display: 16:35:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:35:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:35:10 INFO - Display Serial Number: 1600x1200 60 16:35:10 INFO - Main Display: Yes 16:35:10 INFO - Mirror: Off 16:35:10 INFO - Online: Yes 16:35:10 INFO - Rotation: Supported 16:35:10 INFO - Return code: 0 16:35:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:35:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:35:10 INFO - Python 2.7.3 16:35:10 INFO - Return code: 0 16:35:10 INFO - grabbing minidump binary from tooltool 16:35:10 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')]} 16:35:10 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 0x10d477e00>, '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 0x10d2a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d472b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:35:10 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 16:35:10 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 16:35:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:35:11 INFO - Return code: 0 16:35:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:35:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:35:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:35:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:35:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:35:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:35:12 INFO - Return code: 0 16:35:12 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:35:12 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0088 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:35:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jHyzxlqDvm/Render', 16:35:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:12 INFO - 'HOME': '/Users/cltbld', 16:35:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:12 INFO - 'LOGNAME': 'cltbld', 16:35:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:35:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:12 INFO - 'MOZ_NO_REMOTE': '1', 16:35:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:35:12 INFO - 'NO_EM_RESTART': '1', 16:35:12 INFO - 'PAGER': '/bin/cat', 16:35:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:12 INFO - 'PWD': '/builds/slave/test', 16:35:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:35:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:12 INFO - 'SHELL': '/bin/bash', 16:35:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NIHnznA2kK/Listeners', 16:35:12 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 16:35:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:12 INFO - 'USER': 'cltbld', 16:35:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:12 INFO - 'XPC_FLAGS': '0x0', 16:35:12 INFO - 'XPC_SERVICE_NAME': '0', 16:35:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:35:12 INFO - mozversion application_buildid: 20160414144949 16:35:12 INFO - mozversion application_changeset: 159d0cb3c2c360ec38ff965a50a67fc2b5ab736b 16:35:12 INFO - mozversion application_display_name: Nightly 16:35:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:35:12 INFO - mozversion application_name: Firefox 16:35:12 INFO - mozversion application_remotingname: firefox 16:35:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:35:12 INFO - mozversion application_vendor: Mozilla 16:35:12 INFO - mozversion application_version: 48.0a1 16:35:12 INFO - mozversion platform_buildid: 20160414144949 16:35:12 INFO - mozversion platform_changeset: 159d0cb3c2c360ec38ff965a50a67fc2b5ab736b 16:35:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:35:12 INFO - mozversion platform_version: 48.0a1 16:35:12 INFO - using testdate: 1460676912 16:35:12 INFO - actual date: 1460676912 16:35:12 INFO - starting webserver on 'localhost:49280' 16:35:12 INFO - SUITE-START | Running 2 tests 16:35:12 INFO - TEST-START | dromaeo_css 16:35:12 INFO - operating with platform_type : mac_ 16:35:12 INFO - Initialising browser for dromaeo_css test... 16:35:12 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmparL1St/profile http://localhost:49280/getInfo.html) 16:35:14 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 16:35:14 INFO - PROCESS | 1660 | colorDepth:24 16:35:14 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 16:35:14 INFO - PROCESS | 1660 | __metrics 16:35:15 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:35:15 ERROR - PROCESS | 1660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:35:15 INFO - TEST-INFO | 1660: exit 0 16:35:15 INFO - Browser initialized. 16:35:15 INFO - Running cycle 1/1 for dromaeo_css test... 16:35:15 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmparL1St/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:35:27 INFO - PROCESS | 1662 | RSS: Main: 237572096 16:35:27 INFO - PROCESS | 1662 | 16:36:18 INFO - PROCESS | 1662 | 1460676978372 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] 16:38:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 16:38:30 INFO - PROCESS | 1662 | RSS: Main: 379572224 16:38:30 INFO - PROCESS | 1662 | 16:41:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 16:41:34 INFO - PROCESS | 1662 | RSS: Main: 376541184 16:41:34 INFO - PROCESS | 1662 | 16:44:36 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 16:44:36 INFO - PROCESS | 1662 | RSS: Main: 377888768 16:44:36 INFO - PROCESS | 1662 | 16:47:38 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 16:47:39 INFO - PROCESS | 1662 | RSS: Main: 377356288 16:47:39 INFO - PROCESS | 1662 | 16:50:42 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 16:50:43 INFO - PROCESS | 1662 | RSS: Main: 355241984 16:50:43 INFO - PROCESS | 1662 | 16:53:46 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 16:53:46 INFO - PROCESS | 1662 | RSS: Main: 383565824 16:53:46 INFO - PROCESS | 1662 | 16:53:46 INFO - PROCESS | 1662 | __start_tp_report 16:53:46 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 16:53:46 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 16:53:46 INFO - PROCESS | 1662 | |i|pagename|runs| 16:53:46 INFO - PROCESS | 1662 | |0;dojo.html;3339.4656854903214;3400.2859399526114;3437.9484307735374;3438.8651744924177;3463.2034632034633;5376.91934620981;5470.425605311445;5546.362168350641;5553.22254884316;5554.72226388681;4595.655325850566;5588.832335029945;5653.4911857932775;5702.201691763156;5719.428057194278;4995.5753760930365;5009.223570346584;5047.9747601262125;5058.342415485981;5215.478452154774;5130.281760553526;5170.095233334151;5180.896382072357;5189.8183563575285;5250.684958902459;4965.677230979993;5071.087204303224;5092.414372347191;5112.284280200774;5116.667416617908;5029.522195391469;5066.594672426197;5092.236164575306;5096.643234973553;5107.7446127693465;4977.079240340512;5057.747112644353;5058.342415485963;5076.796928122908;5126.231065340192;5461.808836690737;5462.989346970823;5483.040467918138;5490.945090549083;5493.093639549469;5990.64056156632;6063.761734033555;6093.756249750049;6109.114178444101;6113.938860611382;6094.803649345489;6112.388761123896;6175.135481032614;6179.227596550431;6192.752289908398;5709.058005429058;5709.115087161455;5711.371749107595;5711.885762284731;5749.281339832521;6112.541559383064;6153.4154255345675;6199.659018753921;6223.284322302902;6232.563720539519;5936;6041.667708276087;6053.213082299273;6059.182010428536;6059.36376680451;6129.55005433648;6160.414760597736;6161.199044124325;6181.196444462191;6183.412575805291;5910.8817823643285;6095.414267386731;6096.664683442454;6106.969465152734;6130.2146971548445;6026.758929642853;6085.2393450818645;6103.42017508336;6112.572119951649;6118.0211166214085;4847.3698419205275;4850;4858.44127925286;4859.781309841065;4864.586510146606;4298.505671847715;4313.158934007838;4391.8462853799965;4398.164348773723;4428.955710442919;5568.359638641527;5571.582131340166;5627.943720562742;5635.3519345275;5641.717914104278;6071.817845464643;6144.556029333103;6162.445379915829;6172.969135154385;6201.503879689614;5543.861403464945;5545.057340252167;5554.72226388679;5554.972225138848;5589.944100559023;5280.996610643965;5307.363116426053;5355.169948657965;5358.678479291255;5365.302510673666;5155.896882062413;6200.348963358872;6214.875702486015;6258.030005349178;6283.434490895841;6163.075538669056;6193.473554747897;6198.969005154945;6213.1922850029205;6215.564910456224;6164.229471316085;6236.220472440945;6240.500759939285;6258.342873998165;6270.435660790551;6041.214642096499;6112.777056696867;6126.181801870855;6139.338817383189;6139.553468857593;6161.969190154021;6175.042868355412;6180.66006369636;6183.659898705434;6189.5048396129105;5875.236219291465;5951.285845698544;6021.789237376671;6029.969850150721;6087.482563982111;5958.970205148947;5967.791127310524;5981.312149102909;6001.219841420762;6048.697565121638;5663.3770285267765;5856.267966504187;5856.560757943256;5861.560382971209;5908.675022873783;5801.593888427769;6011.458968692838;6036.9698151508965;6060.939390606038;6077.179580756541;5885.823425297248;5910.349861515316;5912.320083190316;5914.526837853047;5917.5857689961285 16:53:46 INFO - PROCESS | 1662 | |1;ext.html;474.17493561203514;502.494992532505;525.613673949647;542.0487045235611;585.7188549496244;29370;29647;35747.82126089369;38903.80548097256;39093.80453097731;40763.79618101913;41295.17409651805;41430.58569414305;41463;41562.16875662485;8783.604737786798;9593.328467007312;9595.23238140947;9600.03999600038;9606.855897161513;9402.38884472507;9538.618455261781;9543.284253681002;9550.474723890184;9552.331336806426;9487.24102071836;9579.856302155473;9622.711318660451;9642.75893102671;9699.321047526675;9545.713628591118;9599.280053995908;9613.942466328699;9614.375065620712;9619.374740641906;9401.24790016797;9476.668316608955;9491.955884852661;9494.572744226527;9510.572024258925;39522.40716389257;39924;39999.80000099981;40005.39991900124;40076.79961600203;3187.952180717291;3404.3021180657906;3416.8804091856914;3779.7543159694533;3802.068493219151;27850;29291.681874315705;29340.853295733385;29411.411771764444;29434.852825735736;2444.3033735385507;2544.745525447459;2847.957280640792;2848.387596666706;2949.616549848506;306308;361836;363849;364481;367691.9999999973;47417;58653.41346586565;59084;59122;59295.11057334144;60429;60946.39053609407;61038;65441;65522.34477655258;15557.14435706047;16842.07368594739;17046.74429883553;17097;17183.31266749316;10893.891061089287;10902.345859248471;10909.018188363085;10922.945385273022;11924.344161071225;18532.25870965173;18782.624347512974;18808.871467711982;18845.811541884406;18852.81147188538;4823.570993775365;7070.92929070713;7829.3345065670055;7848.215178482106;7903.407244456689;953.1374106433689;1028.7993841200894;1061.766411389493;1111.8776934537195;1131.0131538514893;24509.754902450746;25554.48891022169;28535.28661783472;29522.114336569506;29673;1080.4597701149426;1087.141158484804;1139.3050239353988;1149.5286932357694;1182.4265231362783;14709.632259193606;15122.319495622723;15224.847751522564;15559.611009724847;15887;587633;597802;598808;599160;599815;54558.63603409867;59733.70133149393;60467.69766151141;60905.78188436206;61133.38866611366;1297.6755811047237;1406.2757679794913;1445.8120444342378;1482.540412472094;1503.6316102554945;26130.933696069562;26890;28400.715992839807;28903.56644650374;29059.418811623225;47700.284495733285;48044.51955480401;48274.551763447154;48298;48317.75841120772;402376.9286921397;408721;413054;413530;415081;23373.948172332624;26547.336316591467;26602.866985664947;27010.05464808722;27508.312292192855;43656.78171609122;44234;44339.55660443354;45600.7719961398;46241.30638040365;36410.81794591116;36588.81705591455;36828.81585592055;37644;37706.62293377031;32214;35663.93008209758;36255.81872090622;36819.63180368269;37202.8139859299;32889.83555082209;35280.823595881855;35477.645223547435;35582.93251202468;36383.636163638024;31808.840955795073;31995.520067198544;32250.838745806122;32251.35497290088;32272.677273226967;23914.282571522883;24417.877910610332;24431.14490992807;24573.13994010201;24687.876560617082 16:53:46 INFO - PROCESS | 1662 | |2;jquery.html;335.67607258995065;390.0113213005032;402.7804846358734;406.04781786710157;414.6454781162104;16343.26455309511;19399;21040.473988150305;21093.367198984015;21121.57756844862;18607.348742794005;19671.409857704257;19749.012549372546;20175;20792.856392898386;5198.220266959948;5306.310179676646;5519;5830.5044071254;6007.429294217064;5850.707464626773;6002.949483840311;6016.27804663441;6016.368281330463;6017.338092809788;5394.460553944614;5396.43337449568;5404.702741349244;5499.257600223978;5946.791862284821;5220.712860792655;5406.91889621656;5415.566754659657;5420.864478388072;5426.348838139409;4686.882827929295;4998.175301075318;5110.386753589593;5257.421683614799;5297.099493086184;13619.863801362058;13662.248576328298;13836.446542138303;22029.449263768533;25192.622110668355;1981.3857704111772;2151.752548456916;2220.4781876259067;2488.191337815217;2771.016289217319;5673.971630141823;5733.88532229353;9476.620935162655;9970.598495041626;10035.197184225317;1689.1047744695331;1690.3914590747322;1731.4026660802003;1790.2928343304452;1809.701399269119;106446.46776766144;110739.89260107456;110888;115786;117138;11417.714557135972;11542.13433992454;11648.475818588184;11649.417529123679;11736.354500502553;14920.776188357184;15041.849581504044;15064.246787660792;15119.848801511844;15133.772993405108;7020.5787652741;7065.82335441618;8684.261837743736;8789.340799440068;8810.96021872453;6887.7244910203035;8500.829983400297;8501.19238672325;8623.784405389915;8627.611757470804;4510.594046535762;4610.098121002603;4622.375979242826;4675.064987002613;4702.717836929727;1900.6483800496953;1976.6244413561378;1983.720500277313;1985.5135491804313;2014.4661664658877;849.5072857742495;945.8959514453404;958.8130314588589;1003.0972125087334;1054.372648274291;18872.961987090566;19890;19936.10287537064;20668.689969650466;21049.579008419747;743.5092838726523;909.7543663211028;922.1838672774643;976.7216343342113;1033;9905.950470247602;10925.781484370267;10939.945300273448;10950.616728414467;10973.286736362112;573080;590047.0497647484;597110.0144499249;600828;605756;120649;124620;125113.99999999818;126561;127684;991.8859331176862;1008.1632245236436;1022.1107636356418;1023.3757407981126;1023.4575674892319;17318.913405433395;17548.91225543915;17614.29542818273;17659.911700441415;17861.821381786536;45062.549374505834;46477.07045859131;46527.83680408017;46807.38311402653;47246;69227.65386173037;69924.65037674778;70772;71132;71914.64042679963;7049.929500705132;7353.632318384166;7409.110906691231;7509.286617771303;8402.789930251793;10370.896291036994;11860.703482413008;12145.939270303592;12263.080268979684;12305.56930507428;8886.5112418815;10192.694219173436;10294.948525257625;10357.378557286587;10574;5207.192885102815;9268.974819252036;9633;10520.579176832842;10847.288177955512;10639.680809575726;10794.892051079389;11154.88845111571;11198.552057917917;11284.548618055185;7418.740344087931;7463.394895517615;7486.737964171228;7553.697852086075;7556.433267504849;10166.085052345325;10660.25378223517;10950.452477376259;10983.890161098607;11001.394923279297 16:53:46 INFO - PROCESS | 1662 | |3;mootools.html;1412.4067891485574;1590.673911848071;1596.417307682696;1868.3834334669561;1998.5303453688389;7875.527468351903;8543;8784.297256219503;8797.208251257385;8798.824023519534;8360.874586881202;8609.440386374881;8619.396642235046;8621.008584012841;8626.439281446701;2398.9760102399014;2430.1130087518104;2433.0997530913587;2433.7322894481595;2436.0377650827913;2362.8582285062867;2381.761823817622;2407.5305315463493;2407.7592240775957;2413.1553956115395;2402.1232250228627;2419.7217320008162;2421.4309637235237;2442.27952753938;2443.2425947956103;2379.2267513058327;2403.7596240375997;2409.7349291578;2412.662227288181;2422.6608274841537;2371.537550177716;2395.5208958208254;2404.7715467030603;2404.8196385271;2409.0965887792077;6988.965055174743;8660.26387757035;8713.912860871436;8761.948566172035;8790.077041910636;5157.58739300855;5335.466453354634;5357.678539287655;5376.220448035013;5383.219433182206;3412.4540073588355;3440.3807314683345;3503.2117773501013;3519.296140771856;3520.084777957724;1003.603576587244;1013.7414959185435;1014.8122597319519;1025.8305531693875;1026.8305729554615;11337.94331028348;11625.941870290679;11632.53469861213;11633;11643.708907277301;4477.597016268486;4483.21543729846;4629.606483448877;4694.43666759991;4701.3653156824075;9010.098990100938;9029.23251523628;9035.322350823715;9038.231750301298;9040.231580315616;5264.526192642604;5292.100342941709;5296.967091417214;5301.575873930076;5306.124489459273;4171.144915292358;4548.067646132535;4762.880927976828;4925.4335751388335;4950.777215025332;3633;3746.7189960753053;3842.8270727817317;3851.4607954886337;3879.165979314461;1179.8466199394024;1183.7928362536522;1189.4944648524342;1198.065508903057;1198.6104516032324;645.5739212119978;756.8297133144998;916.6608354908593;927.5130556457779;946.8343039967978;5559.249501317351;5594.021046316879;5733.0540460823495;5736.713164341766;5835.066389377679;535.8044313825426;549.609777058293;571.1404336473664;580.1269090019493;696.1159327653851;3803.82882770276;3949.486566746362;3958.129211573449;3997.6402123808416;4015.5181378234797;10236.078752912274;10671.733206669895;10824.296420732628;10826.566937322576;10861.13110951122;10662.680119596425;10789.946050269855;10791.622293219856;10818;10819;8014.687639557433;8068.07217170033;8303.875441868377;8305.792355191168;8308.376871734645;5624.212610234488;5691.23168372281;5770.740316685676;5785.566082543742;5929.792457263975;9778.608855645694;9825.754356140867;9920.156786673213;9923.751906202402;9931.65239216624;9662.227021838096;9972;9976.700698979042;10300.536475858455;10303.124234440156;6811.318868113149;6904.758333458305;6919.861602768017;6935.237123916264;6935.549189302679;8051.677932882619;8068.919310807051;8285.668573257002;8288.378371622273;8300.377471689768;7398.667059982206;7419.07261592301;7436.4050875928715;7577.772666820004;7580;7200.819979500555;7338.972543843759;7373.889391659022;7404.592747398945;7475.0656167979005;7042.436605071684;7050.858982820418;7076.256993015865;7145.535540189871;7147.392471639969;4725.29120631908;4801.327814106098;4837.4920633334405;4856.465788763304;4991.126552853164;4110.609492098246;4825.396825396825;4874.268859671078;4922.532359425849;5063.746812659426 16:53:46 INFO - PROCESS | 1662 | |4;prototype.html;291.94161167766447;312.2568287475807;315.8152480798732;317.1769258773482;323.7636525336506;5734.541236701064;5784.85960194728;5815.139155470251;5817.767289308428;5853.209816674747;4657.930131048037;5424.593155513333;5580.91628625571;5687.317521897378;5735.483806457418;3373.881914133006;4118.423420721101;4172.97913510432;4332.06860524987;4336.696431249814;3579.9260221933314;4017.3973903914352;4301.913961720764;4330.401758944639;4345.69580129391;3686.963130368689;3713.9071523211865;4110.856120035799;4225.837894578985;4253.1706317268145;3568.464730290464;3991.988052007728;4066.329055705805;4319.82720691172;4322.740635561845;3499.317633061554;3550.9879684289854;3685.9631403686158;3722.813859307024;3732.869349572752;4259.787010649455;5452;5514.283143191359;5514.283143191399;5524;4287.121140166259;4412.088021905559;4974;4978.8257410990445;5026.47222041684;4715.221988371914;5996.4902983246475;6028.788992385245;6049.727762250709;6084.665343406111;3745.419459983707;4002.7391371717817;4171.270027745163;4180.414741936132;4185.811638476276;5377.247185394009;6013.51891848651;6391.904121438182;6447.355264473562;6491.188601424822;3673.210259794157;4113.91772164555;4156.633127166944;4165.812538435777;4171.70798044134;4221.746695198298;4222.978885105616;4227.943014246438;4237.449131612871;4238.533761286256;4747.931715364084;4925.8029678812445;4947.812524994048;4952.727599982036;4965.404151501771;5735.139729040594;6028.668423236676;6115.357887421846;6117.969410153009;6155;1302.615728360136;1445.9421623134956;1452.3682198243798;1456.2427537680346;1457.2640816387657;882.4204673634251;939.8261321655378;948.2319321349729;962.6005207838668;963.8120566489607;5279.472052794767;5454.8909021819345;5591.245181900473;5632.831015069472;5749.872547157494;5319.45735736632;5660.320761508646;5871.031279838864;6372.725454909037;6397.872042559123;5515.145152501369;5774.249347584787;5794.942795307605;5797.507211886952;5801.447363160196;2950.837703926262;3326.9334613307597;3357.261402491448;3367.7642565020706;3382.661733826647;5884.793617308442;6213.689315534205;6233.605308257667;6653.73385064592;6700.597964122168;5805.912911306334;6044.7582096716515;6272.874542509125;6515.315891831289;6551.296662867689;5649.615844118217;5984.982552966093;6505.633816898409;6654.90017649726;6696.799096027127;5573.634459557435;6070.271567411939;6331.9366806331345;6399.968000159969;6428.678566071584;6080.817575472743;6290.811275661737;6302.5588208826775;6309.33751956038;6334.651594162366;6361.427471527585;6647.335266473314;6647.833804154935;6648.6343251119715;6681.365270299314;3503.579570451562;3958.990457433336;4137.441445404832;4171.457710497616;4172.561881002573;5969.671668058299;6041.848953776191;6361.7137228823885;6374.266959299554;6387;5853.239078919713;6142.283918229586;6181.041938499539;6186.81439556814;6195.721192546436;5385.6230063895155;6107.450329470369;6122.816315510542;6139.723712432862;6151.815445536462;5535.046133710226;5565.6104072714525;5758.769649213985;6049.66726830011;6051.305634422369;5549.889002220014;5604.8318550443555;5756.2229099072765;6166.352532983972;6185.288691800501;5596.468335508121;5809.651420914759;5835.44563266489;6094.177286066324;6101.969490152521 16:53:46 INFO - PROCESS | 1662 | |5;yui.html;605.7032054293396;670.7585269303053;687.5153017122929;733.4389192267917;749.3330935467433;14519.20144392058;15096.92451537742;15121;15133.319000644984;15149.469768558103;14020.509282175126;14148.575542733708;14244.14535127893;14254.144751314929;14270.3578338975;709.5281637710916;711.8327193109615;731.9304666056717;883.8762573239752;894.7092195036606;917.3853518142861;917.5504003038496;922.6125027488438;925.3753716241544;926.2960150285764;751.6166754954958;965.9420434773901;966.632679581758;967.2503809547586;970.0638883477443;926.5830376330645;954.9188318992894;959.1367769007879;962.6438217859367;964.5514835601479;723.9638018099074;724.3734169943014;725.1479511573932;725.2928394815066;726.0379996504653;14951.925240373837;15001.099934003994;15025.474108406153;15030.699386012328;15032;12263.570775022921;12393.75212495754;12403.255804651659;12447.190932589352;12576.245425274512;8653.307735381155;9327.673531426435;10003.199744020461;10021;10050.396976181453;3470.2538954124734;3488.843002064913;3505.193805424741;3551.254236610315;3760.567534733486;73441.63279183624;76268.85596716053;76463.23536764616;76666.6166669163;78157.60921195358;9371.297152713574;9449.291303152291;9522.809543809086;9588.185004274716;9908.7027389177;20415.693764593543;21442.892785535973;21618.783812161993;21682.024308906137;21706;7449.1061072670545;7501.512401693873;7509.887351689729;7524.699012039458;7711.190325015905;3920.9803950980063;3981.7013723970817;3982.3628219484744;4005.239004589119;4048.2510735514024;3433.7424693148114;3541.698955588804;3545.1314427965312;3554.2536067425613;3561.3795722945997;519.3196912045233;570.9000924838136;571.4942276085694;589.0839744197814;639.3287048599045;562.4740867289098;563.8601507279883;580.613891761982;602.978895738647;626.114048621205;7615.086189657277;7644.80887977805;7967.00412448444;7981.161977992343;8155.10293867674;497.9775910084055;523.5575938332104;536.940936496985;556.4352182534731;564.3989151553583;3769.4911186989953;3787.6023017582756;3843.365844635604;3903.4535165076913;3998.9800051000143;90630.54684726665;92959.53520232356;93180.53409732907;93739;93907;61203.69398152981;61773.691131544954;80225;80609;82154.58922705348;57071.858562829344;59566.404335956955;60026.499337516914;63321.683391582745;65150.67424662846;7947.721829735931;8118.391120665856;8221.383396245186;8232.34141268709;8286.709965151433;42199.57800422079;42503.7874810624;42988.35517467303;43384.13231735284;43591.128177436905;52456.737716311174;52838;53928.460715393914;57987.71006144942;62204.37795621986;10743.838842417526;11043.582566973275;11192.048675862643;11265.26775759573;11561.710957226136;10578.312409693346;12008;12043.518259269531;12450.620486014097;12537.185082969578;11619.88380116222;11690.88309116932;11835.230710003822;11924.403779811148;11973.940130299292;11319.703526836856;11585;11592.203208502695;11930.582429614922;12101.515939362678;11743.060555155738;11755.706107347385;11763.764724705286;11822.586209482972;11861.40692965331;9627.663031793854;9690.224782017282;9818.116369526777;10050.89949100529;10086.596536138471;9663.855042174233;9739.366941148803;9760.374918878182;9855.11303982645;9857.507124643882 16:53:46 INFO - PROCESS | 1662 | __end_tp_report 16:53:46 INFO - PROCESS | 1662 | __start_cc_report 16:53:46 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1345 16:53:46 INFO - PROCESS | 1662 | __end_cc_report 16:53:46 INFO - PROCESS | 1662 | __startTimestamp1460678026645__endTimestamp 16:53:46 INFO - PROCESS | 1662 | 16:53:46 INFO - PROCESS | 1662 | ------- Summary: start ------- 16:53:46 INFO - PROCESS | 1662 | Number of tests: 6 16:53:46 INFO - PROCESS | 1662 | 16:53:46 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5639.99 Median:5885.82 stddev:628.42 (10.7%) stddev-sans-first:603.88 16:53:46 INFO - PROCESS | 1662 | Values: 3339.5 3400.3 3437.9 3438.9 3463.2 5376.9 5470.4 5546.4 5553.2 5554.7 4595.7 5588.8 5653.5 5702.2 5719.4 4995.6 5009.2 5048.0 5058.3 5215.5 5130.3 5170.1 5180.9 5189.8 5250.7 4965.7 5071.1 5092.4 5112.3 5116.7 5029.5 5066.6 5092.2 5096.6 5107.7 4977.1 5057.7 5058.3 5076.8 5126.2 5461.8 5463.0 5483.0 5490.9 5493.1 5990.6 6063.8 6093.8 6109.1 6113.9 6094.8 6112.4 6175.1 6179.2 6192.8 5709.1 5709.1 5711.4 5711.9 5749.3 6112.5 6153.4 6199.7 6223.3 6232.6 5936.0 6041.7 6053.2 6059.2 6059.4 6129.6 6160.4 6161.2 6181.2 6183.4 5910.9 6095.4 6096.7 6107.0 6130.2 6026.8 6085.2 6103.4 6112.6 6118.0 4847.4 4850.0 4858.4 4859.8 4864.6 4298.5 4313.2 4391.8 4398.2 4429.0 5568.4 5571.6 5627.9 5635.4 5641.7 6071.8 6144.6 6162.4 6173.0 6201.5 5543.9 5545.1 5554.7 5555.0 5589.9 5281.0 5307.4 5355.2 5358.7 5365.3 5155.9 6200.3 6214.9 6258.0 6283.4 6163.1 6193.5 6199.0 6213.2 6215.6 6164.2 6236.2 6240.5 6258.3 6270.4 6041.2 6112.8 6126.2 6139.3 6139.6 6162.0 6175.0 6180.7 6183.7 6189.5 5875.2 5951.3 6021.8 6030.0 6087.5 5959.0 5967.8 5981.3 6001.2 6048.7 5663.4 5856.3 5856.6 5861.6 5908.7 5801.6 6011.5 6037.0 6060.9 6077.2 5885.8 5910.3 5912.3 5914.5 5917.6 16:53:46 INFO - PROCESS | 1662 | 16:53:46 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:59709.31 Median:36824.22 stddev:124050.55 (336.9%) stddev-sans-first:124318.82 16:53:46 INFO - PROCESS | 1662 | Values: 474.2 502.5 525.6 542.0 585.7 29370.0 29647.0 35747.8 38903.8 39093.8 40763.8 41295.2 41430.6 41463.0 41562.2 8783.6 9593.3 9595.2 9600.0 9606.9 9402.4 9538.6 9543.3 9550.5 9552.3 9487.2 9579.9 9622.7 9642.8 9699.3 9545.7 9599.3 9613.9 9614.4 9619.4 9401.2 9476.7 9492.0 9494.6 9510.6 39522.4 39924.0 39999.8 40005.4 40076.8 3188.0 3404.3 3416.9 3779.8 3802.1 27850.0 29291.7 29340.9 29411.4 29434.9 2444.3 2544.7 2848.0 2848.4 2949.6 306308.0 361836.0 363849.0 364481.0 367692.0 47417.0 58653.4 59084.0 59122.0 59295.1 60429.0 60946.4 61038.0 65441.0 65522.3 15557.1 16842.1 17046.7 17097.0 17183.3 10893.9 10902.3 10909.0 10922.9 11924.3 18532.3 18782.6 18808.9 18845.8 18852.8 4823.6 7070.9 7829.3 7848.2 7903.4 953.1 1028.8 1061.8 1111.9 1131.0 24509.8 25554.5 28535.3 29522.1 29673.0 1080.5 1087.1 1139.3 1149.5 1182.4 14709.6 15122.3 15224.8 15559.6 15887.0 587633.0 597802.0 598808.0 599160.0 599815.0 54558.6 59733.7 60467.7 60905.8 61133.4 1297.7 1406.3 1445.8 1482.5 1503.6 26130.9 26890.0 28400.7 28903.6 29059.4 47700.3 48044.5 48274.6 48298.0 48317.8 402376.9 408721.0 413054.0 413530.0 415081.0 23373.9 26547.3 26602.9 27010.1 27508.3 43656.8 44234.0 44339.6 45600.8 46241.3 36410.8 36588.8 36828.8 37644.0 37706.6 32214.0 35663.9 36255.8 36819.6 37202.8 32889.8 35280.8 35477.6 35582.9 36383.6 31808.8 31995.5 32250.8 32251.4 32272.7 23914.3 24417.9 24431.1 24573.1 24687.9 16:53:46 INFO - PROCESS | 1662 | 16:53:46 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:33710.01 Median:13840.41 stddev:98882.66 (714.4%) stddev-sans-first:99128.29 16:53:46 INFO - PROCESS | 1662 | Values: 335.7 390.0 402.8 406.0 414.6 16343.3 19399.0 21040.5 21093.4 21121.6 18607.3 19671.4 19749.0 20175.0 20792.9 5198.2 5306.3 5519.0 5830.5 6007.4 5850.7 6002.9 6016.3 6016.4 6017.3 5394.5 5396.4 5404.7 5499.3 5946.8 5220.7 5406.9 5415.6 5420.9 5426.3 4686.9 4998.2 5110.4 5257.4 5297.1 13619.9 13662.2 13836.4 22029.4 25192.6 1981.4 2151.8 2220.5 2488.2 2771.0 5674.0 5733.9 9476.6 9970.6 10035.2 1689.1 1690.4 1731.4 1790.3 1809.7 106446.5 110739.9 110888.0 115786.0 117138.0 11417.7 11542.1 11648.5 11649.4 11736.4 14920.8 15041.8 15064.2 15119.8 15133.8 7020.6 7065.8 8684.3 8789.3 8811.0 6887.7 8500.8 8501.2 8623.8 8627.6 4510.6 4610.1 4622.4 4675.1 4702.7 1900.6 1976.6 1983.7 1985.5 2014.5 849.5 945.9 958.8 1003.1 1054.4 18873.0 19890.0 19936.1 20668.7 21049.6 743.5 909.8 922.2 976.7 1033.0 9906.0 10925.8 10939.9 10950.6 10973.3 573080.0 590047.0 597110.0 600828.0 605756.0 120649.0 124620.0 125114.0 126561.0 127684.0 991.9 1008.2 1022.1 1023.4 1023.5 17318.9 17548.9 17614.3 17659.9 17861.8 45062.5 46477.1 46527.8 46807.4 47246.0 69227.7 69924.7 70772.0 71132.0 71914.6 7049.9 7353.6 7409.1 7509.3 8402.8 10370.9 11860.7 12145.9 12263.1 12305.6 8886.5 10192.7 10294.9 10357.4 10574.0 5207.2 9269.0 9633.0 10520.6 10847.3 10639.7 10794.9 11154.9 11198.6 11284.5 7418.7 7463.4 7486.7 7553.7 7556.4 10166.1 10660.3 10950.5 10983.9 11001.4 16:53:46 INFO - PROCESS | 1662 | 16:53:46 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5618.20 Median:5027.44 stddev:3157.40 (62.8%) stddev-sans-first:3150.44 16:53:46 INFO - PROCESS | 1662 | Values: 1412.4 1590.7 1596.4 1868.4 1998.5 7875.5 8543.0 8784.3 8797.2 8798.8 8360.9 8609.4 8619.4 8621.0 8626.4 2399.0 2430.1 2433.1 2433.7 2436.0 2362.9 2381.8 2407.5 2407.8 2413.2 2402.1 2419.7 2421.4 2442.3 2443.2 2379.2 2403.8 2409.7 2412.7 2422.7 2371.5 2395.5 2404.8 2404.8 2409.1 6989.0 8660.3 8713.9 8761.9 8790.1 5157.6 5335.5 5357.7 5376.2 5383.2 3412.5 3440.4 3503.2 3519.3 3520.1 1003.6 1013.7 1014.8 1025.8 1026.8 11337.9 11625.9 11632.5 11633.0 11643.7 4477.6 4483.2 4629.6 4694.4 4701.4 9010.1 9029.2 9035.3 9038.2 9040.2 5264.5 5292.1 5297.0 5301.6 5306.1 4171.1 4548.1 4762.9 4925.4 4950.8 3633.0 3746.7 3842.8 3851.5 3879.2 1179.8 1183.8 1189.5 1198.1 1198.6 645.6 756.8 916.7 927.5 946.8 5559.2 5594.0 5733.1 5736.7 5835.1 535.8 549.6 571.1 580.1 696.1 3803.8 3949.5 3958.1 3997.6 4015.5 10236.1 10671.7 10824.3 10826.6 10861.1 10662.7 10789.9 10791.6 10818.0 10819.0 8014.7 8068.1 8303.9 8305.8 8308.4 5624.2 5691.2 5770.7 5785.6 5929.8 9778.6 9825.8 9920.2 9923.8 9931.7 9662.2 9972.0 9976.7 10300.5 10303.1 6811.3 6904.8 6919.9 6935.2 6935.5 8051.7 8068.9 8285.7 8288.4 8300.4 7398.7 7419.1 7436.4 7577.8 7580.0 7200.8 7339.0 7373.9 7404.6 7475.1 7042.4 7050.9 7076.3 7145.5 7147.4 4725.3 4801.3 4837.5 4856.5 4991.1 4110.6 4825.4 4874.3 4922.5 5063.7 16:53:46 INFO - PROCESS | 1662 | 16:53:46 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4921.41 Median:5600.65 stddev:1561.34 (27.9%) stddev-sans-first:1526.57 16:53:46 INFO - PROCESS | 1662 | Values: 291.9 312.3 315.8 317.2 323.8 5734.5 5784.9 5815.1 5817.8 5853.2 4657.9 5424.6 5580.9 5687.3 5735.5 3373.9 4118.4 4173.0 4332.1 4336.7 3579.9 4017.4 4301.9 4330.4 4345.7 3687.0 3713.9 4110.9 4225.8 4253.2 3568.5 3992.0 4066.3 4319.8 4322.7 3499.3 3551.0 3686.0 3722.8 3732.9 4259.8 5452.0 5514.3 5514.3 5524.0 4287.1 4412.1 4974.0 4978.8 5026.5 4715.2 5996.5 6028.8 6049.7 6084.7 3745.4 4002.7 4171.3 4180.4 4185.8 5377.2 6013.5 6391.9 6447.4 6491.2 3673.2 4113.9 4156.6 4165.8 4171.7 4221.7 4223.0 4227.9 4237.4 4238.5 4747.9 4925.8 4947.8 4952.7 4965.4 5735.1 6028.7 6115.4 6118.0 6155.0 1302.6 1445.9 1452.4 1456.2 1457.3 882.4 939.8 948.2 962.6 963.8 5279.5 5454.9 5591.2 5632.8 5749.9 5319.5 5660.3 5871.0 6372.7 6397.9 5515.1 5774.2 5794.9 5797.5 5801.4 2950.8 3326.9 3357.3 3367.8 3382.7 5884.8 6213.7 6233.6 6653.7 6700.6 5805.9 6044.8 6272.9 6515.3 6551.3 5649.6 5985.0 6505.6 6654.9 6696.8 5573.6 6070.3 6331.9 6400.0 6428.7 6080.8 6290.8 6302.6 6309.3 6334.7 6361.4 6647.3 6647.8 6648.6 6681.4 3503.6 3959.0 4137.4 4171.5 4172.6 5969.7 6041.8 6361.7 6374.3 6387.0 5853.2 6142.3 6181.0 6186.8 6195.7 5385.6 6107.5 6122.8 6139.7 6151.8 5535.0 5565.6 5758.8 6049.7 6051.3 5549.9 5604.8 5756.2 6166.4 6185.3 5596.5 5809.7 5835.4 6094.2 6102.0 16:53:46 INFO - PROCESS | 1662 | 16:53:46 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:17292.03 Median:567.65 stddev:23873.63 (4205.7%) stddev-sans-first:23907.72 16:53:46 INFO - PROCESS | 1662 | Values: 605.7 670.8 687.5 733.4 749.3 14519.2 15096.9 15121.0 15133.3 15149.5 14020.5 14148.6 14244.1 14254.1 14270.4 709.5 711.8 731.9 883.9 894.7 917.4 917.6 922.6 925.4 926.3 751.6 965.9 966.6 967.3 970.1 926.6 954.9 959.1 962.6 964.6 724.0 724.4 725.1 725.3 726.0 14951.9 15001.1 15025.5 15030.7 15032.0 12263.6 12393.8 12403.3 12447.2 12576.2 8653.3 9327.7 10003.2 10021.0 10050.4 3470.3 3488.8 3505.2 3551.3 3760.6 73441.6 76268.9 76463.2 76666.6 78157.6 9371.3 9449.3 9522.8 9588.2 9908.7 20415.7 21442.9 21618.8 21682.0 21706.0 7449.1 7501.5 7509.9 7524.7 7711.2 3921.0 3981.7 3982.4 4005.2 4048.3 3433.7 3541.7 3545.1 3554.3 3561.4 519.3 570.9 571.5 589.1 639.3 562.5 563.9 580.6 603.0 626.1 7615.1 7644.8 7967.0 7981.2 8155.1 498.0 523.6 536.9 556.4 564.4 3769.5 3787.6 3843.4 3903.5 3999.0 90630.5 92959.5 93180.5 93739.0 93907.0 61203.7 61773.7 80225.0 80609.0 82154.6 57071.9 59566.4 60026.5 63321.7 65150.7 7947.7 8118.4 8221.4 8232.3 8286.7 42199.6 42503.8 42988.4 43384.1 43591.1 52456.7 52838.0 53928.5 57987.7 62204.4 10743.8 11043.6 11192.0 11265.3 11561.7 10578.3 12008.0 12043.5 12450.6 12537.2 11619.9 11690.9 11835.2 11924.4 11973.9 11319.7 11585.0 11592.2 11930.6 12101.5 11743.1 11755.7 11763.8 11822.6 11861.4 9627.7 9690.2 9818.1 10050.9 10086.6 9663.9 9739.4 9760.4 9855.1 9857.5 16:53:46 INFO - PROCESS | 1662 | -------- Summary: end -------- 16:53:46 INFO - PROCESS | 1662 | 16:53:47 INFO - TEST-INFO | 1662: exit 0 16:53:47 INFO - TEST-OK | dromaeo_css | took 1114683ms 16:53:47 INFO - TEST-START | kraken 16:53:47 INFO - operating with platform_type : mac_ 16:53:47 INFO - Initialising browser for kraken test... 16:53:47 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpHAHrPd/profile http://localhost:49280/getInfo.html) 16:53:49 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 16:53:49 INFO - PROCESS | 1671 | colorDepth:24 16:53:49 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 16:53:49 INFO - PROCESS | 1671 | __metrics 16:53:49 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:53:49 ERROR - PROCESS | 1671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:53:50 INFO - TEST-INFO | 1671: exit 0 16:53:50 INFO - Browser initialized. 16:53:50 INFO - Running cycle 1/1 for kraken test... 16:53:50 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpHAHrPd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:54:02 INFO - PROCESS | 1673 | RSS: Main: 237629440 16:54:02 INFO - PROCESS | 1673 | 16:54:04 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 16:54:05 INFO - PROCESS | 1673 | RSS: Main: 285634560 16:54:05 INFO - PROCESS | 1673 | 16:54:08 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 16:54:08 INFO - PROCESS | 1673 | RSS: Main: 299048960 16:54:08 INFO - PROCESS | 1673 | 16:54:12 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 16:54:13 INFO - PROCESS | 1673 | RSS: Main: 384872448 16:54:13 INFO - PROCESS | 1673 | 16:54:15 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 16:54:15 INFO - PROCESS | 1673 | RSS: Main: 286179328 16:54:15 INFO - PROCESS | 1673 | 16:54:17 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:54:18 INFO - PROCESS | 1673 | RSS: Main: 290377728 16:54:18 INFO - PROCESS | 1673 | 16:54:21 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 16:54:21 INFO - PROCESS | 1673 | RSS: Main: 326811648 16:54:21 INFO - PROCESS | 1673 | 16:54:24 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 16:54:25 INFO - PROCESS | 1673 | RSS: Main: 330022912 16:54:25 INFO - PROCESS | 1673 | 16:54:28 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 16:54:28 INFO - PROCESS | 1673 | RSS: Main: 329641984 16:54:28 INFO - PROCESS | 1673 | 16:54:30 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:54:31 INFO - PROCESS | 1673 | RSS: Main: 319586304 16:54:31 INFO - PROCESS | 1673 | 16:54:32 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:54:33 INFO - PROCESS | 1673 | RSS: Main: 327118848 16:54:33 INFO - PROCESS | 1673 | 16:54:35 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:54:36 INFO - PROCESS | 1673 | RSS: Main: 330129408 16:54:36 INFO - PROCESS | 1673 | 16:54:39 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:54:39 INFO - PROCESS | 1673 | RSS: Main: 331452416 16:54:39 INFO - PROCESS | 1673 | 16:54:42 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:54:43 INFO - PROCESS | 1673 | RSS: Main: 331833344 16:54:43 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 16:54:45 INFO - PROCESS | 1673 | RSS: Main: 396075008 16:54:45 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | __start_tp_report 16:54:45 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 16:54:45 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 16:54:45 INFO - PROCESS | 1673 | |i|pagename|runs| 16:54:45 INFO - PROCESS | 1673 | |0;ai-astar;118;109;111;111;112;112;119;109;112;112 16:54:45 INFO - PROCESS | 1673 | |1;audio-beat-detection;156;132;144;170;120;143;139;117;170;119 16:54:45 INFO - PROCESS | 1673 | |2;audio-dft;183;191;187;185;186;185;183;183;187;257 16:54:45 INFO - PROCESS | 1673 | |3;audio-fft;75;73;87;90;56;59;57;78;85;56 16:54:45 INFO - PROCESS | 1673 | |4;audio-oscillator;90;100;134;78;78;79;119;81;78;126 16:54:45 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;87;83;86;84;87;84;87;85;90;83 16:54:45 INFO - PROCESS | 1673 | |6;imaging-darkroom;93;93;102;94;93;93;94;93;93;94 16:54:45 INFO - PROCESS | 1673 | |7;imaging-desaturate;103;133;135;84;87;86;84;102;132;119 16:54:45 INFO - PROCESS | 1673 | |8;json-parse-financial;58;59;59;58;57;58;58;73;59;56 16:54:45 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;64;71;77;73;73;69;70;68;70;68 16:54:45 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;86;86;85;86;85;85;82;73;85;98 16:54:45 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;144;143;142;143;143;141;141;142;222;144 16:54:45 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;173;216;209;169;169;169;195;210;184;168 16:54:45 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;67;68;81;92;91;93;93;71;69;69 16:54:45 INFO - PROCESS | 1673 | __end_tp_report 16:54:45 INFO - PROCESS | 1673 | __start_cc_report 16:54:45 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1981 16:54:45 INFO - PROCESS | 1673 | __end_cc_report 16:54:45 INFO - PROCESS | 1673 | __startTimestamp1460678085714__endTimestamp 16:54:45 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | ------- Summary: start ------- 16:54:45 INFO - PROCESS | 1673 | Number of tests: 14 16:54:45 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.00 stddev:3.37 (3.0%) stddev-sans-first:2.93 16:54:45 INFO - PROCESS | 1673 | Values: 118.0 109.0 111.0 111.0 112.0 112.0 119.0 109.0 112.0 112.0 16:54:45 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:143.50 stddev:19.74 (13.8%) stddev-sans-first:20.17 16:54:45 INFO - PROCESS | 1673 | Values: 156.0 132.0 144.0 170.0 120.0 143.0 139.0 117.0 170.0 119.0 16:54:45 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:192.70 Median:186.50 stddev:22.73 (12.2%) stddev-sans-first:23.83 16:54:45 INFO - PROCESS | 1673 | Values: 183.0 191.0 187.0 185.0 186.0 185.0 183.0 183.0 187.0 257.0 16:54:45 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:71.60 Median:76.50 stddev:13.62 (17.8%) stddev-sans-first:14.39 16:54:45 INFO - PROCESS | 1673 | Values: 75.0 73.0 87.0 90.0 56.0 59.0 57.0 78.0 85.0 56.0 16:54:45 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:78.00 stddev:22.14 (28.4%) stddev-sans-first:23.36 16:54:45 INFO - PROCESS | 1673 | Values: 90.0 100.0 134.0 78.0 78.0 79.0 119.0 81.0 78.0 126.0 16:54:45 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.50 stddev:2.22 (2.6%) stddev-sans-first:2.30 16:54:45 INFO - PROCESS | 1673 | Values: 87.0 83.0 86.0 84.0 87.0 84.0 87.0 85.0 90.0 83.0 16:54:45 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:93.00 stddev:2.78 (3.0%) stddev-sans-first:2.92 16:54:45 INFO - PROCESS | 1673 | Values: 93.0 93.0 102.0 94.0 93.0 93.0 94.0 93.0 93.0 94.0 16:54:45 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:106.50 Median:109.50 stddev:21.52 (19.6%) stddev-sans-first:22.78 16:54:45 INFO - PROCESS | 1673 | Values: 103.0 133.0 135.0 84.0 87.0 86.0 84.0 102.0 132.0 119.0 16:54:45 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:58.50 stddev:4.84 (8.3%) stddev-sans-first:5.10 16:54:45 INFO - PROCESS | 1673 | Values: 58.0 59.0 59.0 58.0 57.0 58.0 58.0 73.0 59.0 56.0 16:54:45 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.50 stddev:3.53 (5.0%) stddev-sans-first:2.92 16:54:45 INFO - PROCESS | 1673 | Values: 64.0 71.0 77.0 73.0 73.0 69.0 70.0 68.0 70.0 68.0 16:54:45 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.50 stddev:6.01 (7.0%) stddev-sans-first:6.36 16:54:45 INFO - PROCESS | 1673 | Values: 86.0 86.0 85.0 86.0 85.0 85.0 82.0 73.0 85.0 98.0 16:54:45 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:143.00 stddev:25.15 (17.6%) stddev-sans-first:26.56 16:54:45 INFO - PROCESS | 1673 | Values: 144.0 143.0 142.0 143.0 143.0 141.0 141.0 142.0 222.0 144.0 16:54:45 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.20 Median:189.50 stddev:19.58 (10.3%) stddev-sans-first:20.17 16:54:45 INFO - PROCESS | 1673 | Values: 173.0 216.0 209.0 169.0 169.0 169.0 195.0 210.0 184.0 168.0 16:54:45 INFO - PROCESS | 1673 | 16:54:45 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.40 Median:86.00 stddev:11.72 (13.6%) stddev-sans-first:11.54 16:54:45 INFO - PROCESS | 1673 | Values: 67.0 68.0 81.0 92.0 91.0 93.0 93.0 71.0 69.0 69.0 16:54:45 INFO - PROCESS | 1673 | -------- Summary: end -------- 16:54:45 INFO - PROCESS | 1673 | 16:54:46 INFO - TEST-INFO | 1673: exit 0 16:54:46 INFO - TEST-OK | kraken | took 59294ms 16:54:46 INFO - SUITE-END | took 1173s 16:54:46 INFO - Completed test suite (00:19:34) 16:54:46 INFO - javascript benchmark 16:54:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3339.4656854903214, 3400.2859399526114, 3437.9484307735374, 3438.8651744924177, 3463.2034632034633, 5376.91934620981, 5470.425605311445, 5546.362168350641, 5553.22254884316, 5554.72226388681, 4595.655325850566, 5588.832335029945, 5653.4911857932775, 5702.201691763156, 5719.428057194278, 4995.5753760930365, 5009.223570346584, 5047.9747601262125, 5058.342415485981, 5215.478452154774, 5130.281760553526, 5170.095233334151, 5180.896382072357, 5189.8183563575285, 5250.684958902459, 4965.677230979993, 5071.087204303224, 5092.414372347191, 5112.284280200774, 5116.667416617908, 5029.522195391469, 5066.594672426197, 5092.236164575306, 5096.643234973553, 5107.7446127693465, 4977.079240340512, 5057.747112644353, 5058.342415485963, 5076.796928122908, 5126.231065340192, 5461.808836690737, 5462.989346970823, 5483.040467918138, 5490.945090549083, 5493.093639549469, 5990.64056156632, 6063.761734033555, 6093.756249750049, 6109.114178444101, 6113.938860611382, 6094.803649345489, 6112.388761123896, 6175.135481032614, 6179.227596550431, 6192.752289908398, 5709.058005429058, 5709.115087161455, 5711.371749107595, 5711.885762284731, 5749.281339832521, 6112.541559383064, 6153.4154255345675, 6199.659018753921, 6223.284322302902, 6232.563720539519, 5936.0, 6041.667708276087, 6053.213082299273, 6059.182010428536, 6059.36376680451, 6129.55005433648, 6160.414760597736, 6161.199044124325, 6181.196444462191, 6183.412575805291, 5910.8817823643285, 6095.414267386731, 6096.664683442454, 6106.969465152734, 6130.2146971548445, 6026.758929642853, 6085.2393450818645, 6103.42017508336, 6112.572119951649, 6118.0211166214085, 4847.3698419205275, 4850.0, 4858.44127925286, 4859.781309841065, 4864.586510146606, 4298.505671847715, 4313.158934007838, 4391.8462853799965, 4398.164348773723, 4428.955710442919, 5568.359638641527, 5571.582131340166, 5627.943720562742, 5635.3519345275, 5641.717914104278, 6071.817845464643, 6144.556029333103, 6162.445379915829, 6172.969135154385, 6201.503879689614, 5543.861403464945, 5545.057340252167, 5554.72226388679, 5554.972225138848, 5589.944100559023, 5280.996610643965, 5307.363116426053, 5355.169948657965, 5358.678479291255, 5365.302510673666, 5155.896882062413, 6200.348963358872, 6214.875702486015, 6258.030005349178, 6283.434490895841, 6163.075538669056, 6193.473554747897, 6198.969005154945, 6213.1922850029205, 6215.564910456224, 6164.229471316085, 6236.220472440945, 6240.500759939285, 6258.342873998165, 6270.435660790551, 6041.214642096499, 6112.777056696867, 6126.181801870855, 6139.338817383189, 6139.553468857593, 6161.969190154021, 6175.042868355412, 6180.66006369636, 6183.659898705434, 6189.5048396129105, 5875.236219291465, 5951.285845698544, 6021.789237376671, 6029.969850150721, 6087.482563982111, 5958.970205148947, 5967.791127310524, 5981.312149102909, 6001.219841420762, 6048.697565121638, 5663.3770285267765, 5856.267966504187, 5856.560757943256, 5861.560382971209, 5908.675022873783, 5801.593888427769, 6011.458968692838, 6036.9698151508965, 6060.939390606038, 6077.179580756541, 5885.823425297248, 5910.349861515316, 5912.320083190316, 5914.526837853047, 5917.5857689961285], "value": 5600.7671305934555, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.17493561203514, 502.494992532505, 525.613673949647, 542.0487045235611, 585.7188549496244, 29370.0, 29647.0, 35747.82126089369, 38903.80548097256, 39093.80453097731, 40763.79618101913, 41295.17409651805, 41430.58569414305, 41463.0, 41562.16875662485, 8783.604737786798, 9593.328467007312, 9595.23238140947, 9600.03999600038, 9606.855897161513, 9402.38884472507, 9538.618455261781, 9543.284253681002, 9550.474723890184, 9552.331336806426, 9487.24102071836, 9579.856302155473, 9622.711318660451, 9642.75893102671, 9699.321047526675, 9545.713628591118, 9599.280053995908, 9613.942466328699, 9614.375065620712, 9619.374740641906, 9401.24790016797, 9476.668316608955, 9491.955884852661, 9494.572744226527, 9510.572024258925, 39522.40716389257, 39924.0, 39999.80000099981, 40005.39991900124, 40076.79961600203, 3187.952180717291, 3404.3021180657906, 3416.8804091856914, 3779.7543159694533, 3802.068493219151, 27850.0, 29291.681874315705, 29340.853295733385, 29411.411771764444, 29434.852825735736, 2444.3033735385507, 2544.745525447459, 2847.957280640792, 2848.387596666706, 2949.616549848506, 306308.0, 361836.0, 363849.0, 364481.0, 367691.9999999973, 47417.0, 58653.41346586565, 59084.0, 59122.0, 59295.11057334144, 60429.0, 60946.39053609407, 61038.0, 65441.0, 65522.34477655258, 15557.14435706047, 16842.07368594739, 17046.74429883553, 17097.0, 17183.31266749316, 10893.891061089287, 10902.345859248471, 10909.018188363085, 10922.945385273022, 11924.344161071225, 18532.25870965173, 18782.624347512974, 18808.871467711982, 18845.811541884406, 18852.81147188538, 4823.570993775365, 7070.92929070713, 7829.3345065670055, 7848.215178482106, 7903.407244456689, 953.1374106433689, 1028.7993841200894, 1061.766411389493, 1111.8776934537195, 1131.0131538514893, 24509.754902450746, 25554.48891022169, 28535.28661783472, 29522.114336569506, 29673.0, 1080.4597701149426, 1087.141158484804, 1139.3050239353988, 1149.5286932357694, 1182.4265231362783, 14709.632259193606, 15122.319495622723, 15224.847751522564, 15559.611009724847, 15887.0, 587633.0, 597802.0, 598808.0, 599160.0, 599815.0, 54558.63603409867, 59733.70133149393, 60467.69766151141, 60905.78188436206, 61133.38866611366, 1297.6755811047237, 1406.2757679794913, 1445.8120444342378, 1482.540412472094, 1503.6316102554945, 26130.933696069562, 26890.0, 28400.715992839807, 28903.56644650374, 29059.418811623225, 47700.284495733285, 48044.51955480401, 48274.551763447154, 48298.0, 48317.75841120772, 402376.9286921397, 408721.0, 413054.0, 413530.0, 415081.0, 23373.948172332624, 26547.336316591467, 26602.866985664947, 27010.05464808722, 27508.312292192855, 43656.78171609122, 44234.0, 44339.55660443354, 45600.7719961398, 46241.30638040365, 36410.81794591116, 36588.81705591455, 36828.81585592055, 37644.0, 37706.62293377031, 32214.0, 35663.93008209758, 36255.81872090622, 36819.63180368269, 37202.8139859299, 32889.83555082209, 35280.823595881855, 35477.645223547435, 35582.93251202468, 36383.636163638024, 31808.840955795073, 31995.520067198544, 32250.838745806122, 32251.35497290088, 32272.677273226967, 23914.282571522883, 24417.877910610332, 24431.14490992807, 24573.13994010201, 24687.876560617082], "value": 19063.12872663387, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.67607258995065, 390.0113213005032, 402.7804846358734, 406.04781786710157, 414.6454781162104, 16343.26455309511, 19399.0, 21040.473988150305, 21093.367198984015, 21121.57756844862, 18607.348742794005, 19671.409857704257, 19749.012549372546, 20175.0, 20792.856392898386, 5198.220266959948, 5306.310179676646, 5519.0, 5830.5044071254, 6007.429294217064, 5850.707464626773, 6002.949483840311, 6016.27804663441, 6016.368281330463, 6017.338092809788, 5394.460553944614, 5396.43337449568, 5404.702741349244, 5499.257600223978, 5946.791862284821, 5220.712860792655, 5406.91889621656, 5415.566754659657, 5420.864478388072, 5426.348838139409, 4686.882827929295, 4998.175301075318, 5110.386753589593, 5257.421683614799, 5297.099493086184, 13619.863801362058, 13662.248576328298, 13836.446542138303, 22029.449263768533, 25192.622110668355, 1981.3857704111772, 2151.752548456916, 2220.4781876259067, 2488.191337815217, 2771.016289217319, 5673.971630141823, 5733.88532229353, 9476.620935162655, 9970.598495041626, 10035.197184225317, 1689.1047744695331, 1690.3914590747322, 1731.4026660802003, 1790.2928343304452, 1809.701399269119, 106446.46776766144, 110739.89260107456, 110888.0, 115786.0, 117138.0, 11417.714557135972, 11542.13433992454, 11648.475818588184, 11649.417529123679, 11736.354500502553, 14920.776188357184, 15041.849581504044, 15064.246787660792, 15119.848801511844, 15133.772993405108, 7020.5787652741, 7065.82335441618, 8684.261837743736, 8789.340799440068, 8810.96021872453, 6887.7244910203035, 8500.829983400297, 8501.19238672325, 8623.784405389915, 8627.611757470804, 4510.594046535762, 4610.098121002603, 4622.375979242826, 4675.064987002613, 4702.717836929727, 1900.6483800496953, 1976.6244413561378, 1983.720500277313, 1985.5135491804313, 2014.4661664658877, 849.5072857742495, 945.8959514453404, 958.8130314588589, 1003.0972125087334, 1054.372648274291, 18872.961987090566, 19890.0, 19936.10287537064, 20668.689969650466, 21049.579008419747, 743.5092838726523, 909.7543663211028, 922.1838672774643, 976.7216343342113, 1033.0, 9905.950470247602, 10925.781484370267, 10939.945300273448, 10950.616728414467, 10973.286736362112, 573080.0, 590047.0497647484, 597110.0144499249, 600828.0, 605756.0, 120649.0, 124620.0, 125113.99999999818, 126561.0, 127684.0, 991.8859331176862, 1008.1632245236436, 1022.1107636356418, 1023.3757407981126, 1023.4575674892319, 17318.913405433395, 17548.91225543915, 17614.29542818273, 17659.911700441415, 17861.821381786536, 45062.549374505834, 46477.07045859131, 46527.83680408017, 46807.38311402653, 47246.0, 69227.65386173037, 69924.65037674778, 70772.0, 71132.0, 71914.64042679963, 7049.929500705132, 7353.632318384166, 7409.110906691231, 7509.286617771303, 8402.789930251793, 10370.896291036994, 11860.703482413008, 12145.939270303592, 12263.080268979684, 12305.56930507428, 8886.5112418815, 10192.694219173436, 10294.948525257625, 10357.378557286587, 10574.0, 5207.192885102815, 9268.974819252036, 9633.0, 10520.579176832842, 10847.288177955512, 10639.680809575726, 10794.892051079389, 11154.88845111571, 11198.552057917917, 11284.548618055185, 7418.740344087931, 7463.394895517615, 7486.737964171228, 7553.697852086075, 7556.433267504849, 10166.085052345325, 10660.25378223517, 10950.452477376259, 10983.890161098607, 11001.394923279297], "value": 9087.855140422651, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1412.4067891485574, 1590.673911848071, 1596.417307682696, 1868.3834334669561, 1998.5303453688389, 7875.527468351903, 8543.0, 8784.297256219503, 8797.208251257385, 8798.824023519534, 8360.874586881202, 8609.440386374881, 8619.396642235046, 8621.008584012841, 8626.439281446701, 2398.9760102399014, 2430.1130087518104, 2433.0997530913587, 2433.7322894481595, 2436.0377650827913, 2362.8582285062867, 2381.761823817622, 2407.5305315463493, 2407.7592240775957, 2413.1553956115395, 2402.1232250228627, 2419.7217320008162, 2421.4309637235237, 2442.27952753938, 2443.2425947956103, 2379.2267513058327, 2403.7596240375997, 2409.7349291578, 2412.662227288181, 2422.6608274841537, 2371.537550177716, 2395.5208958208254, 2404.7715467030603, 2404.8196385271, 2409.0965887792077, 6988.965055174743, 8660.26387757035, 8713.912860871436, 8761.948566172035, 8790.077041910636, 5157.58739300855, 5335.466453354634, 5357.678539287655, 5376.220448035013, 5383.219433182206, 3412.4540073588355, 3440.3807314683345, 3503.2117773501013, 3519.296140771856, 3520.084777957724, 1003.603576587244, 1013.7414959185435, 1014.8122597319519, 1025.8305531693875, 1026.8305729554615, 11337.94331028348, 11625.941870290679, 11632.53469861213, 11633.0, 11643.708907277301, 4477.597016268486, 4483.21543729846, 4629.606483448877, 4694.43666759991, 4701.3653156824075, 9010.098990100938, 9029.23251523628, 9035.322350823715, 9038.231750301298, 9040.231580315616, 5264.526192642604, 5292.100342941709, 5296.967091417214, 5301.575873930076, 5306.124489459273, 4171.144915292358, 4548.067646132535, 4762.880927976828, 4925.4335751388335, 4950.777215025332, 3633.0, 3746.7189960753053, 3842.8270727817317, 3851.4607954886337, 3879.165979314461, 1179.8466199394024, 1183.7928362536522, 1189.4944648524342, 1198.065508903057, 1198.6104516032324, 645.5739212119978, 756.8297133144998, 916.6608354908593, 927.5130556457779, 946.8343039967978, 5559.249501317351, 5594.021046316879, 5733.0540460823495, 5736.713164341766, 5835.066389377679, 535.8044313825426, 549.609777058293, 571.1404336473664, 580.1269090019493, 696.1159327653851, 3803.82882770276, 3949.486566746362, 3958.129211573449, 3997.6402123808416, 4015.5181378234797, 10236.078752912274, 10671.733206669895, 10824.296420732628, 10826.566937322576, 10861.13110951122, 10662.680119596425, 10789.946050269855, 10791.622293219856, 10818.0, 10819.0, 8014.687639557433, 8068.07217170033, 8303.875441868377, 8305.792355191168, 8308.376871734645, 5624.212610234488, 5691.23168372281, 5770.740316685676, 5785.566082543742, 5929.792457263975, 9778.608855645694, 9825.754356140867, 9920.156786673213, 9923.751906202402, 9931.65239216624, 9662.227021838096, 9972.0, 9976.700698979042, 10300.536475858455, 10303.124234440156, 6811.318868113149, 6904.758333458305, 6919.861602768017, 6935.237123916264, 6935.549189302679, 8051.677932882619, 8068.919310807051, 8285.668573257002, 8288.378371622273, 8300.377471689768, 7398.667059982206, 7419.07261592301, 7436.4050875928715, 7577.772666820004, 7580.0, 7200.819979500555, 7338.972543843759, 7373.889391659022, 7404.592747398945, 7475.0656167979005, 7042.436605071684, 7050.858982820418, 7076.256993015865, 7145.535540189871, 7147.392471639969, 4725.29120631908, 4801.327814106098, 4837.4920633334405, 4856.465788763304, 4991.126552853164, 4110.609492098246, 4825.396825396825, 4874.268859671078, 4922.532359425849, 5063.746812659426], "value": 4471.082676192557, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.94161167766447, 312.2568287475807, 315.8152480798732, 317.1769258773482, 323.7636525336506, 5734.541236701064, 5784.85960194728, 5815.139155470251, 5817.767289308428, 5853.209816674747, 4657.930131048037, 5424.593155513333, 5580.91628625571, 5687.317521897378, 5735.483806457418, 3373.881914133006, 4118.423420721101, 4172.97913510432, 4332.06860524987, 4336.696431249814, 3579.9260221933314, 4017.3973903914352, 4301.913961720764, 4330.401758944639, 4345.69580129391, 3686.963130368689, 3713.9071523211865, 4110.856120035799, 4225.837894578985, 4253.1706317268145, 3568.464730290464, 3991.988052007728, 4066.329055705805, 4319.82720691172, 4322.740635561845, 3499.317633061554, 3550.9879684289854, 3685.9631403686158, 3722.813859307024, 3732.869349572752, 4259.787010649455, 5452.0, 5514.283143191359, 5514.283143191399, 5524.0, 4287.121140166259, 4412.088021905559, 4974.0, 4978.8257410990445, 5026.47222041684, 4715.221988371914, 5996.4902983246475, 6028.788992385245, 6049.727762250709, 6084.665343406111, 3745.419459983707, 4002.7391371717817, 4171.270027745163, 4180.414741936132, 4185.811638476276, 5377.247185394009, 6013.51891848651, 6391.904121438182, 6447.355264473562, 6491.188601424822, 3673.210259794157, 4113.91772164555, 4156.633127166944, 4165.812538435777, 4171.70798044134, 4221.746695198298, 4222.978885105616, 4227.943014246438, 4237.449131612871, 4238.533761286256, 4747.931715364084, 4925.8029678812445, 4947.812524994048, 4952.727599982036, 4965.404151501771, 5735.139729040594, 6028.668423236676, 6115.357887421846, 6117.969410153009, 6155.0, 1302.615728360136, 1445.9421623134956, 1452.3682198243798, 1456.2427537680346, 1457.2640816387657, 882.4204673634251, 939.8261321655378, 948.2319321349729, 962.6005207838668, 963.8120566489607, 5279.472052794767, 5454.8909021819345, 5591.245181900473, 5632.831015069472, 5749.872547157494, 5319.45735736632, 5660.320761508646, 5871.031279838864, 6372.725454909037, 6397.872042559123, 5515.145152501369, 5774.249347584787, 5794.942795307605, 5797.507211886952, 5801.447363160196, 2950.837703926262, 3326.9334613307597, 3357.261402491448, 3367.7642565020706, 3382.661733826647, 5884.793617308442, 6213.689315534205, 6233.605308257667, 6653.73385064592, 6700.597964122168, 5805.912911306334, 6044.7582096716515, 6272.874542509125, 6515.315891831289, 6551.296662867689, 5649.615844118217, 5984.982552966093, 6505.633816898409, 6654.90017649726, 6696.799096027127, 5573.634459557435, 6070.271567411939, 6331.9366806331345, 6399.968000159969, 6428.678566071584, 6080.817575472743, 6290.811275661737, 6302.5588208826775, 6309.33751956038, 6334.651594162366, 6361.427471527585, 6647.335266473314, 6647.833804154935, 6648.6343251119715, 6681.365270299314, 3503.579570451562, 3958.990457433336, 4137.441445404832, 4171.457710497616, 4172.561881002573, 5969.671668058299, 6041.848953776191, 6361.7137228823885, 6374.266959299554, 6387.0, 5853.239078919713, 6142.283918229586, 6181.041938499539, 6186.81439556814, 6195.721192546436, 5385.6230063895155, 6107.450329470369, 6122.816315510542, 6139.723712432862, 6151.815445536462, 5535.046133710226, 5565.6104072714525, 5758.769649213985, 6049.66726830011, 6051.305634422369, 5549.889002220014, 5604.8318550443555, 5756.2229099072765, 6166.352532983972, 6185.288691800501, 5596.468335508121, 5809.651420914759, 5835.44563266489, 6094.177286066324, 6101.969490152521], "value": 4416.7705482431265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.7032054293396, 670.7585269303053, 687.5153017122929, 733.4389192267917, 749.3330935467433, 14519.20144392058, 15096.92451537742, 15121.0, 15133.319000644984, 15149.469768558103, 14020.509282175126, 14148.575542733708, 14244.14535127893, 14254.144751314929, 14270.3578338975, 709.5281637710916, 711.8327193109615, 731.9304666056717, 883.8762573239752, 894.7092195036606, 917.3853518142861, 917.5504003038496, 922.6125027488438, 925.3753716241544, 926.2960150285764, 751.6166754954958, 965.9420434773901, 966.632679581758, 967.2503809547586, 970.0638883477443, 926.5830376330645, 954.9188318992894, 959.1367769007879, 962.6438217859367, 964.5514835601479, 723.9638018099074, 724.3734169943014, 725.1479511573932, 725.2928394815066, 726.0379996504653, 14951.925240373837, 15001.099934003994, 15025.474108406153, 15030.699386012328, 15032.0, 12263.570775022921, 12393.75212495754, 12403.255804651659, 12447.190932589352, 12576.245425274512, 8653.307735381155, 9327.673531426435, 10003.199744020461, 10021.0, 10050.396976181453, 3470.2538954124734, 3488.843002064913, 3505.193805424741, 3551.254236610315, 3760.567534733486, 73441.63279183624, 76268.85596716053, 76463.23536764616, 76666.6166669163, 78157.60921195358, 9371.297152713574, 9449.291303152291, 9522.809543809086, 9588.185004274716, 9908.7027389177, 20415.693764593543, 21442.892785535973, 21618.783812161993, 21682.024308906137, 21706.0, 7449.1061072670545, 7501.512401693873, 7509.887351689729, 7524.699012039458, 7711.190325015905, 3920.9803950980063, 3981.7013723970817, 3982.3628219484744, 4005.239004589119, 4048.2510735514024, 3433.7424693148114, 3541.698955588804, 3545.1314427965312, 3554.2536067425613, 3561.3795722945997, 519.3196912045233, 570.9000924838136, 571.4942276085694, 589.0839744197814, 639.3287048599045, 562.4740867289098, 563.8601507279883, 580.613891761982, 602.978895738647, 626.114048621205, 7615.086189657277, 7644.80887977805, 7967.00412448444, 7981.161977992343, 8155.10293867674, 497.9775910084055, 523.5575938332104, 536.940936496985, 556.4352182534731, 564.3989151553583, 3769.4911186989953, 3787.6023017582756, 3843.365844635604, 3903.4535165076913, 3998.9800051000143, 90630.54684726665, 92959.53520232356, 93180.53409732907, 93739.0, 93907.0, 61203.69398152981, 61773.691131544954, 80225.0, 80609.0, 82154.58922705348, 57071.858562829344, 59566.404335956955, 60026.499337516914, 63321.683391582745, 65150.67424662846, 7947.721829735931, 8118.391120665856, 8221.383396245186, 8232.34141268709, 8286.709965151433, 42199.57800422079, 42503.7874810624, 42988.35517467303, 43384.13231735284, 43591.128177436905, 52456.737716311174, 52838.0, 53928.460715393914, 57987.71006144942, 62204.37795621986, 10743.838842417526, 11043.582566973275, 11192.048675862643, 11265.26775759573, 11561.710957226136, 10578.312409693346, 12008.0, 12043.518259269531, 12450.620486014097, 12537.185082969578, 11619.88380116222, 11690.88309116932, 11835.230710003822, 11924.403779811148, 11973.940130299292, 11319.703526836856, 11585.0, 11592.203208502695, 11930.582429614922, 12101.515939362678, 11743.060555155738, 11755.706107347385, 11763.764724705286, 11822.586209482972, 11861.40692965331, 9627.663031793854, 9690.224782017282, 9818.116369526777, 10050.89949100529, 10086.596536138471, 9663.855042174233, 9739.366941148803, 9760.374918878182, 9855.11303982645, 9857.507124643882], "value": 6739.713827952078, "unit": "score"}], "name": "dromaeo_css", "value": 7109.688884568651, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 109.0, 111.0, 111.0, 112.0, 112.0, 119.0, 109.0, 112.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 144.0, 170.0, 120.0, 143.0, 139.0, 117.0, 170.0, 119.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 191.0, 187.0, 185.0, 186.0, 185.0, 183.0, 183.0, 187.0, 257.0], "value": 192.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 87.0, 90.0, 56.0, 59.0, 57.0, 78.0, 85.0, 56.0], "value": 71.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 100.0, 134.0, 78.0, 78.0, 79.0, 119.0, 81.0, 78.0, 126.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 86.0, 84.0, 87.0, 84.0, 87.0, 85.0, 90.0, 83.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 102.0, 94.0, 93.0, 93.0, 94.0, 93.0, 93.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 133.0, 135.0, 84.0, 87.0, 86.0, 84.0, 102.0, 132.0, 119.0], "value": 106.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 58.0, 57.0, 58.0, 58.0, 73.0, 59.0, 56.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 77.0, 73.0, 73.0, 69.0, 70.0, 68.0, 70.0, 68.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 86.0, 85.0, 85.0, 82.0, 73.0, 85.0, 98.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 143.0, 142.0, 143.0, 143.0, 141.0, 141.0, 142.0, 222.0, 144.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 216.0, 209.0, 169.0, 169.0, 169.0, 195.0, 210.0, 184.0, 168.0], "value": 186.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 81.0, 92.0, 91.0, 93.0, 93.0, 71.0, 69.0, 69.0], "value": 79.4, "unit": "score"}], "name": "kraken", "value": 1531.4, "alertThreshold": 2.0}]} 16:54:46 INFO - Return code: 0 16:54:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:54:47 ERROR - # TBPL SUCCESS # 16:54:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:54:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:54:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:54:47 INFO - 2016-04-14 16:54:47.017 screenresolution[1677:10016] starting screenresolution argv=screenresolution get 16:54:47 INFO - 2016-04-14 16:54:47.020 screenresolution[1677:10016] Display 0: 1600x1200x32@60 16:54:47 INFO - 2016-04-14 16:54:47.026 screenresolution[1678:10019] starting screenresolution argv=screenresolution list 16:54:47 INFO - Available Modes on Display 0 16:54:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:54:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:54:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:54:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:54:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:54:47 INFO - Intel Iris: 16:54:47 INFO - Chipset Model: Intel Iris 16:54:47 INFO - Type: GPU 16:54:47 INFO - Bus: Built-In 16:54:47 INFO - VRAM (Dynamic, Max): 1536 MB 16:54:47 INFO - Vendor: Intel (0x8086) 16:54:47 INFO - Device ID: 0x0a2e 16:54:47 INFO - Revision ID: 0x0009 16:54:47 INFO - Displays: 16:54:47 INFO - Display: 16:54:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:54:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:54:47 INFO - Display Serial Number: 1600x1200 60 16:54:47 INFO - Main Display: Yes 16:54:47 INFO - Mirror: Off 16:54:47 INFO - Online: Yes 16:54:47 INFO - Rotation: Supported 16:54:47 INFO - Return code: 0 16:54:47 INFO - Running post-action listener: _resource_record_post_action 16:54:47 INFO - Running post-run listener: _resource_record_post_run 16:54:48 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 37549568; Write bytes: 695706624; Read time: 388; Write time: 1905 16:54:48 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 387906048; Write bytes: 383092736; Read time: 28516; Write time: 760 16:54:48 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 35735040; Write bytes: 297196544; Read time: 368; Write time: 1113 16:54:48 INFO - Running post-run listener: _upload_blobber_files 16:54:48 INFO - Blob upload gear active. 16:54:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:54:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:54:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:54:48 INFO - (blobuploader) - INFO - Open directory for files ... 16:54:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:54:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:54:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:54:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:54:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:54:49 INFO - (blobuploader) - INFO - Done attempting. 16:54:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:54:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:54:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:54:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:54:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:54:52 INFO - (blobuploader) - INFO - Done attempting. 16:54:52 INFO - (blobuploader) - INFO - Iteration through files over. 16:54:52 INFO - Return code: 0 16:54:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:54:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:54:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e861cd4d6a59ab9505e0b446057eedcc8a688d8733965b7b1fa2f60fb41c35a4d882990cc9d2646095b3468b27aa1dc02877f9aee676d3ab6d3d37ae115f866d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9982bd173c2323a8473b7995f69ba98b7e654ad9a22529e48e6f600667f0295b6990c729d3d9ac218ae267c5bbaad0d7566e3583723fc337f9abf8a18f3eda68"} 16:54:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:54:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:54:52 INFO - Contents: 16:54:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e861cd4d6a59ab9505e0b446057eedcc8a688d8733965b7b1fa2f60fb41c35a4d882990cc9d2646095b3468b27aa1dc02877f9aee676d3ab6d3d37ae115f866d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9982bd173c2323a8473b7995f69ba98b7e654ad9a22529e48e6f600667f0295b6990c729d3d9ac218ae267c5bbaad0d7566e3583723fc337f9abf8a18f3eda68"} 16:54:52 INFO - Running post-run listener: copy_logs_to_upload_dir 16:54:52 INFO - Copying logs to upload dir... 16:54:52 INFO - mkdir: /builds/slave/test/build/upload/logs 16:54:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.587220 ========= master_lag: 1.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-14 16:54:53.355926) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-14 16:54:53.360650) ========= 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.jHyzxlqDvm/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.NIHnznA2kK/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e861cd4d6a59ab9505e0b446057eedcc8a688d8733965b7b1fa2f60fb41c35a4d882990cc9d2646095b3468b27aa1dc02877f9aee676d3ab6d3d37ae115f866d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9982bd173c2323a8473b7995f69ba98b7e654ad9a22529e48e6f600667f0295b6990c729d3d9ac218ae267c5bbaad0d7566e3583723fc337f9abf8a18f3eda68"} build_url:https://queue.taskcluster.net/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/RsCum-53QiqcsL7WFVVdrA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e861cd4d6a59ab9505e0b446057eedcc8a688d8733965b7b1fa2f60fb41c35a4d882990cc9d2646095b3468b27aa1dc02877f9aee676d3ab6d3d37ae115f866d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9982bd173c2323a8473b7995f69ba98b7e654ad9a22529e48e6f600667f0295b6990c729d3d9ac218ae267c5bbaad0d7566e3583723fc337f9abf8a18f3eda68"}' ========= master_lag: 1.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-14 16:54:54.476012) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:54:54.479344) ========= 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.jHyzxlqDvm/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.NIHnznA2kK/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.005159 ========= master_lag: 0.34 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:54:54.825553) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 16:54:54.825843) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 16:54:55.033195) ========= ========= Total master_lag: 2.83 =========