builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0104 starttime: 1471620454.85 results: success (0) buildid: 20160819065122 builduid: 9825f0f0cf6e41e59bb4fe63f9186638 revision: 60f05a3d215f726f21ce60c8e7f7f7dc66265857 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 08:27:34.847235) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 08:27:34.847680) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 08:27:34.847961) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 08:27:34.874290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:27:34.874956) ========= 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.m6XOMx2yKC/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.dLO0qy0ZH0/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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-08-19 08:27:34-- 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% 9.46M=0.001s 2016-08-19 08:27:34 (9.46 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082401 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:27:34.984992) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:27:34.985665) ========= 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.m6XOMx2yKC/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.dLO0qy0ZH0/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.031295 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:27:35.039449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 08:27:35.039770) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 60f05a3d215f726f21ce60c8e7f7f7dc66265857 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 60f05a3d215f726f21ce60c8e7f7f7dc66265857 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.m6XOMx2yKC/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.dLO0qy0ZH0/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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-08-19 08:27:35,115 truncating revision to first 12 chars 2016-08-19 08:27:35,115 Setting DEBUG logging. 2016-08-19 08:27:35,115 attempt 1/10 2016-08-19 08:27:35,115 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/60f05a3d215f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 08:27:36,201 unpacking tar archive at: autoland-60f05a3d215f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.332127 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 08:27:36.399737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 08:27:36.400068) ========= script_repo_revision: 60f05a3d215f726f21ce60c8e7f7f7dc66265857 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 08:27:36.400493) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 08:27:36.400809) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 08:27:36.420933) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-08-19 08:27:36.421246) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.m6XOMx2yKC/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.dLO0qy0ZH0/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 08:27:36 INFO - MultiFileLogger online at 20160819 08:27:36 in /builds/slave/test 08:27:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 08:27:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:27:36 INFO - {'append_to_log': False, 08:27:36 INFO - 'base_work_dir': '/builds/slave/test', 08:27:36 INFO - 'blob_upload_branch': 'Autoland', 08:27:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:27:36 INFO - 'branch': 'Autoland', 08:27:36 INFO - 'buildbot_json_path': 'buildprops.json', 08:27:36 INFO - 'config_files': ('talos/mac_config.py',), 08:27:36 INFO - 'default_actions': ('clobber', 08:27:36 INFO - 'read-buildbot-config', 08:27:36 INFO - 'download-and-extract', 08:27:36 INFO - 'populate-webroot', 08:27:36 INFO - 'create-virtualenv', 08:27:36 INFO - 'install', 08:27:36 INFO - 'run-tests'), 08:27:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:27:36 INFO - 'download_minidump_stackwalk': True, 08:27:36 INFO - 'download_symbols': 'ondemand', 08:27:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:27:36 INFO - 'tooltool.py': '/tools/tooltool.py', 08:27:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:27:36 INFO - '/tools/misc-python/virtualenv.py')}, 08:27:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:27:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:27:36 INFO - 'installer_path': 'installer.exe', 08:27:36 INFO - 'log_level': 'info', 08:27:36 INFO - 'log_name': 'talos', 08:27:36 INFO - 'log_to_console': True, 08:27:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:27:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:27:36 INFO - 'opt_config_files': (), 08:27:36 INFO - 'pip_index': False, 08:27:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:27:36 INFO - 'cmd': ('bash', 08:27:36 INFO - '-c', 08:27:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:27:36 INFO - 'enabled': True, 08:27:36 INFO - 'halt_on_failure': False, 08:27:36 INFO - 'name': 'check_screen_resolution'},), 08:27:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:27:36 INFO - 'cmd': ('bash', 08:27:36 INFO - '-c', 08:27:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:27:36 INFO - 'enabled': True, 08:27:36 INFO - 'halt_on_failure': False, 08:27:36 INFO - 'name': 'check_screen_resolution'},), 08:27:36 INFO - 'run_cmd_checks_enabled': True, 08:27:36 INFO - 'sps_profile': False, 08:27:36 INFO - 'sps_profile_interval': 0, 08:27:36 INFO - 'suite': 'dromaeojs', 08:27:36 INFO - 'system_bits': '32', 08:27:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:27:36 INFO - 'title': 't-yosemite-r7-0104', 08:27:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:27:36 INFO - 'use_talos_json': True, 08:27:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:27:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:27:36 INFO - 'work_dir': 'build'} 08:27:36 INFO - [mozharness: 2016-08-19 15:27:36.619530Z] Running clobber step. 08:27:36 INFO - Running pre-action listener: _resource_record_pre_action 08:27:36 INFO - Running main action method: clobber 08:27:36 INFO - rmtree: /builds/slave/test/build 08:27:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:27:38 INFO - Running post-action listener: _resource_record_post_action 08:27:38 INFO - [mozharness: 2016-08-19 15:27:38.695101Z] Finished clobber step (success) 08:27:38 INFO - [mozharness: 2016-08-19 15:27:38.695225Z] Running read-buildbot-config step. 08:27:38 INFO - Running pre-action listener: _resource_record_pre_action 08:27:38 INFO - Running main action method: read_buildbot_config 08:27:38 INFO - Using buildbot properties: 08:27:38 INFO - { 08:27:38 INFO - "project": "", 08:27:38 INFO - "product": "firefox", 08:27:38 INFO - "script_repo_revision": "production", 08:27:38 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 08:27:38 INFO - "repository": "", 08:27:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 08:27:38 INFO - "buildid": "20160819065122", 08:27:38 INFO - "pgo_build": "False", 08:27:38 INFO - "basedir": "/builds/slave/test", 08:27:38 INFO - "buildnumber": 145, 08:27:38 INFO - "slavename": "t-yosemite-r7-0104", 08:27:38 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:27:38 INFO - "platform": "yosemite_r7", 08:27:38 INFO - "scheduler": "tests-autoland-macosx64-talos", 08:27:38 INFO - "branch": "autoland", 08:27:38 INFO - "repo_path": "integration/autoland", 08:27:38 INFO - "revision": "60f05a3d215f726f21ce60c8e7f7f7dc66265857", 08:27:38 INFO - "stage_platform": "macosx64", 08:27:38 INFO - "builduid": "9825f0f0cf6e41e59bb4fe63f9186638", 08:27:38 INFO - "slavebuilddir": "test" 08:27:38 INFO - } 08:27:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 08:27:38 INFO - Running post-action listener: _resource_record_post_action 08:27:38 INFO - [mozharness: 2016-08-19 15:27:38.698812Z] Finished read-buildbot-config step (success) 08:27:38 INFO - [mozharness: 2016-08-19 15:27:38.698944Z] Running download-and-extract step. 08:27:38 INFO - Running pre-action listener: _resource_record_pre_action 08:27:38 INFO - Running main action method: download_and_extract 08:27:38 INFO - mkdir: /builds/slave/test/build/tests 08:27:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:38 INFO - trying https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 08:27:38 INFO - Downloading https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:27:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 08:27:39 INFO - Downloaded 1199 bytes. 08:27:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:27:39 INFO - Using the following test package requirements: 08:27:39 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:27:39 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:27:39 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 08:27:39 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:27:39 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 08:27:39 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:27:39 INFO - u'jsshell-mac.zip'], 08:27:39 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:27:39 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 08:27:39 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:27:39 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:27:39 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 08:27:39 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:27:39 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 08:27:39 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:27:39 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 08:27:39 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:27:39 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 08:27:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:27:39 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:39 INFO - trying https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:27:39 INFO - Downloading https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:27:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:27:40 INFO - Downloaded 16339431 bytes. 08:27:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 08:27:47 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:47 INFO - trying https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:27:47 INFO - Downloading https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:27:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:27:52 INFO - Downloaded 16339431 bytes. 08:27:52 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 08:27:59 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:59 INFO - trying https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:27:59 INFO - Downloading https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:28:00 INFO - Downloaded 14413981 bytes. 08:28:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 08:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:01 INFO - trying https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:28:01 INFO - Downloading https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 08:28:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 08:28:04 INFO - Downloaded 111275417 bytes. 08:28:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:28:04 INFO - mkdir: /builds/slave/test/properties 08:28:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:28:04 INFO - Writing to file /builds/slave/test/properties/build_url 08:28:04 INFO - Contents: 08:28:04 INFO - build_url:https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:28:05 INFO - Running post-action listener: _resource_record_post_action 08:28:05 INFO - Running post-action listener: set_extra_try_arguments 08:28:05 INFO - [mozharness: 2016-08-19 15:28:05.188286Z] Finished download-and-extract step (success) 08:28:05 INFO - [mozharness: 2016-08-19 15:28:05.188391Z] Running populate-webroot step. 08:28:05 INFO - Running pre-action listener: _resource_record_pre_action 08:28:05 INFO - Running main action method: populate_webroot 08:28:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:28:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:28:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:28:05 INFO - '--tppagecycles', 08:28:05 INFO - '7'], 08:28:05 INFO - 'tests': ['tsvgm']}}, 08:28:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:28:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:28:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:28:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:28:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:28:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:28:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:05 INFO - 'talos_options': ['--disable-e10s'], 08:28:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:05 INFO - 'talos_options': ['--disable-e10s'], 08:28:05 INFO - 'tests': ['damp', 'tps']}, 08:28:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:05 INFO - 'tests': ['damp', 'tps']}, 08:28:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:28:05 INFO - 'tests': ['dromaeo_dom']}, 08:28:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:28:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:28:05 INFO - 'tests': ['basic_compositor_video']}, 08:28:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:28:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:28:05 INFO - 'tests': ['a11yr', 08:28:05 INFO - 'ts_paint', 08:28:05 INFO - 'tpaint', 08:28:05 INFO - 'sessionrestore', 08:28:05 INFO - 'sessionrestore_no_auto_restore', 08:28:05 INFO - 'tabpaint']}, 08:28:05 INFO - 'other-e10s': {'tests': ['a11yr', 08:28:05 INFO - 'ts_paint', 08:28:05 INFO - 'tpaint', 08:28:05 INFO - 'sessionrestore', 08:28:05 INFO - 'sessionrestore_no_auto_restore', 08:28:05 INFO - 'tabpaint']}, 08:28:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:28:05 INFO - 'ts_paint', 08:28:05 INFO - 'tpaint', 08:28:05 INFO - 'sessionrestore', 08:28:05 INFO - 'sessionrestore_no_auto_restore', 08:28:05 INFO - 'tabpaint']}, 08:28:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:28:05 INFO - 'ts_paint', 08:28:05 INFO - 'tpaint', 08:28:05 INFO - 'sessionrestore', 08:28:05 INFO - 'sessionrestore_no_auto_restore', 08:28:05 INFO - 'tabpaint']}, 08:28:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:28:05 INFO - 'tests': ['a11yr', 08:28:05 INFO - 'ts_paint', 08:28:05 INFO - 'tpaint', 08:28:05 INFO - 'sessionrestore', 08:28:05 INFO - 'sessionrestore_no_auto_restore', 08:28:05 INFO - 'tabpaint']}, 08:28:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:28:05 INFO - 'tests': ['a11yr', 08:28:05 INFO - 'ts_paint', 08:28:05 INFO - 'tpaint', 08:28:05 INFO - 'sessionrestore', 08:28:05 INFO - 'sessionrestore_no_auto_restore', 08:28:05 INFO - 'tabpaint']}, 08:28:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:28:05 INFO - 'tests': ['tsvgx', 08:28:05 INFO - 'tsvgr_opacity', 08:28:05 INFO - 'tart', 08:28:05 INFO - 'tscrollx', 08:28:05 INFO - 'cart']}, 08:28:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:28:05 INFO - 'tsvgr_opacity', 08:28:05 INFO - 'tart', 08:28:05 INFO - 'tscrollx', 08:28:05 INFO - 'cart']}, 08:28:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:05 INFO - 'talos_options': ['--disable-e10s'], 08:28:05 INFO - 'tests': ['tp5o']}, 08:28:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:05 INFO - 'tests': ['tp5o']}, 08:28:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:05 INFO - 'talos_options': ['--disable-e10s', 08:28:05 INFO - '--xperf_path', 08:28:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:05 INFO - 'tests': ['tp5n']}, 08:28:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:05 INFO - 'talos_options': ['--xperf_path', 08:28:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:05 INFO - 'tests': ['tp5n']}}, 08:28:05 INFO - 'talos.zip': {'path': '', 08:28:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:28:05 INFO - Running post-action listener: _resource_record_post_action 08:28:05 INFO - [mozharness: 2016-08-19 15:28:05.207302Z] Finished populate-webroot step (success) 08:28:05 INFO - [mozharness: 2016-08-19 15:28:05.207433Z] Running create-virtualenv step. 08:28:05 INFO - Running pre-action listener: _resource_record_pre_action 08:28:05 INFO - Running main action method: create_virtualenv 08:28:05 INFO - Creating virtualenv /builds/slave/test/build/venv 08:28:05 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 08:28:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:28:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:28:05 INFO - Using real prefix '/tools/python27' 08:28:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:28:06 INFO - Installing distribute.............................................................................................................................................................................................done. 08:28:08 INFO - Installing pip.................done. 08:28:08 INFO - Return code: 0 08:28:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:28:08 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:08 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:08 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 0x10f71da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d79c74f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f681d30>, '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 0x10f3e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f679b20>, '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.m6XOMx2yKC/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.dLO0qy0ZH0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 08:28:08 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 08:28:08 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 08:28:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m6XOMx2yKC/Render', 08:28:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:08 INFO - 'HOME': '/Users/cltbld', 08:28:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:08 INFO - 'LOGNAME': 'cltbld', 08:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:08 INFO - 'MOZ_NO_REMOTE': '1', 08:28:08 INFO - 'NO_EM_RESTART': '1', 08:28:08 INFO - 'PAGER': '/bin/cat', 08:28:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:08 INFO - 'PWD': '/builds/slave/test', 08:28:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:08 INFO - 'SHELL': '/bin/bash', 08:28:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLO0qy0ZH0/Listeners', 08:28:08 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 08:28:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:08 INFO - 'USER': 'cltbld', 08:28:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:08 INFO - 'XPC_FLAGS': '0x0', 08:28:08 INFO - 'XPC_SERVICE_NAME': '0', 08:28:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:09 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 08:28:09 INFO - Cleaning up... 08:28:09 INFO - Return code: 0 08:28:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:28:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:09 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f71da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d79c74f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f681d30>, '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 0x10f3e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f679b20>, '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.m6XOMx2yKC/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.dLO0qy0ZH0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 08:28:09 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>=3.1.1'] in /builds/slave/test/build 08:28:09 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>=3.1.1 08:28:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m6XOMx2yKC/Render', 08:28:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:09 INFO - 'HOME': '/Users/cltbld', 08:28:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:09 INFO - 'LOGNAME': 'cltbld', 08:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:09 INFO - 'MOZ_NO_REMOTE': '1', 08:28:09 INFO - 'NO_EM_RESTART': '1', 08:28:09 INFO - 'PAGER': '/bin/cat', 08:28:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:09 INFO - 'PWD': '/builds/slave/test', 08:28:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:09 INFO - 'SHELL': '/bin/bash', 08:28:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLO0qy0ZH0/Listeners', 08:28:09 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 08:28:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:09 INFO - 'USER': 'cltbld', 08:28:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:09 INFO - 'XPC_FLAGS': '0x0', 08:28:09 INFO - 'XPC_SERVICE_NAME': '0', 08:28:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:09 INFO - Downloading/unpacking psutil>=3.1.1 08:28:09 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 08:28:09 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 08:28:09 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 08:28:09 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 08:28:09 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 08:28:09 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 08:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:28:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:12 INFO - Installing collected packages: psutil 08:28:12 INFO - Running setup.py install for psutil 08:28:12 INFO - building 'psutil._psutil_osx' extension 08:28:12 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 08:28:13 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 08:28:13 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 08:28:13 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 08:28:13 INFO - building 'psutil._psutil_posix' extension 08:28:13 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 08:28:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:28:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:28:13 INFO - ^ 08:28:13 INFO - 1 warning generated. 08:28:13 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 08:28:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:13 INFO - Successfully installed psutil 08:28:13 INFO - Cleaning up... 08:28:14 INFO - Return code: 0 08:28:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:28: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f71da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d79c74f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f681d30>, '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 0x10f3e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f679b20>, '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.m6XOMx2yKC/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.dLO0qy0ZH0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 08:28: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:28: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 mozsystemmonitor==0.3 08:28:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m6XOMx2yKC/Render', 08:28:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:14 INFO - 'HOME': '/Users/cltbld', 08:28:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:14 INFO - 'LOGNAME': 'cltbld', 08:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:14 INFO - 'MOZ_NO_REMOTE': '1', 08:28:14 INFO - 'NO_EM_RESTART': '1', 08:28:14 INFO - 'PAGER': '/bin/cat', 08:28:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:14 INFO - 'PWD': '/builds/slave/test', 08:28:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:14 INFO - 'SHELL': '/bin/bash', 08:28:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLO0qy0ZH0/Listeners', 08:28:14 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 08:28:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:14 INFO - 'USER': 'cltbld', 08:28:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:14 INFO - 'XPC_FLAGS': '0x0', 08:28:14 INFO - 'XPC_SERVICE_NAME': '0', 08:28:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:28:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:28:16 INFO - Installing collected packages: mozsystemmonitor 08:28:16 INFO - Running setup.py install for mozsystemmonitor 08:28:17 INFO - Successfully installed mozsystemmonitor 08:28:17 INFO - Cleaning up... 08:28:17 INFO - Return code: 0 08:28:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:28:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:17 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f71da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d79c74f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f681d30>, '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 0x10f3e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f679b20>, '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.m6XOMx2yKC/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.dLO0qy0ZH0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 08:28:17 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==2.5.1'] in /builds/slave/test/build 08:28:17 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==2.5.1 08:28:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m6XOMx2yKC/Render', 08:28:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:17 INFO - 'HOME': '/Users/cltbld', 08:28:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:17 INFO - 'LOGNAME': 'cltbld', 08:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:17 INFO - 'MOZ_NO_REMOTE': '1', 08:28:17 INFO - 'NO_EM_RESTART': '1', 08:28:17 INFO - 'PAGER': '/bin/cat', 08:28:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:17 INFO - 'PWD': '/builds/slave/test', 08:28:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:17 INFO - 'SHELL': '/bin/bash', 08:28:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLO0qy0ZH0/Listeners', 08:28:17 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 08:28:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:17 INFO - 'USER': 'cltbld', 08:28:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:17 INFO - 'XPC_FLAGS': '0x0', 08:28:17 INFO - 'XPC_SERVICE_NAME': '0', 08:28:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:17 INFO - Downloading/unpacking jsonschema==2.5.1 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:28:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:28:20 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 08:28:20 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 08:28:20 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 08:28:20 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 08:28:20 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 08:28:20 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 08:28:20 INFO - Downloading functools32-3.2.3-2.tar.gz 08:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:28:20 INFO - warning: no files found matching '*.txt' 08:28:20 INFO - no previously-included directories found matching 'build' 08:28:20 INFO - no previously-included directories found matching 'dist' 08:28:20 INFO - no previously-included directories found matching '.git*' 08:28:20 INFO - Installing collected packages: jsonschema, functools32 08:28:20 INFO - Running setup.py install for functools32 08:28:20 INFO - warning: no files found matching '*.txt' 08:28:20 INFO - no previously-included directories found matching 'build' 08:28:20 INFO - no previously-included directories found matching 'dist' 08:28:20 INFO - no previously-included directories found matching '.git*' 08:28:21 INFO - Successfully installed jsonschema functools32 08:28:21 INFO - Cleaning up... 08:28:21 INFO - Return code: 0 08:28:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:28:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:21 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f71da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d79c74f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f681d30>, '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 0x10f3e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f679b20>, '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.m6XOMx2yKC/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.dLO0qy0ZH0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 08:28:21 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:28:21 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 functools32==3.2.3-2 08:28:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m6XOMx2yKC/Render', 08:28:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:21 INFO - 'HOME': '/Users/cltbld', 08:28:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:21 INFO - 'LOGNAME': 'cltbld', 08:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:21 INFO - 'MOZ_NO_REMOTE': '1', 08:28:21 INFO - 'NO_EM_RESTART': '1', 08:28:21 INFO - 'PAGER': '/bin/cat', 08:28:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:21 INFO - 'PWD': '/builds/slave/test', 08:28:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:21 INFO - 'SHELL': '/bin/bash', 08:28:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLO0qy0ZH0/Listeners', 08:28:21 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 08:28:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:21 INFO - 'USER': 'cltbld', 08:28:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:21 INFO - 'XPC_FLAGS': '0x0', 08:28:21 INFO - 'XPC_SERVICE_NAME': '0', 08:28:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:28:21 INFO - Cleaning up... 08:28:21 INFO - Return code: 0 08:28:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:28:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:21 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 0x10f71da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d79c74f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f681d30>, '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 0x10f3e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f679b20>, '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.m6XOMx2yKC/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.dLO0qy0ZH0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 08:28:21 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 08:28:21 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 08:28:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m6XOMx2yKC/Render', 08:28:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:21 INFO - 'HOME': '/Users/cltbld', 08:28:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:21 INFO - 'LOGNAME': 'cltbld', 08:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:21 INFO - 'MOZ_NO_REMOTE': '1', 08:28:21 INFO - 'NO_EM_RESTART': '1', 08:28:21 INFO - 'PAGER': '/bin/cat', 08:28:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:21 INFO - 'PWD': '/builds/slave/test', 08:28:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:21 INFO - 'SHELL': '/bin/bash', 08:28:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLO0qy0ZH0/Listeners', 08:28:21 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 08:28:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:21 INFO - 'USER': 'cltbld', 08:28:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:21 INFO - 'XPC_FLAGS': '0x0', 08:28:21 INFO - 'XPC_SERVICE_NAME': '0', 08:28:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:21 INFO - Downloading/unpacking blobuploader==1.2.4 08:28:21 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 08:28:21 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 08:28:21 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 08:28:21 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 08:28:21 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 08:28:21 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 08:28:24 INFO - Downloading blobuploader-1.2.4.tar.gz 08:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:28:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:28:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:25 INFO - Downloading docopt-0.6.1.tar.gz 08:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:28:25 INFO - Installing collected packages: blobuploader, requests, docopt 08:28:25 INFO - Running setup.py install for blobuploader 08:28:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:28:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:28:25 INFO - Running setup.py install for requests 08:28:26 INFO - Running setup.py install for docopt 08:28:26 INFO - Successfully installed blobuploader requests docopt 08:28:26 INFO - Cleaning up... 08:28:26 INFO - Return code: 0 08:28:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:26 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 0x10f71da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d79c74f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f681d30>, '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 0x10f3e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f679b20>, '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.m6XOMx2yKC/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.dLO0qy0ZH0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 08:28:26 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 08:28:26 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 08:28:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m6XOMx2yKC/Render', 08:28:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:26 INFO - 'HOME': '/Users/cltbld', 08:28:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:26 INFO - 'LOGNAME': 'cltbld', 08:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:26 INFO - 'MOZ_NO_REMOTE': '1', 08:28:26 INFO - 'NO_EM_RESTART': '1', 08:28:26 INFO - 'PAGER': '/bin/cat', 08:28:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:26 INFO - 'PWD': '/builds/slave/test', 08:28:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:26 INFO - 'SHELL': '/bin/bash', 08:28:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLO0qy0ZH0/Listeners', 08:28:26 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 08:28:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:26 INFO - 'USER': 'cltbld', 08:28:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:26 INFO - 'XPC_FLAGS': '0x0', 08:28:26 INFO - 'XPC_SERVICE_NAME': '0', 08:28:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:28:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-8pxWyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:28:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-bDDBci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:28:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-3GvEm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:28:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-nR4aMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:28:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-gprmhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:28:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-2NQx5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-FkagmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:28:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-m8OlK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:28:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-sl0sFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:28:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-Vsmrh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:28:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-b_FXaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:28:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-U6KHwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:28:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-6y7w7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:28:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-rw9gCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-PeZLcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:28:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-HBdAXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:28:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-J_yFN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:28:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:28:28 INFO - Running setup.py install for manifestparser 08:28:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:28:29 INFO - Running setup.py install for mozcrash 08:28:29 INFO - Running setup.py install for mozdebug 08:28:29 INFO - Running setup.py install for mozdevice 08:28:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:28:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:28:29 INFO - Running setup.py install for mozfile 08:28:29 INFO - Running setup.py install for mozhttpd 08:28:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:28:29 INFO - Running setup.py install for mozinfo 08:28:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:28:29 INFO - Running setup.py install for mozInstall 08:28:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:28:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:28:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:28:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:28:30 INFO - Running setup.py install for mozleak 08:28:30 INFO - Running setup.py install for mozlog 08:28:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:28:30 INFO - Running setup.py install for moznetwork 08:28:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:28:30 INFO - Running setup.py install for mozprocess 08:28:30 INFO - Running setup.py install for mozprofile 08:28:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:28:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:28:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:28:30 INFO - Running setup.py install for mozrunner 08:28:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:28:30 INFO - Running setup.py install for mozscreenshot 08:28:31 INFO - Running setup.py install for moztest 08:28:31 INFO - Running setup.py install for mozversion 08:28:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:28:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:28:31 INFO - Cleaning up... 08:28:31 INFO - Return code: 0 08:28:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:31 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 0x10f71da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d79c74f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f681d30>, '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 0x10f3e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f679b20>, '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.m6XOMx2yKC/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.dLO0qy0ZH0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 08:28:31 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 08:28:31 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 08:28:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m6XOMx2yKC/Render', 08:28:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:31 INFO - 'HOME': '/Users/cltbld', 08:28:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:31 INFO - 'LOGNAME': 'cltbld', 08:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:31 INFO - 'MOZ_NO_REMOTE': '1', 08:28:31 INFO - 'NO_EM_RESTART': '1', 08:28:31 INFO - 'PAGER': '/bin/cat', 08:28:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:31 INFO - 'PWD': '/builds/slave/test', 08:28:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:31 INFO - 'SHELL': '/bin/bash', 08:28:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLO0qy0ZH0/Listeners', 08:28:31 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 08:28:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:31 INFO - 'USER': 'cltbld', 08:28:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:31 INFO - 'XPC_FLAGS': '0x0', 08:28:31 INFO - 'XPC_SERVICE_NAME': '0', 08:28:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:28:31 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-XCxbHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:28:31 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)) 08:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:28:31 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-lvSCif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:28:31 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)) 08:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:28:31 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-CrWCM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:28:32 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)) 08:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:28:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-JOZ6mM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:28:32 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)) 08:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:28:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-vA366M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:28:32 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)) 08:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:28:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-RoyCtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:32 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)) 08:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-NgVa0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:28:32 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)) 08:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:28:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-9y4d1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:28:32 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)) 08:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:28:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-bJ5iQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:28:32 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)) 08:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:28:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-WQVOk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:28:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 08:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:28:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-2LnE1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:28:32 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)) 08:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:28:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-jecJUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:28:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 08:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:28:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-SASq_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:28:33 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)) 08:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:28:33 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-tqHURK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 08:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:33 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-wrsPTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:33 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)) 08:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:28:33 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-LRbmzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:28:33 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)) 08:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:28:33 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-IPJpyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:28:33 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)) 08:28:33 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)) 08:28:33 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)) 08:28:33 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)) 08:28:33 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)) 08:28:33 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)) 08:28:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:36 INFO - Downloading blessings-1.6.tar.gz 08:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:28:36 INFO - Installing collected packages: blessings 08:28:36 INFO - Running setup.py install for blessings 08:28:36 INFO - Successfully installed blessings 08:28:36 INFO - Cleaning up... 08:28:36 INFO - Return code: 0 08:28:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:28:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:28:36 INFO - Reading from file tmpfile_stdout 08:28:36 INFO - Current package versions: 08:28:36 INFO - blessings == 1.6 08:28:36 INFO - blobuploader == 1.2.4 08:28:36 INFO - docopt == 0.6.1 08:28:36 INFO - functools32 == 3.2.3-2 08:28:36 INFO - jsonschema == 2.5.1 08:28:36 INFO - manifestparser == 1.1 08:28:36 INFO - mozInstall == 1.12 08:28:36 INFO - mozcrash == 0.17 08:28:36 INFO - mozdebug == 0.1 08:28:36 INFO - mozdevice == 0.48 08:28:36 INFO - mozfile == 1.2 08:28:36 INFO - mozhttpd == 0.7 08:28:36 INFO - mozinfo == 0.9 08:28:36 INFO - mozleak == 0.1 08:28:36 INFO - mozlog == 3.3 08:28:36 INFO - moznetwork == 0.27 08:28:36 INFO - mozprocess == 0.23 08:28:36 INFO - mozprofile == 0.28 08:28:36 INFO - mozrunner == 6.12 08:28:36 INFO - mozscreenshot == 0.1 08:28:36 INFO - mozsystemmonitor == 0.3 08:28:36 INFO - moztest == 0.7 08:28:36 INFO - mozversion == 1.4 08:28:36 INFO - psutil == 3.1.1 08:28:36 INFO - requests == 1.2.3 08:28:36 INFO - wsgiref == 0.1.2 08:28:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:36 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 0x10f71da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d79c74f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f681d30>, '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 0x10f3e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f679b20>, '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.m6XOMx2yKC/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.dLO0qy0ZH0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 08:28:36 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 08:28:36 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 08:28:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m6XOMx2yKC/Render', 08:28:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:36 INFO - 'HOME': '/Users/cltbld', 08:28:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:36 INFO - 'LOGNAME': 'cltbld', 08:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:36 INFO - 'MOZ_NO_REMOTE': '1', 08:28:36 INFO - 'NO_EM_RESTART': '1', 08:28:36 INFO - 'PAGER': '/bin/cat', 08:28:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:36 INFO - 'PWD': '/builds/slave/test', 08:28:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:36 INFO - 'SHELL': '/bin/bash', 08:28:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLO0qy0ZH0/Listeners', 08:28:36 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 08:28:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:36 INFO - 'USER': 'cltbld', 08:28:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:36 INFO - 'XPC_FLAGS': '0x0', 08:28:36 INFO - 'XPC_SERVICE_NAME': '0', 08:28:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:37 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)) 08:28:37 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)) 08:28:37 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)) 08:28:37 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)) 08:28:37 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)) 08:28:37 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)) 08:28:37 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)) 08:28:37 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)) 08:28:37 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)) 08:28:37 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)) 08:28:37 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)) 08:28:37 INFO - Cleaning up... 08:28:37 INFO - Return code: 0 08:28:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f71da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d79c74f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f681d30>, '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 0x10f3e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f679b20>, '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.m6XOMx2yKC/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.dLO0qy0ZH0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 08:28:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:28:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m6XOMx2yKC/Render', 08:28:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:37 INFO - 'HOME': '/Users/cltbld', 08:28:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:37 INFO - 'LOGNAME': 'cltbld', 08:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:37 INFO - 'MOZ_NO_REMOTE': '1', 08:28:37 INFO - 'NO_EM_RESTART': '1', 08:28:37 INFO - 'PAGER': '/bin/cat', 08:28:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:37 INFO - 'PWD': '/builds/slave/test', 08:28:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:37 INFO - 'SHELL': '/bin/bash', 08:28:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLO0qy0ZH0/Listeners', 08:28:37 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 08:28:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:37 INFO - 'USER': 'cltbld', 08:28:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:37 INFO - 'XPC_FLAGS': '0x0', 08:28:37 INFO - 'XPC_SERVICE_NAME': '0', 08:28:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:28:37 INFO - Cleaning up... 08:28:37 INFO - Return code: 0 08:28:37 INFO - Running post-action listener: _resource_record_post_action 08:28:37 INFO - Running post-action listener: _start_resource_monitoring 08:28:37 INFO - Starting resource monitoring. 08:28:37 INFO - [mozharness: 2016-08-19 15:28:37.427996Z] Finished create-virtualenv step (success) 08:28:37 INFO - [mozharness: 2016-08-19 15:28:37.428965Z] Running install step. 08:28:37 INFO - Running pre-action listener: _resource_record_pre_action 08:28:37 INFO - Running main action method: install 08:28:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:28:37 INFO - Reading from file tmpfile_stdout 08:28:37 INFO - Detecting whether we're running mozinstall >=1.0... 08:28:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:28:37 INFO - Reading from file tmpfile_stdout 08:28:37 INFO - Output received: 08:28:37 INFO - Usage: mozinstall [options] installer 08:28:37 INFO - Options: 08:28:37 INFO - -h, --help show this help message and exit 08:28:37 INFO - -d DEST, --destination=DEST 08:28:37 INFO - Directory to install application into. [default: 08:28:37 INFO - "/builds/slave/test"] 08:28:37 INFO - --app=APP Application being installed. [default: firefox] 08:28:37 INFO - mkdir: /builds/slave/test/build/application 08:28:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:29:11 INFO - Reading from file tmpfile_stdout 08:29:11 INFO - Output received: 08:29:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:29:11 INFO - Running post-action listener: _resource_record_post_action 08:29:11 INFO - [mozharness: 2016-08-19 15:29:11.610413Z] Finished install step (success) 08:29:11 INFO - [mozharness: 2016-08-19 15:29:11.610566Z] Running run-tests step. 08:29:11 INFO - Running pre-action listener: _resource_record_pre_action 08:29:11 INFO - Running main action method: run_tests 08:29:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:29:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:29:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:29:11 INFO - 2016-08-19 08:29:11.625 screenresolution[1628:7681] starting screenresolution argv=screenresolution get 08:29:11 INFO - 2016-08-19 08:29:11.628 screenresolution[1628:7681] Display 0: 1600x1200x32@60 08:29:11 INFO - 2016-08-19 08:29:11.634 screenresolution[1629:7683] starting screenresolution argv=screenresolution list 08:29:11 INFO - Available Modes on Display 0 08:29:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:29:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:29:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:29:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:29:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:29:11 INFO - Intel Iris: 08:29:11 INFO - Chipset Model: Intel Iris 08:29:11 INFO - Type: GPU 08:29:11 INFO - Bus: Built-In 08:29:11 INFO - VRAM (Dynamic, Max): 1536 MB 08:29:11 INFO - Vendor: Intel (0x8086) 08:29:11 INFO - Device ID: 0x0a2e 08:29:11 INFO - Revision ID: 0x0009 08:29:11 INFO - Displays: 08:29:11 INFO - Display: 08:29:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:29:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:29:11 INFO - Display Serial Number: 1600x1200 60 08:29:11 INFO - Main Display: Yes 08:29:11 INFO - Mirror: Off 08:29:11 INFO - Online: Yes 08:29:11 INFO - Rotation: Supported 08:29:11 INFO - Return code: 0 08:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:29:11 INFO - Python 2.7.3 08:29:11 INFO - Return code: 0 08:29:11 INFO - grabbing minidump binary from tooltool 08:29: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:11 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f681d30>, '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 0x10f3e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f679b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:29:11 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 08:29:11 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 08:29:11 INFO - Calling ['/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'] with output_timeout 600 08:29:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:29:11 INFO - Return code: 0 08:29:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:29:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:29:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:29:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:29:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0104', '--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 08:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0104 --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 08:29:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m6XOMx2yKC/Render', 08:29:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:11 INFO - 'HOME': '/Users/cltbld', 08:29:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:11 INFO - 'LOGNAME': 'cltbld', 08:29:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:29:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:11 INFO - 'MOZ_NO_REMOTE': '1', 08:29:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:29:11 INFO - 'NO_EM_RESTART': '1', 08:29:11 INFO - 'PAGER': '/bin/cat', 08:29:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:11 INFO - 'PWD': '/builds/slave/test', 08:29:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:29:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:11 INFO - 'SHELL': '/bin/bash', 08:29:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLO0qy0ZH0/Listeners', 08:29:11 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 08:29:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:11 INFO - 'USER': 'cltbld', 08:29:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:11 INFO - 'XPC_FLAGS': '0x0', 08:29:11 INFO - 'XPC_SERVICE_NAME': '0', 08:29:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0104', '--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 08:29:12 INFO - mozversion application_buildid: 20160819065122 08:29:12 INFO - mozversion application_changeset: 60f05a3d215f726f21ce60c8e7f7f7dc66265857 08:29:12 INFO - mozversion application_display_name: Nightly 08:29:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:29:12 INFO - mozversion application_name: Firefox 08:29:12 INFO - mozversion application_remotingname: firefox 08:29:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 08:29:12 INFO - mozversion application_vendor: Mozilla 08:29:12 INFO - mozversion application_version: 51.0a1 08:29:12 INFO - mozversion platform_buildid: 20160819065122 08:29:12 INFO - mozversion platform_changeset: 60f05a3d215f726f21ce60c8e7f7f7dc66265857 08:29:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 08:29:12 INFO - mozversion platform_version: 51.0a1 08:29:12 INFO - using testdate: 1471620552 08:29:12 INFO - actual date: 1471620552 08:29:12 INFO - starting webserver on 'localhost:49276' 08:29:12 INFO - SUITE-START | Running 2 tests 08:29:12 INFO - TEST-START | dromaeo_css 08:29:12 INFO - operating with platform_type : mac_ 08:29:12 INFO - Initialising browser for dromaeo_css test... 08:29:12 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmphBcM3p/profile http://localhost:49276/getInfo.html) 08:29:14 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 08:29:14 INFO - PROCESS | 1639 | colorDepth:24 08:29:14 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 08:29:14 INFO - PROCESS | 1639 | __metrics 08:29:14 INFO - PROCESS | 1639 | 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" 08:29:14 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:29:14 INFO - PROCESS | 1639 | ************************* 08:29:14 INFO - PROCESS | 1639 | A coding exception was thrown in a Promise resolution callback. 08:29:14 INFO - PROCESS | 1639 | See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise 08:29:14 INFO - PROCESS | 1639 | 08:29:14 ERROR - PROCESS | 1639 | Full message: TypeError: win is null 08:29:14 INFO - PROCESS | 1639 | Full stack: onSuccess@resource://app/components/nsBrowserGlue.js:758:17 08:29:14 INFO - PROCESS | 1639 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 08:29:14 INFO - PROCESS | 1639 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 08:29:14 INFO - PROCESS | 1639 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 08:29:14 INFO - PROCESS | 1639 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 08:29:14 INFO - PROCESS | 1639 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 08:29:14 INFO - PROCESS | 1639 | get _worker/worker.onmessage@resource://gre/modules/PromiseWorker.jsm:235:9 08:29:14 INFO - PROCESS | 1639 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 08:29:14 INFO - PROCESS | 1639 | 08:29:14 INFO - PROCESS | 1639 | ************************* 08:29:15 INFO - TEST-INFO | 1639: exit 0 08:29:15 INFO - Browser initialized. 08:29:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:29:15 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmphBcM3p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:27 INFO - PROCESS | 1641 | RSS: Main: 247296000 08:29:27 INFO - PROCESS | 1641 | 08:30:18 INFO - PROCESS | 1641 | 1471620618875 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] 08:32:30 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 08:32:31 INFO - PROCESS | 1641 | RSS: Main: 402878464 08:32:31 INFO - PROCESS | 1641 | 08:35:34 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 08:35:35 INFO - PROCESS | 1641 | RSS: Main: 390483968 08:35:35 INFO - PROCESS | 1641 | 08:38:37 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 08:38:38 INFO - PROCESS | 1641 | RSS: Main: 379338752 08:38:38 INFO - PROCESS | 1641 | 08:41:40 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 08:41:41 INFO - PROCESS | 1641 | RSS: Main: 353357824 08:41:41 INFO - PROCESS | 1641 | 08:44:44 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 08:44:45 INFO - PROCESS | 1641 | RSS: Main: 342487040 08:44:45 INFO - PROCESS | 1641 | 08:47:48 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 08:47:48 INFO - PROCESS | 1641 | RSS: Main: 502091776 08:47:48 INFO - PROCESS | 1641 | 08:47:48 INFO - PROCESS | 1641 | __start_tp_report 08:47:48 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 08:47:48 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 08:47:48 INFO - PROCESS | 1641 | |i|pagename|runs| 08:47:48 INFO - PROCESS | 1641 | |0;dojo.html;3310.6689331066887;3344.130526063223;3352.27925995911;3371.0279486500403;3401.5067815166803;5689.118186681071;5737.713114344282;5795.623284486505;5812.564057695674;5882.705864706763;5774.595778295521;5826.096954971986;5880.7059647017695;5927.585069045169;5973.402659734024;5213.452587478317;5231.476852314776;5279;5291.735413229342;5390.407055223922;5409.404965453797;5410.702411367373;5415.296011518517;5422.91865622016;5451.509364157225;5223.869403264911;5283.418823929364;5289.68261904287;5334.439883812182;5383.4616538346245;5306.469353064701;5313.043652142613;5317.548008419289;5319.654222475566;5336.653117547347;5239;5271.815486457994;5277.234800953878;5295.523402893758;5327.786888524454;5785.884282314372;5838.737256823453;5862.882742345172;5923.259592550931;5950.523958083343;6305.33793951633;6367.235931688181;6371.96814015927;6374.107624932513;6377.043443483514;5256.8685782855355;6223.533235007348;6283.874322513524;6311.495080393557;6331.2719037310835;5981.5214782817275;6010.639361638272;6037.698115094227;6043.909341359927;6049.334573196945;6257.812265632038;6352.14246076783;6357.650329231937;6370.108184854124;6377.936220637827;6199.473044791243;6219.875602487925;6236.906446403307;6313.147725057151;6319.462845658079;6345.714442850082;6356.904646430307;6365.872682546323;6369;6375.681215939185;6099.9390006099375;6328.335524769925;6347.301796802348;6350.7777227796805;6356.11014457967;6188.381161883775;6209.6895155242055;6216.160818289473;6245.250569931637;6255.906161407583;5067.391912970467;5069.493050694901;5073.213651883964;5074.619403544749;5117.667351622133;4507.323901414814;4523.7285762854335;4526.434195725535;4532.9320060199125;4584.15193189261;5743.770249189985;5775.191473193756;5868.911966320508;5900.291964964232;5931.58478906481;6259.655718935411;6300.243970723451;6310.05349197624;6310.9368906311265;6316.9368306317265;5943.218105642771;5947.940520594739;5968.701564921824;6005.969970150121;6011.428914253139;5390.164524498709;5462.0441422751655;5487.204355368449;5497.752601132958;5584.134459158756;6376.082482426882;6420.325865784025;6438.098666186831;6438.969764837697;6443.71003304843;6286.277078136073;6298.370162983665;6301.338359472189;6315.55791094619;6319.494440444661;6254.437100660963;6272.435480806749;6287.088372185916;6305.905411418924;6399.840003999751;6245.843853903689;6297.811065668037;6299.590526615755;6303.275123360872;6307.400796924285;5243.528082472596;6187.16473276102;6260.342664020394;6270.843228919313;6285.057241413641;5943.167956486009;6070.089486577049;6111.622125543816;6168.444839964245;6179.28938172116;6235.781747638811;6239.532035097295;6245.0632405139595;6245.250569931637;6255.843603909939;6153.476954458921;6154.569180157346;6161.938380616137;6166.075088736726;6176.7838125665385;6049.6067755597505;6145.938540614537;6191.00943848982;6192.59748116371;6264.342244064308;6133.55861372586;6149.661768602769;6156.661383623944;6164.938350616437;6166.784162554289 08:47:48 INFO - PROCESS | 1641 | |1;ext.html;499.80757408397756;512.1063743767126;532.2973674749331;538.2733310031456;549.1159233633849;31348.84325578372;31537.21156971074;33060.83469582649;41305.58694413055;42314;43741;44175.558244417625;44252.77873610635;44258.33612495815;44323.556764432346;8732.607032683512;9135.908640913573;9721.999999999982;9889.06053924876;9892.159166470823;8765.7808554786;8945.373823832335;8952.955235223815;9718.514074296292;9835.164011059069;8886.555672216396;8938.106189381042;12160.087993400486;12455.564055258068;12470.875291247063;12102.152849300552;12177.51289948401;12180.390980451031;12186.720394358643;12198.329091899943;11957.461914213794;12045.698857528545;12061.87938120625;12069;12093.879061209363;41350.79324603358;41737.58262417398;41738;41754;41763.7911810442;3458.239187378773;3686.189038411545;3693.778373297611;3962.7424217426064;4135.345861655332;31411.329376412355;31894.521582176287;32001.51997720036;32185.517217241526;32983.17542061444;3018.109657650998;3018.3208778024987;3049.237690577356;3100.069979006289;3118.7193152616373;384437;385075;385102;386869.06565466995;392407;59686;60051;60104;60161.699191503765;60303;28783.56824647632;34808.30383392318;35522.28955420877;36510.63489365125;63898;16454.42409515685;16582;16598.336066557204;16599.50201493933;16638.667226655398;12679.175853569488;12744.681382965315;12772.169808962388;12786.808197877039;12790.872091279154;16699.833001669827;19295.110449242988;19420.708689369672;19528.218871245273;19549.924754138658;6640.634765087966;7332.340089391981;7651.813968834839;8285.130061343472;8348.916510834935;881.9206271435473;941.3222479814523;952.4237836109054;954.3033585482636;1099.164634877483;25409.639995215708;31277.374452510823;31311.686883131333;31333.686663133078;31962.360752784814;1046.6127532812757;1086.9184811139196;1090.8854570270166;1093.5953697131954;1152.176194021279;13711.451541938211;15223.520738061914;16139.838601614068;16179.867409281473;16182.75725864113;655980;657902;665684;667977;669460.0539945966;60630;61104;61193.16420507303;61262.77474450486;61574.768504629654;1376.7521846067605;1396.0506855338265;1416.9504067357593;1420.552525954321;1421.1118051217989;29315.70684293215;29953.70046299509;30942.071737847902;30999.84500077485;31435;53014.46985530095;53330.73334633302;53399;53486.930261393776;53711;479072;546127;566730;574380;580390.098049507;26646.934122634877;26915;27031.1890643281;27188.728112718618;27211;35880.46179307365;40111.796646100665;49786;50379;51248.74375628098;38592;39989.80005099956;40230.1953960925;41164.58835411607;41356;39665.801670992616;40239.597604024755;40278.59721402748;41511.169776604904;41856.37215441831;38001.61998380091;39212.41181382338;39484.21031579295;39486.80256598814;39660.40509392419;29170.416591668472;30695.772169112985;35096.47355289622;35812.462813058344;36115.458268125476;20674.793252067888;22611.886940565193;22992;24700.58982305337;25873.870630646725 08:47:48 INFO - PROCESS | 1641 | |2;jquery.html;315.76475525733326;351.7818952249606;367.69113944286795;372.54549449671396;397.02728315626723;15558;17647.205875735606;20789.025042620928;20917.267895623656;21040.263590774306;20452.795472045276;20647;20962.475938101517;21309;21365.465863353384;5069.417017043042;5475.233467314579;6208.844778880519;6246.937530624681;6262.655553944532;5979.701014949257;6176.691165441733;6181.969090154543;6183.443490085891;6185.072239164117;5935.762569497215;6050.727717252734;6073.240844894388;6127.1728316677345;6162.414570615784;6008.579399442041;6117.418845209698;6131.969340153293;6169.938300616981;6174.876502469948;5236.083685355085;5262.815801446931;5312.681239125664;5320.65415747979;5326.174442961347;25294.494110117877;25978.83095260718;26094.608580871303;26234;26502.204933852016;2274.7042884425086;2486.018022880952;2504.5241404133158;2570.177543186181;3025.5461680747844;15429.30568124437;15572.844271557253;15615.609609759733;15892.046477211405;16046.679066418723;1721.9655606887793;1830.7803063632316;1846.6583682018736;1923.8916440301984;1942.4366933589242;118699;120860;121472;122009.38995305056;122845.99999999911;10422;10968.341899486057;11023.889761102446;11024.614138505114;11198;13796.310184490736;13801.964852635892;13812.447502099803;13817.447302108005;13817.516386926409;7157.57054576727;8213.753587392388;8444.113368096261;8647.740567782977;8656.956715216384;6964.373206411447;8662.913370866338;8832.911670883337;8838.29293656506;8839.734807955772;6476.352364763486;6607.933920660828;6610.372014658696;6612.206535215805;6623.172103487064;1586.2623879895673;1802.8467580255563;1819.3450357871156;1834.147121588441;1834.605699668235;823.9011318641682;878.767126711422;892.683097500378;897.9640814367352;938.596403546468;19329.51676208078;21555.461113472287;22276.331710048726;22460;22573.01815019021;940.4639355567261;949.8100379924043;970.315927271272;990.1484723138095;992.5682328187262;8962.955185224033;10574.731032276177;10847.566097356017;11913.28520288768;11942.880571194351;578606;597439;610148;626806;631291;99640;132105;140288;142389.01638442604;143181;964.2093483343731;1008.0927165551062;1019.5259204469957;1022.4172221833484;1034.0383443397561;19433.611327773084;19616.803831961497;19729.309474168334;19919.418533737033;19929.501762456053;51455.48544514507;52528.21207681811;55138.89722205613;56415.589610260075;56706.716466417405;56631;74129.8880516782;77501.61249193718;78240;80786.59606701929;7324.633768311456;7697.461177717506;7886.763397098096;7940.444168908121;7957.880631790644;10353.378797272188;12225;12280.263184208976;12589.748205035665;12705.745885082431;10773.784524309627;11044.944775276072;11198.776024479628;11379;11431.714207144887;10661.89338106609;10727.088197503299;10971.890281097087;10988.175886808682;11050.613228536962;10566.207534434794;10807.35155890649;10998.285111467729;11020.969233460863;11352.545898164311;6875.724971001304;7159.892601610876;7185.820354491179;8014.038315402189;8139.1453897339925;10732.356058636507;10738.40938748345;10889.21442594197;11184.273022253528;11200.38397888124 08:47:48 INFO - PROCESS | 1641 | |3;mootools.html;1520.680657062017;1555.9688806223876;1694.822043685413;1802.3241284518306;1837.751903493028;8444.704435344764;8960.731178064652;8973.865392019117;8978.191962723362;8984.91015089849;7807.258310460497;8053.355731541477;8298.585070746469;8634.266087382564;8662;2000.3098930868828;2312.456572705417;2358.2453614843257;2371.21749822559;2380.4881950380664;2340.707411573553;2350.388898886293;2388.020911426307;2389.880505974703;2395.6765836612094;2362.9645555316683;2376.92869213923;2388.319328991229;2389.940251493709;2395.4849707312924;2340.8127349811975;2358.351453350334;2368.27767530903;2378.821588380861;2379.381360846175;2330.278234030193;2356.516914032636;2357.481354102095;2357.481354102095;2359.398353419884;8635.050144484101;8774.956125219396;8793.252573531257;8798.340124490625;8812.16284452976;4487.618552423048;5218.191180367011;5349.251104845324;5349.973250133763;5359.651622644555;3619.3847046002243;3621.746477746559;3690.7970061646597;3704.01843511467;3727.4781530585738;1079.8110330692098;1086.896744809242;1086.8967448092499;1103.8068338040812;1113.092829344082;11551.768964620745;11617.535298588047;11717.941410292979;11731.354775487345;11759.529618815237;4418.33724941255;4598.540145985375;4677.368555245066;4817.373741413594;4824.059308434892;9989.650362237433;9997.80004399908;9998.650047248311;10014.79970400588;10020.799584008279;5275.657082289639;5283.762230699551;5286.995470860525;5291.1798671206025;5292.841214763564;4290.485141783006;4384.934225986613;4548.226801443762;4552.248878934939;4821.855344339676;3898.2593307271527;3930.7838068906485;4014.8193331300163;4027.2750904836826;4056.634902858698;1267.2713189915835;1290.1936289818864;1290.9736759276398;1301.342821874966;1302.0885380233874;850.2560259772699;870.2820173356879;918.6784625381197;943.3396622364236;946.9526523673788;5836.270466191726;5993.640381577119;6018.849528761816;6148.784792532329;6173.876522469525;754.1817128415621;876.6975393489236;901.833160865242;960.4717405426987;981.3817295104038;4001.9599804001587;4004;4064.9187016260103;4117.300058989979;4166.854115118366;9655.517224138765;10334.483275836179;10505.212109091848;10893.673189804318;10896.673099807018;10200.183985281159;10582;10613.416262105504;10762.730931726614;10832.837507437394;7999.400044996649;8225;8230.613122194496;8238.134995825352;8239.423240373237;5643.604947653625;5951.464368206882;6093.268807742922;6226.657533835682;6235.127082208585;9879.802403951737;10013.749656258651;10095.848562271425;10100.89899101029;10105.39367637944;9292.535373231447;9649.324547281623;10061.496925153566;10068.748281293027;10112.747181320527;6635.706037322676;7076.2923707628825;7248.56508609464;7258.274172582699;7387.150477695134;6918.965405172942;8145.470544414594;8151.5109093454585;8325.25072743456;8333.6666533338;7483.363914067148;7495.250474952461;7550.207228240955;7562.621868906423;7585.16563178061;7179.389751871149;7360.447966402434;7374.078240219973;7468.365188958999;7555.13115991646;6940.340667636567;7007.229204787367;7020.417130616569;7070.787876363717;7085.645717713991;4927.753612319441;5000.57495112905;5030.170021946338;5050.570701490415;5217.739113044257;5030.798768049383;5172.25002374646;5178.741062946762;5266.920996185137;5363.2759577456545 08:47:48 INFO - PROCESS | 1641 | |4;prototype.html;285.8185052491667;291.1280714260789;301.27092436304144;309.5774268124011;310.3560112766011;5162.792324255734;5215.217717342401;5409.377921539024;5411.188321751739;5441.646292990953;5155.664881782682;5302.893942121155;5353.3843607985;5374.516293533581;5402.35171779386;3403.7106845918;3776.905577360574;4112.835486580533;4145.316022856225;4165;3025.727684508394;4018.0557568971267;4131.979340103296;4196.034911970249;4204.390363397306;4012;4031.266555381185;4052.939205911899;4054.1891621675636;4070.1656160487178;3333.96666033339;4006.5793091725386;4055.6755459563165;4060.7360521566;4073.490813648294;2902.795339933946;3052.5879006334085;3490.7905525668543;3501.3872572299747;3518.894433167009;4110.671146308288;4390.0122472443445;4928.398270562082;5186.7147306898105;5249.112987856702;4382.780860956939;4628.930566041512;4629.768511574408;4636.423615970552;4645.419322584677;5545.584081193886;5642.379338272786;5644.858878528029;5648.491635752802;5725.799597014085;2927.5901373807683;3556.893293201208;3821.636944490269;3867.245887052026;3890.533136023667;4998.375203099649;5884.440978107073;5925.4370834770625;5930.495907847795;5943.465088142045;3292.851821668031;3884.3008258513737;3914.373700207953;3928.4107383892074;3933.8623148189677;3304.2565422780162;3832.770033797981;3991.2416640838146;3993.381025940984;3996.200759847984;4587;4590.632749380042;4615.861524154281;4615.8846028848875;4655.324977878188;5632.3804381518;5712.314522257273;5727.627704199213;5741.712914354265;5788.88422231553;1164.2723297938787;1262.7348256866162;1263.15999860092;1283.0313113599173;1311.6786387335164;811.9147489513634;856.246503077288;908.504864848659;909.8953620333747;921.6543796076471;4389.407429996973;5080.74596270185;5197.8440646780655;5207.3490813648295;5216.739163041832;5143.5568105150505;5765.221695071195;5777.64225407029;5794.710264486759;5805.506531944748;4761.452527928368;4777.4267087949665;4882.51174882516;5048.545630893237;5254.448282930237;2436.6954130733657;3022.2897619059504;3032.6209223847018;3033.8179709217516;3051.8474076296097;5426.8371948841595;5429.701366424884;5678.290213723285;5882.852928676817;5939.881202375928;4924.606031517542;5533.6403133796175;5588.524975377057;5896.675682837399;5943.524518038546;4884.65807393479;5446.673199608036;5508.366537848118;5927.006861534811;5945.781114871527;4854.757262136808;5370.697021331931;5680.375158732453;5741.741621626953;5753.654780713171;4644.58198762113;5517.806876759294;5671.801486948102;5685.403032681675;5710.914336285042;4902.803887844446;5908.409159084057;5956.910646340221;5962.612430192024;5979.760809567569;2981.381098279499;3826.3112639724004;3848.9037774055873;3901.882943511699;3946.585608511065;4902.975485122552;5208.895822083613;5405.513463806693;5805.187273781589;5896.587238893408;4767.976160119178;5427.24018637399;5699.2590963174525;5752.712364381848;5763.596548241583;5037.219231019198;5616.5787565931905;5655.377908429987;5698.8290351289525;5735.512481438957;5663.433656634468;5669.20631111653;5679.756496183902;5681.431856814285;5715.457031581993;5270.025045366619;5428.7285635718845;5767.75057727495;5776.624519406225;5782.277215348082;5230.8169214077325;5345.492178243061;5584.860378490408;5644.238027866186;5697.259356283656 08:47:48 INFO - PROCESS | 1641 | |5;yui.html;710.634023477909;724.3589423360324;729.3690957321915;759.051186017478;790.4585359029069;15645.374185032599;16725.74911376327;16728.33086676533;16728.996260224394;16741.162941852905;15003.624909377271;15183.620409489768;15227.238638068107;15244.237788110606;15250.618734531643;696.8815301398774;716.0762616225063;718.8813845715476;720.2797202797203;854.6325080215489;689.396777819408;714.5819695478151;717.0642311783121;861.3109512390063;865.472062042157;902.2331018634175;912.6440688131634;916.8716379706847;919.4758987377197;921.7695576105973;903.742433406476;904.9909500905038;907.7004588485784;911.1662828511903;912.4388501071826;530.2682298428144;655.4297760948006;680.6664734280216;680.9829754256134;681.3731367142192;15206.315715792816;15261.6184595386;15285.312160952784;15317.540473785804;15375.615609609737;13976.301184940712;14192.645183870383;14217.431302747878;14270.714585708332;14457.421703131862;13093.410796514085;13121;13283.86716132836;13447;13462.259575723332;4553.704009239389;4606.378138951232;4608.9308660370125;4628.25947848346;4818.156822556039;113858.29212561819;115908;119566.40216798948;119681.40159299235;119775.40112299469;11065.668029959113;11204.887951120547;11423.143264255214;11523.193376463567;11613.187076904536;22837;22844.42888927757;22858.657120143213;22902;22904.427389315402;7882.290593846466;7966.8448075029955;7976.960115199503;8142.592870356577;8211.507309561446;3653.415453527423;4356.803943822536;4375.387445757597;4399.670024748093;4566.292224705176;3543.557055368079;3664.3953747631876;3668.7248456365346;3670.3209906167444;3678.9448158277646;578.8581797459565;723.3200791256203;725.5356571794056;729.4711334282603;733.0250766480568;541.8293237630133;619.8822223777468;626.5269721360344;627.9623222606658;689.6172624193521;8422.252097816536;9046.411983221069;9650.806983860424;9675.951620241854;9774.364666296668;531.4924247343855;639.3223183425583;654.1855390039336;669.846044247442;688.4870771275432;4284.335927931175;4536.88657783558;4604.608608268268;4788.688735232199;4799.136155491975;108395.45802270938;124733.12900306503;132736;138691;138934;129085;132000;133425;134364;135199.32400338133;75000;104733.47633261785;105023;108843.45578272059;110491;8636.568171591522;8818.29453643694;8976.41653292534;9094.363394562317;9154.221891139328;50754;61188.694056529435;67314.66342668256;67938.66030669815;68806;99956;102667.97332026882;106012.40981385439;106309.46845265724;108872;11737.706557335794;11917.344546049704;11963.521459141884;12085.033197344368;12556.874431255936;10452.790944181226;12329.204316518018;12983.091183617056;13104;13997.930010349883;12030.583869347207;13346.933265333611;14065.578032659037;14316.427342906583;14434.347034133156;13573.1856088635;14044;14164.858351416355;14247.358868851134;14813.407463701331;13770.724585508435;13915.234662093682;14025.158490490603;14099.083559568595;14219.573412797632;11014.834777478183;11452.484638191469;11515.25150865191;11629.76740465169;11648.88351116478;9387.202087822612;11012.789560845456;11368.602098926498;11620.883791162318;11725.120615954009 08:47:48 INFO - PROCESS | 1641 | __end_tp_report 08:47:48 INFO - PROCESS | 1641 | __start_cc_report 08:47:48 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1488 08:47:48 INFO - PROCESS | 1641 | __end_cc_report 08:47:48 INFO - PROCESS | 1641 | __startTimestamp1471621668729__endTimestamp 08:47:48 INFO - PROCESS | 1641 | 08:47:48 INFO - PROCESS | 1641 | ------- Summary: start ------- 08:47:48 INFO - PROCESS | 1641 | Number of tests: 6 08:47:48 INFO - PROCESS | 1641 | 08:47:48 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5844.19 Median:6133.56 stddev:642.63 (10.5%) stddev-sans-first:613.10 08:47:48 INFO - PROCESS | 1641 | Values: 3310.7 3344.1 3352.3 3371.0 3401.5 5689.1 5737.7 5795.6 5812.6 5882.7 5774.6 5826.1 5880.7 5927.6 5973.4 5213.5 5231.5 5279.0 5291.7 5390.4 5409.4 5410.7 5415.3 5422.9 5451.5 5223.9 5283.4 5289.7 5334.4 5383.5 5306.5 5313.0 5317.5 5319.7 5336.7 5239.0 5271.8 5277.2 5295.5 5327.8 5785.9 5838.7 5862.9 5923.3 5950.5 6305.3 6367.2 6372.0 6374.1 6377.0 5256.9 6223.5 6283.9 6311.5 6331.3 5981.5 6010.6 6037.7 6043.9 6049.3 6257.8 6352.1 6357.7 6370.1 6377.9 6199.5 6219.9 6236.9 6313.1 6319.5 6345.7 6356.9 6365.9 6369.0 6375.7 6099.9 6328.3 6347.3 6350.8 6356.1 6188.4 6209.7 6216.2 6245.3 6255.9 5067.4 5069.5 5073.2 5074.6 5117.7 4507.3 4523.7 4526.4 4532.9 4584.2 5743.8 5775.2 5868.9 5900.3 5931.6 6259.7 6300.2 6310.1 6310.9 6316.9 5943.2 5947.9 5968.7 6006.0 6011.4 5390.2 5462.0 5487.2 5497.8 5584.1 6376.1 6420.3 6438.1 6439.0 6443.7 6286.3 6298.4 6301.3 6315.6 6319.5 6254.4 6272.4 6287.1 6305.9 6399.8 6245.8 6297.8 6299.6 6303.3 6307.4 5243.5 6187.2 6260.3 6270.8 6285.1 5943.2 6070.1 6111.6 6168.4 6179.3 6235.8 6239.5 6245.1 6245.3 6255.8 6153.5 6154.6 6161.9 6166.1 6176.8 6049.6 6145.9 6191.0 6192.6 6264.3 6133.6 6149.7 6156.7 6164.9 6166.8 08:47:48 INFO - PROCESS | 1641 | 08:47:48 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:67059.40 Median:211219.31 stddev:145879.33 (69.1%) stddev-sans-first:146202.96 08:47:48 INFO - PROCESS | 1641 | Values: 499.8 512.1 532.3 538.3 549.1 31348.8 31537.2 33060.8 41305.6 42314.0 43741.0 44175.6 44252.8 44258.3 44323.6 8732.6 9135.9 9722.0 9889.1 9892.2 8765.8 8945.4 8953.0 9718.5 9835.2 8886.6 8938.1 12160.1 12455.6 12470.9 12102.2 12177.5 12180.4 12186.7 12198.3 11957.5 12045.7 12061.9 12069.0 12093.9 41350.8 41737.6 41738.0 41754.0 41763.8 3458.2 3686.2 3693.8 3962.7 4135.3 31411.3 31894.5 32001.5 32185.5 32983.2 3018.1 3018.3 3049.2 3100.1 3118.7 384437.0 385075.0 385102.0 386869.1 392407.0 59686.0 60051.0 60104.0 60161.7 60303.0 28783.6 34808.3 35522.3 36510.6 63898.0 16454.4 16582.0 16598.3 16599.5 16638.7 12679.2 12744.7 12772.2 12786.8 12790.9 16699.8 19295.1 19420.7 19528.2 19549.9 6640.6 7332.3 7651.8 8285.1 8348.9 881.9 941.3 952.4 954.3 1099.2 25409.6 31277.4 31311.7 31333.7 31962.4 1046.6 1086.9 1090.9 1093.6 1152.2 13711.5 15223.5 16139.8 16179.9 16182.8 655980.0 657902.0 665684.0 667977.0 669460.1 60630.0 61104.0 61193.2 61262.8 61574.8 1376.8 1396.1 1417.0 1420.6 1421.1 29315.7 29953.7 30942.1 30999.8 31435.0 53014.5 53330.7 53399.0 53486.9 53711.0 479072.0 546127.0 566730.0 574380.0 580390.1 26646.9 26915.0 27031.2 27188.7 27211.0 35880.5 40111.8 49786.0 50379.0 51248.7 38592.0 39989.8 40230.2 41164.6 41356.0 39665.8 40239.6 40278.6 41511.2 41856.4 38001.6 39212.4 39484.2 39486.8 39660.4 29170.4 30695.8 35096.5 35812.5 36115.5 20674.8 22611.9 22992.0 24700.6 25873.9 08:47:48 INFO - PROCESS | 1641 | 08:47:48 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:35600.91 Median:13932.34 stddev:101702.20 (730.0%) stddev-sans-first:101952.99 08:47:48 INFO - PROCESS | 1641 | Values: 315.8 351.8 367.7 372.5 397.0 15558.0 17647.2 20789.0 20917.3 21040.3 20452.8 20647.0 20962.5 21309.0 21365.5 5069.4 5475.2 6208.8 6246.9 6262.7 5979.7 6176.7 6182.0 6183.4 6185.1 5935.8 6050.7 6073.2 6127.2 6162.4 6008.6 6117.4 6132.0 6169.9 6174.9 5236.1 5262.8 5312.7 5320.7 5326.2 25294.5 25978.8 26094.6 26234.0 26502.2 2274.7 2486.0 2504.5 2570.2 3025.5 15429.3 15572.8 15615.6 15892.0 16046.7 1722.0 1830.8 1846.7 1923.9 1942.4 118699.0 120860.0 121472.0 122009.4 122846.0 10422.0 10968.3 11023.9 11024.6 11198.0 13796.3 13802.0 13812.4 13817.4 13817.5 7157.6 8213.8 8444.1 8647.7 8657.0 6964.4 8662.9 8832.9 8838.3 8839.7 6476.4 6607.9 6610.4 6612.2 6623.2 1586.3 1802.8 1819.3 1834.1 1834.6 823.9 878.8 892.7 898.0 938.6 19329.5 21555.5 22276.3 22460.0 22573.0 940.5 949.8 970.3 990.1 992.6 8963.0 10574.7 10847.6 11913.3 11942.9 578606.0 597439.0 610148.0 626806.0 631291.0 99640.0 132105.0 140288.0 142389.0 143181.0 964.2 1008.1 1019.5 1022.4 1034.0 19433.6 19616.8 19729.3 19919.4 19929.5 51455.5 52528.2 55138.9 56415.6 56706.7 56631.0 74129.9 77501.6 78240.0 80786.6 7324.6 7697.5 7886.8 7940.4 7957.9 10353.4 12225.0 12280.3 12589.7 12705.7 10773.8 11044.9 11198.8 11379.0 11431.7 10661.9 10727.1 10971.9 10988.2 11050.6 10566.2 10807.4 10998.3 11021.0 11352.5 6875.7 7159.9 7185.8 8014.0 8139.1 10732.4 10738.4 10889.2 11184.3 11200.4 08:47:48 INFO - PROCESS | 1641 | 08:47:48 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5696.01 Median:5015.37 stddev:3162.18 (63.0%) stddev-sans-first:3155.48 08:47:48 INFO - PROCESS | 1641 | Values: 1520.7 1556.0 1694.8 1802.3 1837.8 8444.7 8960.7 8973.9 8978.2 8984.9 7807.3 8053.4 8298.6 8634.3 8662.0 2000.3 2312.5 2358.2 2371.2 2380.5 2340.7 2350.4 2388.0 2389.9 2395.7 2363.0 2376.9 2388.3 2389.9 2395.5 2340.8 2358.4 2368.3 2378.8 2379.4 2330.3 2356.5 2357.5 2357.5 2359.4 8635.1 8775.0 8793.3 8798.3 8812.2 4487.6 5218.2 5349.3 5350.0 5359.7 3619.4 3621.7 3690.8 3704.0 3727.5 1079.8 1086.9 1086.9 1103.8 1113.1 11551.8 11617.5 11717.9 11731.4 11759.5 4418.3 4598.5 4677.4 4817.4 4824.1 9989.7 9997.8 9998.7 10014.8 10020.8 5275.7 5283.8 5287.0 5291.2 5292.8 4290.5 4384.9 4548.2 4552.2 4821.9 3898.3 3930.8 4014.8 4027.3 4056.6 1267.3 1290.2 1291.0 1301.3 1302.1 850.3 870.3 918.7 943.3 947.0 5836.3 5993.6 6018.8 6148.8 6173.9 754.2 876.7 901.8 960.5 981.4 4002.0 4004.0 4064.9 4117.3 4166.9 9655.5 10334.5 10505.2 10893.7 10896.7 10200.2 10582.0 10613.4 10762.7 10832.8 7999.4 8225.0 8230.6 8238.1 8239.4 5643.6 5951.5 6093.3 6226.7 6235.1 9879.8 10013.7 10095.8 10100.9 10105.4 9292.5 9649.3 10061.5 10068.7 10112.7 6635.7 7076.3 7248.6 7258.3 7387.2 6919.0 8145.5 8151.5 8325.3 8333.7 7483.4 7495.3 7550.2 7562.6 7585.2 7179.4 7360.4 7374.1 7468.4 7555.1 6940.3 7007.2 7020.4 7070.8 7085.6 4927.8 5000.6 5030.2 5050.6 5217.7 5030.8 5172.3 5178.7 5266.9 5363.3 08:47:48 INFO - PROCESS | 1641 | 08:47:48 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4539.41 Median:5174.75 stddev:1424.54 (27.5%) stddev-sans-first:1392.30 08:47:48 INFO - PROCESS | 1641 | Values: 285.8 291.1 301.3 309.6 310.4 5162.8 5215.2 5409.4 5411.2 5441.6 5155.7 5302.9 5353.4 5374.5 5402.4 3403.7 3776.9 4112.8 4145.3 4165.0 3025.7 4018.1 4132.0 4196.0 4204.4 4012.0 4031.3 4052.9 4054.2 4070.2 3334.0 4006.6 4055.7 4060.7 4073.5 2902.8 3052.6 3490.8 3501.4 3518.9 4110.7 4390.0 4928.4 5186.7 5249.1 4382.8 4628.9 4629.8 4636.4 4645.4 5545.6 5642.4 5644.9 5648.5 5725.8 2927.6 3556.9 3821.6 3867.2 3890.5 4998.4 5884.4 5925.4 5930.5 5943.5 3292.9 3884.3 3914.4 3928.4 3933.9 3304.3 3832.8 3991.2 3993.4 3996.2 4587.0 4590.6 4615.9 4615.9 4655.3 5632.4 5712.3 5727.6 5741.7 5788.9 1164.3 1262.7 1263.2 1283.0 1311.7 811.9 856.2 908.5 909.9 921.7 4389.4 5080.7 5197.8 5207.3 5216.7 5143.6 5765.2 5777.6 5794.7 5805.5 4761.5 4777.4 4882.5 5048.5 5254.4 2436.7 3022.3 3032.6 3033.8 3051.8 5426.8 5429.7 5678.3 5882.9 5939.9 4924.6 5533.6 5588.5 5896.7 5943.5 4884.7 5446.7 5508.4 5927.0 5945.8 4854.8 5370.7 5680.4 5741.7 5753.7 4644.6 5517.8 5671.8 5685.4 5710.9 4902.8 5908.4 5956.9 5962.6 5979.8 2981.4 3826.3 3848.9 3901.9 3946.6 4903.0 5208.9 5405.5 5805.2 5896.6 4768.0 5427.2 5699.3 5752.7 5763.6 5037.2 5616.6 5655.4 5698.8 5735.5 5663.4 5669.2 5679.8 5681.4 5715.5 5270.0 5428.7 5767.8 5776.6 5782.3 5230.8 5345.5 5584.9 5644.2 5697.3 08:47:48 INFO - PROCESS | 1641 | 08:47:48 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:24883.79 Median:22903.21 stddev:39017.70 (170.4%) stddev-sans-first:39084.93 08:47:48 INFO - PROCESS | 1641 | Values: 710.6 724.4 729.4 759.1 790.5 15645.4 16725.7 16728.3 16729.0 16741.2 15003.6 15183.6 15227.2 15244.2 15250.6 696.9 716.1 718.9 720.3 854.6 689.4 714.6 717.1 861.3 865.5 902.2 912.6 916.9 919.5 921.8 903.7 905.0 907.7 911.2 912.4 530.3 655.4 680.7 681.0 681.4 15206.3 15261.6 15285.3 15317.5 15375.6 13976.3 14192.6 14217.4 14270.7 14457.4 13093.4 13121.0 13283.9 13447.0 13462.3 4553.7 4606.4 4608.9 4628.3 4818.2 113858.3 115908.0 119566.4 119681.4 119775.4 11065.7 11204.9 11423.1 11523.2 11613.2 22837.0 22844.4 22858.7 22902.0 22904.4 7882.3 7966.8 7977.0 8142.6 8211.5 3653.4 4356.8 4375.4 4399.7 4566.3 3543.6 3664.4 3668.7 3670.3 3678.9 578.9 723.3 725.5 729.5 733.0 541.8 619.9 626.5 628.0 689.6 8422.3 9046.4 9650.8 9676.0 9774.4 531.5 639.3 654.2 669.8 688.5 4284.3 4536.9 4604.6 4788.7 4799.1 108395.5 124733.1 132736.0 138691.0 138934.0 129085.0 132000.0 133425.0 134364.0 135199.3 75000.0 104733.5 105023.0 108843.5 110491.0 8636.6 8818.3 8976.4 9094.4 9154.2 50754.0 61188.7 67314.7 67938.7 68806.0 99956.0 102668.0 106012.4 106309.5 108872.0 11737.7 11917.3 11963.5 12085.0 12556.9 10452.8 12329.2 12983.1 13104.0 13997.9 12030.6 13346.9 14065.6 14316.4 14434.3 13573.2 14044.0 14164.9 14247.4 14813.4 13770.7 13915.2 14025.2 14099.1 14219.6 11014.8 11452.5 11515.3 11629.8 11648.9 9387.2 11012.8 11368.6 11620.9 11725.1 08:47:48 INFO - PROCESS | 1641 | -------- Summary: end -------- 08:47:48 INFO - PROCESS | 1641 | 08:47:49 INFO - TEST-INFO | 1641: exit 0 08:47:49 INFO - TEST-OK | dromaeo_css | took 1117213ms 08:47:49 INFO - TEST-START | kraken 08:47:49 INFO - operating with platform_type : mac_ 08:47:49 INFO - Initialising browser for kraken test... 08:47:49 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmp3htRgM/profile http://localhost:49276/getInfo.html) 08:47:51 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 08:47:51 INFO - PROCESS | 1652 | colorDepth:24 08:47:51 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 08:47:51 INFO - PROCESS | 1652 | __metrics 08:47:51 INFO - PROCESS | 1652 | 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" 08:47:51 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:47:51 INFO - PROCESS | 1652 | ************************* 08:47:51 INFO - PROCESS | 1652 | A coding exception was thrown in a Promise resolution callback. 08:47:51 INFO - PROCESS | 1652 | See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise 08:47:51 INFO - PROCESS | 1652 | 08:47:51 ERROR - PROCESS | 1652 | Full message: TypeError: win is null 08:47:51 INFO - PROCESS | 1652 | Full stack: onSuccess@resource://app/components/nsBrowserGlue.js:758:17 08:47:51 INFO - PROCESS | 1652 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 08:47:51 INFO - PROCESS | 1652 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 08:47:51 INFO - PROCESS | 1652 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 08:47:51 INFO - PROCESS | 1652 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 08:47:51 INFO - PROCESS | 1652 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 08:47:51 INFO - PROCESS | 1652 | get _worker/worker.onmessage@resource://gre/modules/PromiseWorker.jsm:235:9 08:47:51 INFO - PROCESS | 1652 | EventHandlerNonNull*get _worker@resource://gre/modules/PromiseWorker.jsm:217:5 08:47:51 INFO - PROCESS | 1652 | postMessage@resource://gre/modules/PromiseWorker.jsm:291:9 08:47:51 INFO - PROCESS | 1652 | TaskImpl_run@resource://gre/modules/Task.jsm:319:40 08:47:51 INFO - PROCESS | 1652 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 08:47:51 INFO - PROCESS | 1652 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 08:47:51 INFO - PROCESS | 1652 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 08:47:51 INFO - PROCESS | 1652 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 08:47:51 INFO - PROCESS | 1652 | Promise.prototype.then@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:454:5 08:47:51 INFO - PROCESS | 1652 | this.DeferredSave.prototype._deferredSave@resource://gre/modules/DeferredSave.jsm:220:5 08:47:51 INFO - PROCESS | 1652 | this.DeferredSave.prototype._startTimer/<@resource://gre/modules/DeferredSave.jsm:175:40 08:47:51 INFO - PROCESS | 1652 | syncLoadManifestFromFile@resource://gre/modules/addons/XPIProvider.jsm:1537:5 08:47:51 INFO - PROCESS | 1652 | addMetadata@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:1654:21 08:47:51 INFO - PROCESS | 1652 | processFileChanges@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2018:23 08:47:51 INFO - PROCESS | 1652 | this.XPIProvider.checkForChanges@resource://gre/modules/addons/XPIProvider.jsm:3793:34 08:47:51 INFO - PROCESS | 1652 | this.XPIProvider.startup@resource://gre/modules/addons/XPIProvider.jsm:2778:25 08:47:51 INFO - PROCESS | 1652 | callProvider@resource://gre/modules/AddonManager.jsm:236:12 08:47:51 INFO - PROCESS | 1652 | _startProvider@resource://gre/modules/AddonManager.jsm:788:5 08:47:51 INFO - PROCESS | 1652 | AddonManagerInternal.startup@resource://gre/modules/AddonManager.jsm:972:9 08:47:51 INFO - PROCESS | 1652 | this.AddonManagerPrivate.startup@resource://gre/modules/AddonManager.jsm:3016:5 08:47:51 INFO - PROCESS | 1652 | amManager.prototype.observe@resource://gre/components/addonManager.js:71:9 08:47:51 INFO - PROCESS | 1652 | 08:47:51 INFO - PROCESS | 1652 | ************************* 08:47:52 INFO - TEST-INFO | 1652: exit 0 08:47:52 INFO - Browser initialized. 08:47:52 INFO - Running cycle 1/1 for kraken test... 08:47:52 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmp3htRgM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:48:04 INFO - PROCESS | 1653 | RSS: Main: 247103488 08:48:04 INFO - PROCESS | 1653 | 08:48:07 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 08:48:07 INFO - PROCESS | 1653 | RSS: Main: 303460352 08:48:07 INFO - PROCESS | 1653 | 08:48:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 08:48:11 INFO - PROCESS | 1653 | RSS: Main: 308449280 08:48:11 INFO - PROCESS | 1653 | 08:48:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 08:48:15 INFO - PROCESS | 1653 | RSS: Main: 402804736 08:48:15 INFO - PROCESS | 1653 | 08:48:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 08:48:17 INFO - PROCESS | 1653 | RSS: Main: 303394816 08:48:17 INFO - PROCESS | 1653 | 08:48:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:48:20 INFO - PROCESS | 1653 | RSS: Main: 307707904 08:48:20 INFO - PROCESS | 1653 | 08:48:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 08:48:24 INFO - PROCESS | 1653 | RSS: Main: 345100288 08:48:24 INFO - PROCESS | 1653 | 08:48:26 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 08:48:27 INFO - PROCESS | 1653 | RSS: Main: 345804800 08:48:27 INFO - PROCESS | 1653 | 08:48:30 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 08:48:31 INFO - PROCESS | 1653 | RSS: Main: 346886144 08:48:31 INFO - PROCESS | 1653 | 08:48:32 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:48:33 INFO - PROCESS | 1653 | RSS: Main: 315015168 08:48:33 INFO - PROCESS | 1653 | 08:48:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:48:35 INFO - PROCESS | 1653 | RSS: Main: 321622016 08:48:35 INFO - PROCESS | 1653 | 08:48:37 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:48:38 INFO - PROCESS | 1653 | RSS: Main: 316215296 08:48:38 INFO - PROCESS | 1653 | 08:48:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:48:42 INFO - PROCESS | 1653 | RSS: Main: 325914624 08:48:42 INFO - PROCESS | 1653 | 08:48:45 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:48:45 INFO - PROCESS | 1653 | RSS: Main: 328306688 08:48:45 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 08:48:47 INFO - PROCESS | 1653 | RSS: Main: 371339264 08:48:47 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | __start_tp_report 08:48:47 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 08:48:47 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 08:48:47 INFO - PROCESS | 1653 | |i|pagename|runs| 08:48:47 INFO - PROCESS | 1653 | |0;ai-astar;101;113;113;113;108;113;112;111;112;112 08:48:47 INFO - PROCESS | 1653 | |1;audio-beat-detection;143;109;108;163;110;105;129;107;141;107 08:48:47 INFO - PROCESS | 1653 | |2;audio-dft;182;188;185;185;182;183;181;183;184;182 08:48:47 INFO - PROCESS | 1653 | |3;audio-fft;84;74;59;88;58;59;59;70;108;80 08:48:47 INFO - PROCESS | 1653 | |4;audio-oscillator;85;92;96;71;73;69;95;71;67;102 08:48:47 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;88;85;88;85;87;85;87;85;87;84 08:48:47 INFO - PROCESS | 1653 | |6;imaging-darkroom;92;92;94;94;92;93;92;93;93;123 08:48:47 INFO - PROCESS | 1653 | |7;imaging-desaturate;86;84;86;86;86;83;84;85;87;84 08:48:47 INFO - PROCESS | 1653 | |8;json-parse-financial;56;52;55;55;55;56;52;53;54;54 08:48:47 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;65;68;68;73;76;69;70;70;69;71 08:48:47 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;87;86;85;82;85;85;86;86;89;86 08:48:47 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;138;136;138;134;140;153;130;151;218;162 08:48:47 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;173;168;167;167;167;169;166;166;171;165 08:48:47 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;68;64;67;68;68;67;67;65;66;66 08:48:47 INFO - PROCESS | 1653 | __end_tp_report 08:48:47 INFO - PROCESS | 1653 | __start_cc_report 08:48:47 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2075 08:48:47 INFO - PROCESS | 1653 | __end_cc_report 08:48:47 INFO - PROCESS | 1653 | __startTimestamp1471621727684__endTimestamp 08:48:47 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | ------- Summary: start ------- 08:48:47 INFO - PROCESS | 1653 | Number of tests: 14 08:48:47 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.50 stddev:3.77 (3.3%) stddev-sans-first:1.62 08:48:47 INFO - PROCESS | 1653 | Values: 101.0 113.0 113.0 113.0 108.0 113.0 112.0 111.0 112.0 112.0 08:48:47 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:122.20 Median:119.50 stddev:20.49 (17.1%) stddev-sans-first:20.31 08:48:47 INFO - PROCESS | 1653 | Values: 143.0 109.0 108.0 163.0 110.0 105.0 129.0 107.0 141.0 107.0 08:48:47 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:183.50 Median:183.50 stddev:2.07 (1.1%) stddev-sans-first:2.12 08:48:47 INFO - PROCESS | 1653 | Values: 182.0 188.0 185.0 185.0 182.0 183.0 181.0 183.0 184.0 182.0 08:48:47 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:73.90 Median:72.00 stddev:16.45 (22.8%) stddev-sans-first:17.04 08:48:47 INFO - PROCESS | 1653 | Values: 84.0 74.0 59.0 88.0 58.0 59.0 59.0 70.0 108.0 80.0 08:48:47 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:82.10 Median:79.00 stddev:13.30 (16.8%) stddev-sans-first:14.06 08:48:47 INFO - PROCESS | 1653 | Values: 85.0 92.0 96.0 71.0 73.0 69.0 95.0 71.0 67.0 102.0 08:48:47 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:87.00 stddev:1.45 (1.7%) stddev-sans-first:1.36 08:48:47 INFO - PROCESS | 1653 | Values: 88.0 85.0 88.0 85.0 87.0 85.0 87.0 85.0 87.0 84.0 08:48:47 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:95.80 Median:93.00 stddev:9.59 (10.3%) stddev-sans-first:10.07 08:48:47 INFO - PROCESS | 1653 | Values: 92.0 92.0 94.0 94.0 92.0 93.0 92.0 93.0 93.0 123.0 08:48:47 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:86.00 stddev:1.29 (1.5%) stddev-sans-first:1.32 08:48:47 INFO - PROCESS | 1653 | Values: 86.0 84.0 86.0 86.0 86.0 83.0 84.0 85.0 87.0 84.0 08:48:47 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:1.48 (2.7%) stddev-sans-first:1.41 08:48:47 INFO - PROCESS | 1653 | Values: 56.0 52.0 55.0 55.0 55.0 56.0 52.0 53.0 54.0 54.0 08:48:47 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:3.00 (4.3%) stddev-sans-first:2.60 08:48:47 INFO - PROCESS | 1653 | Values: 65.0 68.0 68.0 73.0 76.0 69.0 70.0 70.0 69.0 71.0 08:48:47 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.00 stddev:1.77 (2.1%) stddev-sans-first:1.81 08:48:47 INFO - PROCESS | 1653 | Values: 87.0 86.0 85.0 82.0 85.0 85.0 86.0 86.0 89.0 86.0 08:48:47 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:150.00 Median:145.50 stddev:25.86 (17.8%) stddev-sans-first:27.06 08:48:47 INFO - PROCESS | 1653 | Values: 138.0 136.0 138.0 134.0 140.0 153.0 130.0 151.0 218.0 162.0 08:48:47 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:167.50 stddev:2.47 (1.5%) stddev-sans-first:1.80 08:48:47 INFO - PROCESS | 1653 | Values: 173.0 168.0 167.0 167.0 167.0 169.0 166.0 166.0 171.0 165.0 08:48:47 INFO - PROCESS | 1653 | 08:48:47 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.35 (2.0%) stddev-sans-first:1.33 08:48:47 INFO - PROCESS | 1653 | Values: 68.0 64.0 67.0 68.0 68.0 67.0 67.0 65.0 66.0 66.0 08:48:47 INFO - PROCESS | 1653 | -------- Summary: end -------- 08:48:47 INFO - PROCESS | 1653 | 08:48:48 INFO - TEST-INFO | 1653: exit 0 08:48:48 INFO - TEST-OK | kraken | took 59125ms 08:48:48 INFO - SUITE-END | took 1176s 08:48:48 INFO - Completed test suite (00:19:36) 08:48:48 INFO - javascript benchmark 08:48:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3310.6689331066887, 3344.130526063223, 3352.27925995911, 3371.0279486500403, 3401.5067815166803, 5689.118186681071, 5737.713114344282, 5795.623284486505, 5812.564057695674, 5882.705864706763, 5774.595778295521, 5826.096954971986, 5880.7059647017695, 5927.585069045169, 5973.402659734024, 5213.452587478317, 5231.476852314776, 5279.0, 5291.735413229342, 5390.407055223922, 5409.404965453797, 5410.702411367373, 5415.296011518517, 5422.91865622016, 5451.509364157225, 5223.869403264911, 5283.418823929364, 5289.68261904287, 5334.439883812182, 5383.4616538346245, 5306.469353064701, 5313.043652142613, 5317.548008419289, 5319.654222475566, 5336.653117547347, 5239.0, 5271.815486457994, 5277.234800953878, 5295.523402893758, 5327.786888524454, 5785.884282314372, 5838.737256823453, 5862.882742345172, 5923.259592550931, 5950.523958083343, 6305.33793951633, 6367.235931688181, 6371.96814015927, 6374.107624932513, 6377.043443483514, 5256.8685782855355, 6223.533235007348, 6283.874322513524, 6311.495080393557, 6331.2719037310835, 5981.5214782817275, 6010.639361638272, 6037.698115094227, 6043.909341359927, 6049.334573196945, 6257.812265632038, 6352.14246076783, 6357.650329231937, 6370.108184854124, 6377.936220637827, 6199.473044791243, 6219.875602487925, 6236.906446403307, 6313.147725057151, 6319.462845658079, 6345.714442850082, 6356.904646430307, 6365.872682546323, 6369.0, 6375.681215939185, 6099.9390006099375, 6328.335524769925, 6347.301796802348, 6350.7777227796805, 6356.11014457967, 6188.381161883775, 6209.6895155242055, 6216.160818289473, 6245.250569931637, 6255.906161407583, 5067.391912970467, 5069.493050694901, 5073.213651883964, 5074.619403544749, 5117.667351622133, 4507.323901414814, 4523.7285762854335, 4526.434195725535, 4532.9320060199125, 4584.15193189261, 5743.770249189985, 5775.191473193756, 5868.911966320508, 5900.291964964232, 5931.58478906481, 6259.655718935411, 6300.243970723451, 6310.05349197624, 6310.9368906311265, 6316.9368306317265, 5943.218105642771, 5947.940520594739, 5968.701564921824, 6005.969970150121, 6011.428914253139, 5390.164524498709, 5462.0441422751655, 5487.204355368449, 5497.752601132958, 5584.134459158756, 6376.082482426882, 6420.325865784025, 6438.098666186831, 6438.969764837697, 6443.71003304843, 6286.277078136073, 6298.370162983665, 6301.338359472189, 6315.55791094619, 6319.494440444661, 6254.437100660963, 6272.435480806749, 6287.088372185916, 6305.905411418924, 6399.840003999751, 6245.843853903689, 6297.811065668037, 6299.590526615755, 6303.275123360872, 6307.400796924285, 5243.528082472596, 6187.16473276102, 6260.342664020394, 6270.843228919313, 6285.057241413641, 5943.167956486009, 6070.089486577049, 6111.622125543816, 6168.444839964245, 6179.28938172116, 6235.781747638811, 6239.532035097295, 6245.0632405139595, 6245.250569931637, 6255.843603909939, 6153.476954458921, 6154.569180157346, 6161.938380616137, 6166.075088736726, 6176.7838125665385, 6049.6067755597505, 6145.938540614537, 6191.00943848982, 6192.59748116371, 6264.342244064308, 6133.55861372586, 6149.661768602769, 6156.661383623944, 6164.938350616437, 6166.784162554289], "value": 5802.680381753145, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.80757408397756, 512.1063743767126, 532.2973674749331, 538.2733310031456, 549.1159233633849, 31348.84325578372, 31537.21156971074, 33060.83469582649, 41305.58694413055, 42314.0, 43741.0, 44175.558244417625, 44252.77873610635, 44258.33612495815, 44323.556764432346, 8732.607032683512, 9135.908640913573, 9721.999999999982, 9889.06053924876, 9892.159166470823, 8765.7808554786, 8945.373823832335, 8952.955235223815, 9718.514074296292, 9835.164011059069, 8886.555672216396, 8938.106189381042, 12160.087993400486, 12455.564055258068, 12470.875291247063, 12102.152849300552, 12177.51289948401, 12180.390980451031, 12186.720394358643, 12198.329091899943, 11957.461914213794, 12045.698857528545, 12061.87938120625, 12069.0, 12093.879061209363, 41350.79324603358, 41737.58262417398, 41738.0, 41754.0, 41763.7911810442, 3458.239187378773, 3686.189038411545, 3693.778373297611, 3962.7424217426064, 4135.345861655332, 31411.329376412355, 31894.521582176287, 32001.51997720036, 32185.517217241526, 32983.17542061444, 3018.109657650998, 3018.3208778024987, 3049.237690577356, 3100.069979006289, 3118.7193152616373, 384437.0, 385075.0, 385102.0, 386869.06565466995, 392407.0, 59686.0, 60051.0, 60104.0, 60161.699191503765, 60303.0, 28783.56824647632, 34808.30383392318, 35522.28955420877, 36510.63489365125, 63898.0, 16454.42409515685, 16582.0, 16598.336066557204, 16599.50201493933, 16638.667226655398, 12679.175853569488, 12744.681382965315, 12772.169808962388, 12786.808197877039, 12790.872091279154, 16699.833001669827, 19295.110449242988, 19420.708689369672, 19528.218871245273, 19549.924754138658, 6640.634765087966, 7332.340089391981, 7651.813968834839, 8285.130061343472, 8348.916510834935, 881.9206271435473, 941.3222479814523, 952.4237836109054, 954.3033585482636, 1099.164634877483, 25409.639995215708, 31277.374452510823, 31311.686883131333, 31333.686663133078, 31962.360752784814, 1046.6127532812757, 1086.9184811139196, 1090.8854570270166, 1093.5953697131954, 1152.176194021279, 13711.451541938211, 15223.520738061914, 16139.838601614068, 16179.867409281473, 16182.75725864113, 655980.0, 657902.0, 665684.0, 667977.0, 669460.0539945966, 60630.0, 61104.0, 61193.16420507303, 61262.77474450486, 61574.768504629654, 1376.7521846067605, 1396.0506855338265, 1416.9504067357593, 1420.552525954321, 1421.1118051217989, 29315.70684293215, 29953.70046299509, 30942.071737847902, 30999.84500077485, 31435.0, 53014.46985530095, 53330.73334633302, 53399.0, 53486.930261393776, 53711.0, 479072.0, 546127.0, 566730.0, 574380.0, 580390.098049507, 26646.934122634877, 26915.0, 27031.1890643281, 27188.728112718618, 27211.0, 35880.46179307365, 40111.796646100665, 49786.0, 50379.0, 51248.74375628098, 38592.0, 39989.80005099956, 40230.1953960925, 41164.58835411607, 41356.0, 39665.801670992616, 40239.597604024755, 40278.59721402748, 41511.169776604904, 41856.37215441831, 38001.61998380091, 39212.41181382338, 39484.21031579295, 39486.80256598814, 39660.40509392419, 29170.416591668472, 30695.772169112985, 35096.47355289622, 35812.462813058344, 36115.458268125476, 20674.793252067888, 22611.886940565193, 22992.0, 24700.58982305337, 25873.870630646725], "value": 20090.1271598363, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.76475525733326, 351.7818952249606, 367.69113944286795, 372.54549449671396, 397.02728315626723, 15558.0, 17647.205875735606, 20789.025042620928, 20917.267895623656, 21040.263590774306, 20452.795472045276, 20647.0, 20962.475938101517, 21309.0, 21365.465863353384, 5069.417017043042, 5475.233467314579, 6208.844778880519, 6246.937530624681, 6262.655553944532, 5979.701014949257, 6176.691165441733, 6181.969090154543, 6183.443490085891, 6185.072239164117, 5935.762569497215, 6050.727717252734, 6073.240844894388, 6127.1728316677345, 6162.414570615784, 6008.579399442041, 6117.418845209698, 6131.969340153293, 6169.938300616981, 6174.876502469948, 5236.083685355085, 5262.815801446931, 5312.681239125664, 5320.65415747979, 5326.174442961347, 25294.494110117877, 25978.83095260718, 26094.608580871303, 26234.0, 26502.204933852016, 2274.7042884425086, 2486.018022880952, 2504.5241404133158, 2570.177543186181, 3025.5461680747844, 15429.30568124437, 15572.844271557253, 15615.609609759733, 15892.046477211405, 16046.679066418723, 1721.9655606887793, 1830.7803063632316, 1846.6583682018736, 1923.8916440301984, 1942.4366933589242, 118699.0, 120860.0, 121472.0, 122009.38995305056, 122845.99999999911, 10422.0, 10968.341899486057, 11023.889761102446, 11024.614138505114, 11198.0, 13796.310184490736, 13801.964852635892, 13812.447502099803, 13817.447302108005, 13817.516386926409, 7157.57054576727, 8213.753587392388, 8444.113368096261, 8647.740567782977, 8656.956715216384, 6964.373206411447, 8662.913370866338, 8832.911670883337, 8838.29293656506, 8839.734807955772, 6476.352364763486, 6607.933920660828, 6610.372014658696, 6612.206535215805, 6623.172103487064, 1586.2623879895673, 1802.8467580255563, 1819.3450357871156, 1834.147121588441, 1834.605699668235, 823.9011318641682, 878.767126711422, 892.683097500378, 897.9640814367352, 938.596403546468, 19329.51676208078, 21555.461113472287, 22276.331710048726, 22460.0, 22573.01815019021, 940.4639355567261, 949.8100379924043, 970.315927271272, 990.1484723138095, 992.5682328187262, 8962.955185224033, 10574.731032276177, 10847.566097356017, 11913.28520288768, 11942.880571194351, 578606.0, 597439.0, 610148.0, 626806.0, 631291.0, 99640.0, 132105.0, 140288.0, 142389.01638442604, 143181.0, 964.2093483343731, 1008.0927165551062, 1019.5259204469957, 1022.4172221833484, 1034.0383443397561, 19433.611327773084, 19616.803831961497, 19729.309474168334, 19919.418533737033, 19929.501762456053, 51455.48544514507, 52528.21207681811, 55138.89722205613, 56415.589610260075, 56706.716466417405, 56631.0, 74129.8880516782, 77501.61249193718, 78240.0, 80786.59606701929, 7324.633768311456, 7697.461177717506, 7886.763397098096, 7940.444168908121, 7957.880631790644, 10353.378797272188, 12225.0, 12280.263184208976, 12589.748205035665, 12705.745885082431, 10773.784524309627, 11044.944775276072, 11198.776024479628, 11379.0, 11431.714207144887, 10661.89338106609, 10727.088197503299, 10971.890281097087, 10988.175886808682, 11050.613228536962, 10566.207534434794, 10807.35155890649, 10998.285111467729, 11020.969233460863, 11352.545898164311, 6875.724971001304, 7159.892601610876, 7185.820354491179, 8014.038315402189, 8139.1453897339925, 10732.356058636507, 10738.40938748345, 10889.21442594197, 11184.273022253528, 11200.38397888124], "value": 9741.407135346291, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1520.680657062017, 1555.9688806223876, 1694.822043685413, 1802.3241284518306, 1837.751903493028, 8444.704435344764, 8960.731178064652, 8973.865392019117, 8978.191962723362, 8984.91015089849, 7807.258310460497, 8053.355731541477, 8298.585070746469, 8634.266087382564, 8662.0, 2000.3098930868828, 2312.456572705417, 2358.2453614843257, 2371.21749822559, 2380.4881950380664, 2340.707411573553, 2350.388898886293, 2388.020911426307, 2389.880505974703, 2395.6765836612094, 2362.9645555316683, 2376.92869213923, 2388.319328991229, 2389.940251493709, 2395.4849707312924, 2340.8127349811975, 2358.351453350334, 2368.27767530903, 2378.821588380861, 2379.381360846175, 2330.278234030193, 2356.516914032636, 2357.481354102095, 2357.481354102095, 2359.398353419884, 8635.050144484101, 8774.956125219396, 8793.252573531257, 8798.340124490625, 8812.16284452976, 4487.618552423048, 5218.191180367011, 5349.251104845324, 5349.973250133763, 5359.651622644555, 3619.3847046002243, 3621.746477746559, 3690.7970061646597, 3704.01843511467, 3727.4781530585738, 1079.8110330692098, 1086.896744809242, 1086.8967448092499, 1103.8068338040812, 1113.092829344082, 11551.768964620745, 11617.535298588047, 11717.941410292979, 11731.354775487345, 11759.529618815237, 4418.33724941255, 4598.540145985375, 4677.368555245066, 4817.373741413594, 4824.059308434892, 9989.650362237433, 9997.80004399908, 9998.650047248311, 10014.79970400588, 10020.799584008279, 5275.657082289639, 5283.762230699551, 5286.995470860525, 5291.1798671206025, 5292.841214763564, 4290.485141783006, 4384.934225986613, 4548.226801443762, 4552.248878934939, 4821.855344339676, 3898.2593307271527, 3930.7838068906485, 4014.8193331300163, 4027.2750904836826, 4056.634902858698, 1267.2713189915835, 1290.1936289818864, 1290.9736759276398, 1301.342821874966, 1302.0885380233874, 850.2560259772699, 870.2820173356879, 918.6784625381197, 943.3396622364236, 946.9526523673788, 5836.270466191726, 5993.640381577119, 6018.849528761816, 6148.784792532329, 6173.876522469525, 754.1817128415621, 876.6975393489236, 901.833160865242, 960.4717405426987, 981.3817295104038, 4001.9599804001587, 4004.0, 4064.9187016260103, 4117.300058989979, 4166.854115118366, 9655.517224138765, 10334.483275836179, 10505.212109091848, 10893.673189804318, 10896.673099807018, 10200.183985281159, 10582.0, 10613.416262105504, 10762.730931726614, 10832.837507437394, 7999.400044996649, 8225.0, 8230.613122194496, 8238.134995825352, 8239.423240373237, 5643.604947653625, 5951.464368206882, 6093.268807742922, 6226.657533835682, 6235.127082208585, 9879.802403951737, 10013.749656258651, 10095.848562271425, 10100.89899101029, 10105.39367637944, 9292.535373231447, 9649.324547281623, 10061.496925153566, 10068.748281293027, 10112.747181320527, 6635.706037322676, 7076.2923707628825, 7248.56508609464, 7258.274172582699, 7387.150477695134, 6918.965405172942, 8145.470544414594, 8151.5109093454585, 8325.25072743456, 8333.6666533338, 7483.363914067148, 7495.250474952461, 7550.207228240955, 7562.621868906423, 7585.16563178061, 7179.389751871149, 7360.447966402434, 7374.078240219973, 7468.365188958999, 7555.13115991646, 6940.340667636567, 7007.229204787367, 7020.417130616569, 7070.787876363717, 7085.645717713991, 4927.753612319441, 5000.57495112905, 5030.170021946338, 5050.570701490415, 5217.739113044257, 5030.798768049383, 5172.25002374646, 5178.741062946762, 5266.920996185137, 5363.2759577456545], "value": 4592.039628876593, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.8185052491667, 291.1280714260789, 301.27092436304144, 309.5774268124011, 310.3560112766011, 5162.792324255734, 5215.217717342401, 5409.377921539024, 5411.188321751739, 5441.646292990953, 5155.664881782682, 5302.893942121155, 5353.3843607985, 5374.516293533581, 5402.35171779386, 3403.7106845918, 3776.905577360574, 4112.835486580533, 4145.316022856225, 4165.0, 3025.727684508394, 4018.0557568971267, 4131.979340103296, 4196.034911970249, 4204.390363397306, 4012.0, 4031.266555381185, 4052.939205911899, 4054.1891621675636, 4070.1656160487178, 3333.96666033339, 4006.5793091725386, 4055.6755459563165, 4060.7360521566, 4073.490813648294, 2902.795339933946, 3052.5879006334085, 3490.7905525668543, 3501.3872572299747, 3518.894433167009, 4110.671146308288, 4390.0122472443445, 4928.398270562082, 5186.7147306898105, 5249.112987856702, 4382.780860956939, 4628.930566041512, 4629.768511574408, 4636.423615970552, 4645.419322584677, 5545.584081193886, 5642.379338272786, 5644.858878528029, 5648.491635752802, 5725.799597014085, 2927.5901373807683, 3556.893293201208, 3821.636944490269, 3867.245887052026, 3890.533136023667, 4998.375203099649, 5884.440978107073, 5925.4370834770625, 5930.495907847795, 5943.465088142045, 3292.851821668031, 3884.3008258513737, 3914.373700207953, 3928.4107383892074, 3933.8623148189677, 3304.2565422780162, 3832.770033797981, 3991.2416640838146, 3993.381025940984, 3996.200759847984, 4587.0, 4590.632749380042, 4615.861524154281, 4615.8846028848875, 4655.324977878188, 5632.3804381518, 5712.314522257273, 5727.627704199213, 5741.712914354265, 5788.88422231553, 1164.2723297938787, 1262.7348256866162, 1263.15999860092, 1283.0313113599173, 1311.6786387335164, 811.9147489513634, 856.246503077288, 908.504864848659, 909.8953620333747, 921.6543796076471, 4389.407429996973, 5080.74596270185, 5197.8440646780655, 5207.3490813648295, 5216.739163041832, 5143.5568105150505, 5765.221695071195, 5777.64225407029, 5794.710264486759, 5805.506531944748, 4761.452527928368, 4777.4267087949665, 4882.51174882516, 5048.545630893237, 5254.448282930237, 2436.6954130733657, 3022.2897619059504, 3032.6209223847018, 3033.8179709217516, 3051.8474076296097, 5426.8371948841595, 5429.701366424884, 5678.290213723285, 5882.852928676817, 5939.881202375928, 4924.606031517542, 5533.6403133796175, 5588.524975377057, 5896.675682837399, 5943.524518038546, 4884.65807393479, 5446.673199608036, 5508.366537848118, 5927.006861534811, 5945.781114871527, 4854.757262136808, 5370.697021331931, 5680.375158732453, 5741.741621626953, 5753.654780713171, 4644.58198762113, 5517.806876759294, 5671.801486948102, 5685.403032681675, 5710.914336285042, 4902.803887844446, 5908.409159084057, 5956.910646340221, 5962.612430192024, 5979.760809567569, 2981.381098279499, 3826.3112639724004, 3848.9037774055873, 3901.882943511699, 3946.585608511065, 4902.975485122552, 5208.895822083613, 5405.513463806693, 5805.187273781589, 5896.587238893408, 4767.976160119178, 5427.24018637399, 5699.2590963174525, 5752.712364381848, 5763.596548241583, 5037.219231019198, 5616.5787565931905, 5655.377908429987, 5698.8290351289525, 5735.512481438957, 5663.433656634468, 5669.20631111653, 5679.756496183902, 5681.431856814285, 5715.457031581993, 5270.025045366619, 5428.7285635718845, 5767.75057727495, 5776.624519406225, 5782.277215348082, 5230.8169214077325, 5345.492178243061, 5584.860378490408, 5644.238027866186, 5697.259356283656], "value": 4081.2583943399472, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.634023477909, 724.3589423360324, 729.3690957321915, 759.051186017478, 790.4585359029069, 15645.374185032599, 16725.74911376327, 16728.33086676533, 16728.996260224394, 16741.162941852905, 15003.624909377271, 15183.620409489768, 15227.238638068107, 15244.237788110606, 15250.618734531643, 696.8815301398774, 716.0762616225063, 718.8813845715476, 720.2797202797203, 854.6325080215489, 689.396777819408, 714.5819695478151, 717.0642311783121, 861.3109512390063, 865.472062042157, 902.2331018634175, 912.6440688131634, 916.8716379706847, 919.4758987377197, 921.7695576105973, 903.742433406476, 904.9909500905038, 907.7004588485784, 911.1662828511903, 912.4388501071826, 530.2682298428144, 655.4297760948006, 680.6664734280216, 680.9829754256134, 681.3731367142192, 15206.315715792816, 15261.6184595386, 15285.312160952784, 15317.540473785804, 15375.615609609737, 13976.301184940712, 14192.645183870383, 14217.431302747878, 14270.714585708332, 14457.421703131862, 13093.410796514085, 13121.0, 13283.86716132836, 13447.0, 13462.259575723332, 4553.704009239389, 4606.378138951232, 4608.9308660370125, 4628.25947848346, 4818.156822556039, 113858.29212561819, 115908.0, 119566.40216798948, 119681.40159299235, 119775.40112299469, 11065.668029959113, 11204.887951120547, 11423.143264255214, 11523.193376463567, 11613.187076904536, 22837.0, 22844.42888927757, 22858.657120143213, 22902.0, 22904.427389315402, 7882.290593846466, 7966.8448075029955, 7976.960115199503, 8142.592870356577, 8211.507309561446, 3653.415453527423, 4356.803943822536, 4375.387445757597, 4399.670024748093, 4566.292224705176, 3543.557055368079, 3664.3953747631876, 3668.7248456365346, 3670.3209906167444, 3678.9448158277646, 578.8581797459565, 723.3200791256203, 725.5356571794056, 729.4711334282603, 733.0250766480568, 541.8293237630133, 619.8822223777468, 626.5269721360344, 627.9623222606658, 689.6172624193521, 8422.252097816536, 9046.411983221069, 9650.806983860424, 9675.951620241854, 9774.364666296668, 531.4924247343855, 639.3223183425583, 654.1855390039336, 669.846044247442, 688.4870771275432, 4284.335927931175, 4536.88657783558, 4604.608608268268, 4788.688735232199, 4799.136155491975, 108395.45802270938, 124733.12900306503, 132736.0, 138691.0, 138934.0, 129085.0, 132000.0, 133425.0, 134364.0, 135199.32400338133, 75000.0, 104733.47633261785, 105023.0, 108843.45578272059, 110491.0, 8636.568171591522, 8818.29453643694, 8976.41653292534, 9094.363394562317, 9154.221891139328, 50754.0, 61188.694056529435, 67314.66342668256, 67938.66030669815, 68806.0, 99956.0, 102667.97332026882, 106012.40981385439, 106309.46845265724, 108872.0, 11737.706557335794, 11917.344546049704, 11963.521459141884, 12085.033197344368, 12556.874431255936, 10452.790944181226, 12329.204316518018, 12983.091183617056, 13104.0, 13997.930010349883, 12030.583869347207, 13346.933265333611, 14065.578032659037, 14316.427342906583, 14434.347034133156, 13573.1856088635, 14044.0, 14164.858351416355, 14247.358868851134, 14813.407463701331, 13770.724585508435, 13915.234662093682, 14025.158490490603, 14099.083559568595, 14219.573412797632, 11014.834777478183, 11452.484638191469, 11515.25150865191, 11629.76740465169, 11648.88351116478, 9387.202087822612, 11012.789560845456, 11368.602098926498, 11620.883791162318, 11725.120615954009], "value": 7875.635961052961, "unit": "score"}], "name": "dromaeo_css", "value": 7425.529666377606, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 113.0, 113.0, 108.0, 113.0, 112.0, 111.0, 112.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 108.0, 163.0, 110.0, 105.0, 129.0, 107.0, 141.0, 107.0], "value": 122.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 188.0, 185.0, 185.0, 182.0, 183.0, 181.0, 183.0, 184.0, 182.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 74.0, 59.0, 88.0, 58.0, 59.0, 59.0, 70.0, 108.0, 80.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 92.0, 96.0, 71.0, 73.0, 69.0, 95.0, 71.0, 67.0, 102.0], "value": 82.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 87.0, 85.0, 87.0, 85.0, 87.0, 84.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 94.0, 94.0, 92.0, 93.0, 92.0, 93.0, 93.0, 123.0], "value": 95.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 86.0, 86.0, 83.0, 84.0, 85.0, 87.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 55.0, 55.0, 55.0, 56.0, 52.0, 53.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 68.0, 73.0, 76.0, 69.0, 70.0, 70.0, 69.0, 71.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 85.0, 82.0, 85.0, 85.0, 86.0, 86.0, 89.0, 86.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 138.0, 134.0, 140.0, 153.0, 130.0, 151.0, 218.0, 162.0], "value": 150.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 168.0, 167.0, 167.0, 167.0, 169.0, 166.0, 166.0, 171.0, 165.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 67.0, 68.0, 68.0, 67.0, 67.0, 65.0, 66.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1433.8, "alertThreshold": 2.0}]} 08:48:48 INFO - Return code: 0 08:48:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:48:49 ERROR - # TBPL SUCCESS # 08:48:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:48:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:48:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:48:49 INFO - 2016-08-19 08:48:49.027 screenresolution[1657:10255] starting screenresolution argv=screenresolution get 08:48:49 INFO - 2016-08-19 08:48:49.029 screenresolution[1657:10255] Display 0: 1600x1200x32@60 08:48:49 INFO - 2016-08-19 08:48:49.036 screenresolution[1658:10258] starting screenresolution argv=screenresolution list 08:48:49 INFO - Available Modes on Display 0 08:48:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:48:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:48:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:48:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:48:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:48:49 INFO - Intel Iris: 08:48:49 INFO - Chipset Model: Intel Iris 08:48:49 INFO - Type: GPU 08:48:49 INFO - Bus: Built-In 08:48:49 INFO - VRAM (Dynamic, Max): 1536 MB 08:48:49 INFO - Vendor: Intel (0x8086) 08:48:49 INFO - Device ID: 0x0a2e 08:48:49 INFO - Revision ID: 0x0009 08:48:49 INFO - Displays: 08:48:49 INFO - Display: 08:48:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:48:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:48:49 INFO - Display Serial Number: 1600x1200 60 08:48:49 INFO - Main Display: Yes 08:48:49 INFO - Mirror: Off 08:48:49 INFO - Online: Yes 08:48:49 INFO - Rotation: Supported 08:48:49 INFO - Return code: 0 08:48:49 INFO - Running post-action listener: _resource_record_post_action 08:48:49 INFO - [mozharness: 2016-08-19 15:48:49.270205Z] Finished run-tests step (success) 08:48:49 INFO - Running post-run listener: _resource_record_post_run 08:48:49 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 38179840; Write bytes: 706017280; Read time: 379; Write time: 1894 08:48:49 INFO - TinderboxPrint: CPU usage
53.5% 08:48:49 INFO - TinderboxPrint: I/O read bytes / time
38,179,840 / 379 08:48:49 INFO - TinderboxPrint: I/O write bytes / time
706,017,280 / 1,894 08:48:49 INFO - TinderboxPrint: CPU idle
2,252.2 (46.5%) 08:48:49 INFO - TinderboxPrint: CPU system
970.7 (20.0%) 08:48:49 INFO - TinderboxPrint: CPU user
1,622.7 (33.5%) 08:48:49 INFO - TinderboxPrint: Swap in / out
443,633,664 / 0 08:48:49 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 406356480; Write bytes: 407750656; Read time: 30010; Write time: 746 08:48:49 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 34497536; Write bytes: 296816640; Read time: 345; Write time: 1141 08:48:49 INFO - Running post-run listener: _upload_blobber_files 08:48:49 INFO - Blob upload gear active. 08:48:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:48:49 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 08:48:49 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:48:49 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:48:50 INFO - (blobuploader) - INFO - Open directory for files ... 08:48:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:48:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:48:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:51 INFO - (blobuploader) - INFO - Done attempting. 08:48:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:48:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:48:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:52 INFO - (blobuploader) - INFO - Done attempting. 08:48:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:48:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:48:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:54 INFO - (blobuploader) - INFO - Done attempting. 08:48:54 INFO - (blobuploader) - INFO - Iteration through files over. 08:48:54 INFO - Return code: 0 08:48:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:48:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:48:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d8dee707c004f1f0b2fb19325f67742806857aecbb4349b43b582e065dcc337467ca64723b650aab0a44379e35fed2b422fdf3c187cb9e4e7dcde97f7e8375cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a6eb7ea63fbfb981f70d64c347aefef62734c592dd8a2d15dd2d0ebe4cabc847adb4fdcc25b3d6d394ac610eef81aa55f67751b9895c0cf736d1b1b2933c690c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fcecd049ae41fdf3c0bafe4505c1bf696816372ab0ede32d2a13b0a7c972539d6d42bfb80d81f89d5a16e3bea03bf461dd1ce4a40519fdd5a2564ec40f21eb33"} 08:48:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:48:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:48:54 INFO - Contents: 08:48:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d8dee707c004f1f0b2fb19325f67742806857aecbb4349b43b582e065dcc337467ca64723b650aab0a44379e35fed2b422fdf3c187cb9e4e7dcde97f7e8375cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a6eb7ea63fbfb981f70d64c347aefef62734c592dd8a2d15dd2d0ebe4cabc847adb4fdcc25b3d6d394ac610eef81aa55f67751b9895c0cf736d1b1b2933c690c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fcecd049ae41fdf3c0bafe4505c1bf696816372ab0ede32d2a13b0a7c972539d6d42bfb80d81f89d5a16e3bea03bf461dd1ce4a40519fdd5a2564ec40f21eb33"} 08:48:54 INFO - Running post-run listener: copy_logs_to_upload_dir 08:48:54 INFO - Copying logs to upload dir... 08:48:54 INFO - mkdir: /builds/slave/test/build/upload/logs 08:48:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.361175 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-08-19 08:48:54.826783) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 08:48:54.830143) ========= 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.m6XOMx2yKC/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.dLO0qy0ZH0/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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/Autoland/sha512/d8dee707c004f1f0b2fb19325f67742806857aecbb4349b43b582e065dcc337467ca64723b650aab0a44379e35fed2b422fdf3c187cb9e4e7dcde97f7e8375cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a6eb7ea63fbfb981f70d64c347aefef62734c592dd8a2d15dd2d0ebe4cabc847adb4fdcc25b3d6d394ac610eef81aa55f67751b9895c0cf736d1b1b2933c690c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fcecd049ae41fdf3c0bafe4505c1bf696816372ab0ede32d2a13b0a7c972539d6d42bfb80d81f89d5a16e3bea03bf461dd1ce4a40519fdd5a2564ec40f21eb33"} build_url:https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011028 build_url: 'https://queue.taskcluster.net/v1/task/bC5NaGWJQhOebnWXWrvIbQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d8dee707c004f1f0b2fb19325f67742806857aecbb4349b43b582e065dcc337467ca64723b650aab0a44379e35fed2b422fdf3c187cb9e4e7dcde97f7e8375cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a6eb7ea63fbfb981f70d64c347aefef62734c592dd8a2d15dd2d0ebe4cabc847adb4fdcc25b3d6d394ac610eef81aa55f67751b9895c0cf736d1b1b2933c690c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fcecd049ae41fdf3c0bafe4505c1bf696816372ab0ede32d2a13b0a7c972539d6d42bfb80d81f89d5a16e3bea03bf461dd1ce4a40519fdd5a2564ec40f21eb33"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 08:48:54.863999) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:48:54.864370) ========= 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.m6XOMx2yKC/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.dLO0qy0ZH0/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.005055 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:48:54.913869) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 08:48:54.914223) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 08:48:54.914613) ========= ========= Total master_lag: 0.19 =========