builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0066 starttime: 1470658113.95 results: success (0) buildid: 20160808012421 builduid: f64ec4b55952477e87b269089c3452c5 revision: f8fc21bb232095b7b4c995d259558212cb90a44b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:33.946606) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:33.947038) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:33.947305) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:33.973487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:33.973746) ========= 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.ViJ9Eifici/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.XVVeYvCRdv/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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-08 05:08:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 12.1M=0.001s 2016-08-08 05:08:34 (12.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.359179 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:34.356702) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:34.357036) ========= 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.ViJ9Eifici/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.XVVeYvCRdv/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.027660 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:34.406158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:34.406486) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f8fc21bb232095b7b4c995d259558212cb90a44b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f8fc21bb232095b7b4c995d259558212cb90a44b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ViJ9Eifici/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.XVVeYvCRdv/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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-08 05:08:34,485 truncating revision to first 12 chars 2016-08-08 05:08:34,486 Setting DEBUG logging. 2016-08-08 05:08:34,486 attempt 1/10 2016-08-08 05:08:34,486 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f8fc21bb2320?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 05:08:34,780 unpacking tar archive at: fx-team-f8fc21bb2320/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571564 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:35.001564) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:35.001881) ========= script_repo_revision: f8fc21bb232095b7b4c995d259558212cb90a44b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:35.002252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:35.002527) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:08:35.023555) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-08 05:08:35.023815) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ViJ9Eifici/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.XVVeYvCRdv/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 05:08:35 INFO - MultiFileLogger online at 20160808 05:08:35 in /builds/slave/test 05:08:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:08:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:08:35 INFO - {'append_to_log': False, 05:08:35 INFO - 'base_work_dir': '/builds/slave/test', 05:08:35 INFO - 'blob_upload_branch': 'Fx-Team', 05:08:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:08:35 INFO - 'branch': 'Fx-Team', 05:08:35 INFO - 'buildbot_json_path': 'buildprops.json', 05:08:35 INFO - 'config_files': ('talos/mac_config.py',), 05:08:35 INFO - 'default_actions': ('clobber', 05:08:35 INFO - 'read-buildbot-config', 05:08:35 INFO - 'download-and-extract', 05:08:35 INFO - 'populate-webroot', 05:08:35 INFO - 'create-virtualenv', 05:08:35 INFO - 'install', 05:08:35 INFO - 'run-tests'), 05:08:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:08:35 INFO - 'download_minidump_stackwalk': True, 05:08:35 INFO - 'download_symbols': 'ondemand', 05:08:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:08:35 INFO - 'tooltool.py': '/tools/tooltool.py', 05:08:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:08:35 INFO - '/tools/misc-python/virtualenv.py')}, 05:08:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:08:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:08:35 INFO - 'installer_path': 'installer.exe', 05:08:35 INFO - 'log_level': 'info', 05:08:35 INFO - 'log_name': 'talos', 05:08:35 INFO - 'log_to_console': True, 05:08:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:08:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:08:35 INFO - 'opt_config_files': (), 05:08:35 INFO - 'pip_index': False, 05:08:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:08:35 INFO - 'cmd': ('bash', 05:08:35 INFO - '-c', 05:08:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:08:35 INFO - 'enabled': True, 05:08:35 INFO - 'halt_on_failure': False, 05:08:35 INFO - 'name': 'check_screen_resolution'},), 05:08:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:08:35 INFO - 'cmd': ('bash', 05:08:35 INFO - '-c', 05:08:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:08:35 INFO - 'enabled': True, 05:08:35 INFO - 'halt_on_failure': False, 05:08:35 INFO - 'name': 'check_screen_resolution'},), 05:08:35 INFO - 'run_cmd_checks_enabled': True, 05:08:35 INFO - 'sps_profile': False, 05:08:35 INFO - 'sps_profile_interval': 0, 05:08:35 INFO - 'suite': 'dromaeojs-e10s', 05:08:35 INFO - 'system_bits': '32', 05:08:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:08:35 INFO - 'title': 't-yosemite-r7-0066', 05:08:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:08:35 INFO - 'use_talos_json': True, 05:08:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:08:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:08:35 INFO - 'work_dir': 'build'} 05:08:35 INFO - [mozharness: 2016-08-08 12:08:35.240579Z] Running clobber step. 05:08:35 INFO - Running pre-action listener: _resource_record_pre_action 05:08:35 INFO - Running main action method: clobber 05:08:35 INFO - rmtree: /builds/slave/test/build 05:08:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:08:36 INFO - Running post-action listener: _resource_record_post_action 05:08:36 INFO - [mozharness: 2016-08-08 12:08:36.890488Z] Finished clobber step (success) 05:08:36 INFO - [mozharness: 2016-08-08 12:08:36.890620Z] Running read-buildbot-config step. 05:08:36 INFO - Running pre-action listener: _resource_record_pre_action 05:08:36 INFO - Running main action method: read_buildbot_config 05:08:36 INFO - Using buildbot properties: 05:08:36 INFO - { 05:08:36 INFO - "project": "", 05:08:36 INFO - "product": "firefox", 05:08:36 INFO - "script_repo_revision": "production", 05:08:36 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:08:36 INFO - "repository": "", 05:08:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:08:36 INFO - "buildid": "20160808012421", 05:08:36 INFO - "pgo_build": "False", 05:08:36 INFO - "basedir": "/builds/slave/test", 05:08:36 INFO - "buildnumber": 81, 05:08:36 INFO - "slavename": "t-yosemite-r7-0066", 05:08:36 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:08:36 INFO - "platform": "yosemite_r7", 05:08:36 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:08:36 INFO - "branch": "fx-team", 05:08:36 INFO - "repo_path": "integration/fx-team", 05:08:36 INFO - "revision": "f8fc21bb232095b7b4c995d259558212cb90a44b", 05:08:36 INFO - "stage_platform": "macosx64", 05:08:36 INFO - "builduid": "f64ec4b55952477e87b269089c3452c5", 05:08:36 INFO - "slavebuilddir": "test" 05:08:36 INFO - } 05:08:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:08:36 INFO - Running post-action listener: _resource_record_post_action 05:08:36 INFO - [mozharness: 2016-08-08 12:08:36.893804Z] Finished read-buildbot-config step (success) 05:08:36 INFO - [mozharness: 2016-08-08 12:08:36.893915Z] Running download-and-extract step. 05:08:36 INFO - Running pre-action listener: _resource_record_pre_action 05:08:36 INFO - Running main action method: download_and_extract 05:08:36 INFO - mkdir: /builds/slave/test/build/tests 05:08: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')]} 05:08:36 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:08:36 INFO - Downloading https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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 05:08:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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 05:08:38 INFO - Downloaded 1199 bytes. 05:08:38 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:08:38 INFO - Using the following test package requirements: 05:08:38 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:08:38 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:38 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:08:38 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:38 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:08:38 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:38 INFO - u'jsshell-mac.zip'], 05:08:38 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:38 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:08:38 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:08:38 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:38 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:08:38 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:38 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:08:38 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:38 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:08:38 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:08:38 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:08:38 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:08: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')]} 05:08:38 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:08:38 INFO - Downloading https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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 05:08:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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 05:08:39 INFO - Downloaded 16320444 bytes. 05:08:39 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:08:45 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 05:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:45 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:08:45 INFO - Downloading https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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 05:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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 05:08:47 INFO - Downloaded 16320444 bytes. 05:08:47 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:54 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:08:54 INFO - Downloading https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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 05:08:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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 05:08:56 INFO - Downloaded 14413723 bytes. 05:08:56 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 05:08:57 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')]} 05:08:57 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:08:57 INFO - Downloading https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:08:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/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 05:09:00 INFO - Downloaded 111901101 bytes. 05:09:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:09:00 INFO - mkdir: /builds/slave/test/properties 05:09:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:09:00 INFO - Writing to file /builds/slave/test/properties/build_url 05:09:00 INFO - Contents: 05:09:00 INFO - build_url:https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:09:01 INFO - Running post-action listener: _resource_record_post_action 05:09:01 INFO - Running post-action listener: set_extra_try_arguments 05:09:01 INFO - [mozharness: 2016-08-08 12:09:01.107782Z] Finished download-and-extract step (success) 05:09:01 INFO - [mozharness: 2016-08-08 12:09:01.107930Z] Running populate-webroot step. 05:09:01 INFO - Running pre-action listener: _resource_record_pre_action 05:09:01 INFO - Running main action method: populate_webroot 05:09:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:09:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:09:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:09:01 INFO - '--tppagecycles', 05:09:01 INFO - '7'], 05:09:01 INFO - 'tests': ['tsvgm']}}, 05:09:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:09:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:09:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:09:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:09:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:09:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:09:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:01 INFO - 'talos_options': ['--disable-e10s'], 05:09:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:01 INFO - 'talos_options': ['--disable-e10s'], 05:09:01 INFO - 'tests': ['damp', 'tps']}, 05:09:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:01 INFO - 'tests': ['damp', 'tps']}, 05:09:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:09:01 INFO - 'tests': ['dromaeo_dom']}, 05:09:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:09:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:09:01 INFO - 'tests': ['basic_compositor_video']}, 05:09:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:09:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:09:01 INFO - 'tests': ['a11yr', 05:09:01 INFO - 'ts_paint', 05:09:01 INFO - 'tpaint', 05:09:01 INFO - 'sessionrestore', 05:09:01 INFO - 'sessionrestore_no_auto_restore', 05:09:01 INFO - 'tabpaint']}, 05:09:01 INFO - 'other-e10s': {'tests': ['a11yr', 05:09:01 INFO - 'ts_paint', 05:09:01 INFO - 'tpaint', 05:09:01 INFO - 'sessionrestore', 05:09:01 INFO - 'sessionrestore_no_auto_restore', 05:09:01 INFO - 'tabpaint']}, 05:09:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:09:01 INFO - 'ts_paint', 05:09:01 INFO - 'tpaint', 05:09:01 INFO - 'sessionrestore', 05:09:01 INFO - 'sessionrestore_no_auto_restore', 05:09:01 INFO - 'tabpaint']}, 05:09:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:09:01 INFO - 'ts_paint', 05:09:01 INFO - 'tpaint', 05:09:01 INFO - 'sessionrestore', 05:09:01 INFO - 'sessionrestore_no_auto_restore', 05:09:01 INFO - 'tabpaint']}, 05:09:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:09:01 INFO - 'tests': ['a11yr', 05:09:01 INFO - 'ts_paint', 05:09:01 INFO - 'tpaint', 05:09:01 INFO - 'sessionrestore', 05:09:01 INFO - 'sessionrestore_no_auto_restore', 05:09:01 INFO - 'tabpaint']}, 05:09:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:09:01 INFO - 'tests': ['a11yr', 05:09:01 INFO - 'ts_paint', 05:09:01 INFO - 'tpaint', 05:09:01 INFO - 'sessionrestore', 05:09:01 INFO - 'sessionrestore_no_auto_restore', 05:09:01 INFO - 'tabpaint']}, 05:09:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:09:01 INFO - 'tests': ['tsvgx', 05:09:01 INFO - 'tsvgr_opacity', 05:09:01 INFO - 'tart', 05:09:01 INFO - 'tscrollx', 05:09:01 INFO - 'cart']}, 05:09:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:09:01 INFO - 'tsvgr_opacity', 05:09:01 INFO - 'tart', 05:09:01 INFO - 'tscrollx', 05:09:01 INFO - 'cart']}, 05:09:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:01 INFO - 'talos_options': ['--disable-e10s'], 05:09:01 INFO - 'tests': ['tp5o']}, 05:09:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:01 INFO - 'tests': ['tp5o']}, 05:09:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:01 INFO - 'talos_options': ['--disable-e10s', 05:09:01 INFO - '--xperf_path', 05:09:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:01 INFO - 'tests': ['tp5n']}, 05:09:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:01 INFO - 'talos_options': ['--xperf_path', 05:09:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:01 INFO - 'tests': ['tp5n']}}, 05:09:01 INFO - 'talos.zip': {'path': '', 05:09:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:09:01 INFO - Running post-action listener: _resource_record_post_action 05:09:01 INFO - [mozharness: 2016-08-08 12:09:01.126750Z] Finished populate-webroot step (success) 05:09:01 INFO - [mozharness: 2016-08-08 12:09:01.126854Z] Running create-virtualenv step. 05:09:01 INFO - Running pre-action listener: _resource_record_pre_action 05:09:01 INFO - Running main action method: create_virtualenv 05:09:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:09:01 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 05:09:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:09:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:09:01 INFO - Using real prefix '/tools/python27' 05:09:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:09:01 INFO - Installing distribute.............................................................................................................................................................................................done. 05:09:04 INFO - Installing pip.................done. 05:09:04 INFO - Return code: 0 05:09:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108284a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108319618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97685acaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081e8d30>, '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 0x107f4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081e0b20>, '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.ViJ9Eifici/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.XVVeYvCRdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 05:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:09:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ViJ9Eifici/Render', 05:09:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:04 INFO - 'HOME': '/Users/cltbld', 05:09:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:04 INFO - 'LOGNAME': 'cltbld', 05:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:04 INFO - 'MOZ_NO_REMOTE': '1', 05:09:04 INFO - 'NO_EM_RESTART': '1', 05:09:04 INFO - 'PAGER': '/bin/cat', 05:09:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:04 INFO - 'PWD': '/builds/slave/test', 05:09:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:04 INFO - 'SHELL': '/bin/bash', 05:09:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVVeYvCRdv/Listeners', 05:09:04 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:09:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:04 INFO - 'USER': 'cltbld', 05:09:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:04 INFO - 'XPC_FLAGS': '0x0', 05:09:04 INFO - 'XPC_SERVICE_NAME': '0', 05:09:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:05 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 05:09:05 INFO - Cleaning up... 05:09:05 INFO - Return code: 0 05:09:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:05 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 0x108284a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108319618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97685acaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081e8d30>, '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 0x107f4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081e0b20>, '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.ViJ9Eifici/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.XVVeYvCRdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 05:09:05 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 05:09:05 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 05:09:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ViJ9Eifici/Render', 05:09:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:05 INFO - 'HOME': '/Users/cltbld', 05:09:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:05 INFO - 'LOGNAME': 'cltbld', 05:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:05 INFO - 'MOZ_NO_REMOTE': '1', 05:09:05 INFO - 'NO_EM_RESTART': '1', 05:09:05 INFO - 'PAGER': '/bin/cat', 05:09:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:05 INFO - 'PWD': '/builds/slave/test', 05:09:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:05 INFO - 'SHELL': '/bin/bash', 05:09:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVVeYvCRdv/Listeners', 05:09:05 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:09:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:05 INFO - 'USER': 'cltbld', 05:09:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:05 INFO - 'XPC_FLAGS': '0x0', 05:09:05 INFO - 'XPC_SERVICE_NAME': '0', 05:09:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:05 INFO - Downloading/unpacking psutil>=3.1.1 05:09:05 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 05:09:05 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 05:09:05 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 05:09:05 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 05:09:05 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 05:09:05 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 05:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:09:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:08 INFO - Installing collected packages: psutil 05:09:08 INFO - Running setup.py install for psutil 05:09:08 INFO - building 'psutil._psutil_osx' extension 05:09:08 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 05:09:09 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 05:09:09 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 05:09:09 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 05:09:09 INFO - building 'psutil._psutil_posix' extension 05:09:09 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 05:09:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:09:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:09:09 INFO - ^ 05:09:09 INFO - 1 warning generated. 05:09:09 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 05:09:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:09 INFO - Successfully installed psutil 05:09:09 INFO - Cleaning up... 05:09:09 INFO - Return code: 0 05:09:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108284a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108319618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97685acaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081e8d30>, '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 0x107f4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081e0b20>, '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.ViJ9Eifici/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.XVVeYvCRdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 05:09: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:09: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 mozsystemmonitor==0.3 05:09:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ViJ9Eifici/Render', 05:09:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:09 INFO - 'HOME': '/Users/cltbld', 05:09:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:09 INFO - 'LOGNAME': 'cltbld', 05:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:09 INFO - 'MOZ_NO_REMOTE': '1', 05:09:09 INFO - 'NO_EM_RESTART': '1', 05:09:09 INFO - 'PAGER': '/bin/cat', 05:09:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:09 INFO - 'PWD': '/builds/slave/test', 05:09:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:09 INFO - 'SHELL': '/bin/bash', 05:09:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVVeYvCRdv/Listeners', 05:09:09 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:09:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:09 INFO - 'USER': 'cltbld', 05:09:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:09 INFO - 'XPC_FLAGS': '0x0', 05:09:09 INFO - 'XPC_SERVICE_NAME': '0', 05:09:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:09:12 INFO - Installing collected packages: mozsystemmonitor 05:09:12 INFO - Running setup.py install for mozsystemmonitor 05:09:12 INFO - Successfully installed mozsystemmonitor 05:09:12 INFO - Cleaning up... 05:09:12 INFO - Return code: 0 05:09:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:09:12 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')]} 05:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:12 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')]} 05:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:12 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 0x108284a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108319618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97685acaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081e8d30>, '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 0x107f4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081e0b20>, '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.ViJ9Eifici/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.XVVeYvCRdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 05:09:12 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 05:09:12 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 05:09:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ViJ9Eifici/Render', 05:09:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:12 INFO - 'HOME': '/Users/cltbld', 05:09:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:12 INFO - 'LOGNAME': 'cltbld', 05:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:12 INFO - 'MOZ_NO_REMOTE': '1', 05:09:12 INFO - 'NO_EM_RESTART': '1', 05:09:12 INFO - 'PAGER': '/bin/cat', 05:09:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:12 INFO - 'PWD': '/builds/slave/test', 05:09:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:12 INFO - 'SHELL': '/bin/bash', 05:09:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVVeYvCRdv/Listeners', 05:09:12 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:09:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:12 INFO - 'USER': 'cltbld', 05:09:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:12 INFO - 'XPC_FLAGS': '0x0', 05:09:12 INFO - 'XPC_SERVICE_NAME': '0', 05:09:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:12 INFO - Downloading/unpacking jsonschema==2.5.1 05:09:12 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 05:09:12 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 05:09:12 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 05:09:12 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 05:09:12 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 05:09:12 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 05:09:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:09:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:09:15 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 05:09:15 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 05:09:15 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 05:09:15 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 05:09:15 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 05:09:15 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 05:09:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:09:15 INFO - warning: no files found matching '*.txt' 05:09:15 INFO - no previously-included directories found matching 'build' 05:09:15 INFO - no previously-included directories found matching 'dist' 05:09:15 INFO - no previously-included directories found matching '.git*' 05:09:15 INFO - Installing collected packages: jsonschema, functools32 05:09:15 INFO - Running setup.py install for functools32 05:09:15 INFO - warning: no files found matching '*.txt' 05:09:15 INFO - no previously-included directories found matching 'build' 05:09:15 INFO - no previously-included directories found matching 'dist' 05:09:15 INFO - no previously-included directories found matching '.git*' 05:09:15 INFO - Successfully installed jsonschema functools32 05:09:15 INFO - Cleaning up... 05:09:15 INFO - Return code: 0 05:09:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:15 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 0x108284a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108319618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97685acaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081e8d30>, '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 0x107f4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081e0b20>, '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.ViJ9Eifici/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.XVVeYvCRdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 05:09:15 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 05:09:15 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 05:09:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ViJ9Eifici/Render', 05:09:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:15 INFO - 'HOME': '/Users/cltbld', 05:09:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:15 INFO - 'LOGNAME': 'cltbld', 05:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:15 INFO - 'MOZ_NO_REMOTE': '1', 05:09:15 INFO - 'NO_EM_RESTART': '1', 05:09:15 INFO - 'PAGER': '/bin/cat', 05:09:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:15 INFO - 'PWD': '/builds/slave/test', 05:09:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:15 INFO - 'SHELL': '/bin/bash', 05:09:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVVeYvCRdv/Listeners', 05:09:15 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:09:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:15 INFO - 'USER': 'cltbld', 05:09:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:15 INFO - 'XPC_FLAGS': '0x0', 05:09:15 INFO - 'XPC_SERVICE_NAME': '0', 05:09:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:09:16 INFO - Cleaning up... 05:09:16 INFO - Return code: 0 05:09:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108284a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108319618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97685acaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081e8d30>, '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 0x107f4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081e0b20>, '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.ViJ9Eifici/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.XVVeYvCRdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 05:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:09:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ViJ9Eifici/Render', 05:09:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:16 INFO - 'HOME': '/Users/cltbld', 05:09:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:16 INFO - 'LOGNAME': 'cltbld', 05:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:16 INFO - 'MOZ_NO_REMOTE': '1', 05:09:16 INFO - 'NO_EM_RESTART': '1', 05:09:16 INFO - 'PAGER': '/bin/cat', 05:09:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:16 INFO - 'PWD': '/builds/slave/test', 05:09:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:16 INFO - 'SHELL': '/bin/bash', 05:09:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVVeYvCRdv/Listeners', 05:09:16 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:09:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:16 INFO - 'USER': 'cltbld', 05:09:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:16 INFO - 'XPC_FLAGS': '0x0', 05:09:16 INFO - 'XPC_SERVICE_NAME': '0', 05:09:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:16 INFO - Downloading/unpacking blobuploader==1.2.4 05:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:18 INFO - Downloading blobuploader-1.2.4.tar.gz 05:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:09:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:09:18 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 05:09:18 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 05:09:18 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 05:09:18 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 05:09:18 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 05:09:18 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 05:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:09:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:20 INFO - Downloading docopt-0.6.1.tar.gz 05:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:09:20 INFO - Installing collected packages: blobuploader, requests, docopt 05:09:20 INFO - Running setup.py install for blobuploader 05:09:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:09:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:09:20 INFO - Running setup.py install for requests 05:09:20 INFO - Running setup.py install for docopt 05:09:20 INFO - Successfully installed blobuploader requests docopt 05:09:20 INFO - Cleaning up... 05:09:21 INFO - Return code: 0 05:09:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:21 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 0x108284a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108319618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97685acaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081e8d30>, '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 0x107f4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081e0b20>, '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.ViJ9Eifici/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.XVVeYvCRdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 05:09:21 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 05:09:21 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 05:09:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ViJ9Eifici/Render', 05:09:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:21 INFO - 'HOME': '/Users/cltbld', 05:09:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:21 INFO - 'LOGNAME': 'cltbld', 05:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:21 INFO - 'MOZ_NO_REMOTE': '1', 05:09:21 INFO - 'NO_EM_RESTART': '1', 05:09:21 INFO - 'PAGER': '/bin/cat', 05:09:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:21 INFO - 'PWD': '/builds/slave/test', 05:09:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:21 INFO - 'SHELL': '/bin/bash', 05:09:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVVeYvCRdv/Listeners', 05:09:21 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:09:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:21 INFO - 'USER': 'cltbld', 05:09:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:21 INFO - 'XPC_FLAGS': '0x0', 05:09:21 INFO - 'XPC_SERVICE_NAME': '0', 05:09:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:21 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-XaD4lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:21 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-kZToro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:21 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-94JQV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:21 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-9VHxJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:21 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-F9VSLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:21 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-J3fpHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:21 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-wHDOHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-sfdWfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-iCnsiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-LYsNqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-aLrM2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-wb_SM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-B_xT5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-FaEvTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-TeCQbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-PUCZbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-QH9L7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:09:23 INFO - Running setup.py install for manifestparser 05:09:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:09:23 INFO - Running setup.py install for mozcrash 05:09:23 INFO - Running setup.py install for mozdebug 05:09:23 INFO - Running setup.py install for mozdevice 05:09:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:09:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:09:23 INFO - Running setup.py install for mozfile 05:09:23 INFO - Running setup.py install for mozhttpd 05:09:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:09:23 INFO - Running setup.py install for mozinfo 05:09:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Running setup.py install for mozInstall 05:09:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Running setup.py install for mozleak 05:09:24 INFO - Running setup.py install for mozlog 05:09:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Running setup.py install for moznetwork 05:09:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Running setup.py install for mozprocess 05:09:24 INFO - Running setup.py install for mozprofile 05:09:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:09:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:09:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:09:25 INFO - Running setup.py install for mozrunner 05:09:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:09:25 INFO - Running setup.py install for mozscreenshot 05:09:25 INFO - Running setup.py install for moztest 05:09:25 INFO - Running setup.py install for mozversion 05:09:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:09:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:25 INFO - Cleaning up... 05:09:25 INFO - Return code: 0 05:09:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:25 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 0x108284a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108319618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97685acaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081e8d30>, '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 0x107f4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081e0b20>, '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.ViJ9Eifici/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.XVVeYvCRdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 05:09:25 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 05:09:25 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 05:09:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ViJ9Eifici/Render', 05:09:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:25 INFO - 'HOME': '/Users/cltbld', 05:09:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:25 INFO - 'LOGNAME': 'cltbld', 05:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:25 INFO - 'MOZ_NO_REMOTE': '1', 05:09:25 INFO - 'NO_EM_RESTART': '1', 05:09:25 INFO - 'PAGER': '/bin/cat', 05:09:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:25 INFO - 'PWD': '/builds/slave/test', 05:09:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:25 INFO - 'SHELL': '/bin/bash', 05:09:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVVeYvCRdv/Listeners', 05:09:25 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:09:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:25 INFO - 'USER': 'cltbld', 05:09:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:25 INFO - 'XPC_FLAGS': '0x0', 05:09:25 INFO - 'XPC_SERVICE_NAME': '0', 05:09:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:25 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-jV0ES9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:26 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)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:26 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-VLL_Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:26 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)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:26 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-zvuk3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:26 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)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:26 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-R2Xztn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:26 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)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:26 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-jsN82m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:26 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)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:26 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-0rNI3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:26 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)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:26 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-6YYEa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:26 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)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:26 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-X0zbbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:26 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)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:26 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-ZSjMXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:26 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)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:26 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-V_3SkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:27 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)) 05:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-RCuLBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:27 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)) 05:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-k6bSVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:27 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)) 05:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-CF5WHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:27 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)) 05:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-R0H7u8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:27 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)) 05:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-s6OcKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:27 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)) 05:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-tS0o9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:27 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)) 05:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-pwfZ5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:27 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)) 05:09:27 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)) 05:09:27 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)) 05:09:27 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)) 05:09:27 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)) 05:09:27 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)) 05:09:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:27 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 05:09:27 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 05:09:27 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 05:09:27 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 05:09:27 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 05:09:27 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 05:09:30 INFO - Downloading blessings-1.6.tar.gz 05:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:30 INFO - Installing collected packages: blessings 05:09:30 INFO - Running setup.py install for blessings 05:09:30 INFO - Successfully installed blessings 05:09:30 INFO - Cleaning up... 05:09:30 INFO - Return code: 0 05:09:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:30 INFO - Reading from file tmpfile_stdout 05:09:30 INFO - Current package versions: 05:09:30 INFO - blessings == 1.6 05:09:30 INFO - blobuploader == 1.2.4 05:09:30 INFO - docopt == 0.6.1 05:09:30 INFO - functools32 == 3.2.3-2 05:09:30 INFO - jsonschema == 2.5.1 05:09:30 INFO - manifestparser == 1.1 05:09:30 INFO - mozInstall == 1.12 05:09:30 INFO - mozcrash == 0.17 05:09:30 INFO - mozdebug == 0.1 05:09:30 INFO - mozdevice == 0.48 05:09:30 INFO - mozfile == 1.2 05:09:30 INFO - mozhttpd == 0.7 05:09:30 INFO - mozinfo == 0.9 05:09:30 INFO - mozleak == 0.1 05:09:30 INFO - mozlog == 3.3 05:09:30 INFO - moznetwork == 0.27 05:09:30 INFO - mozprocess == 0.23 05:09:30 INFO - mozprofile == 0.28 05:09:30 INFO - mozrunner == 6.12 05:09:30 INFO - mozscreenshot == 0.1 05:09:30 INFO - mozsystemmonitor == 0.3 05:09:30 INFO - moztest == 0.7 05:09:30 INFO - mozversion == 1.4 05:09:30 INFO - psutil == 3.1.1 05:09:30 INFO - requests == 1.2.3 05:09:30 INFO - wsgiref == 0.1.2 05:09:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:30 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')]} 05:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:31 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 0x108284a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108319618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97685acaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081e8d30>, '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 0x107f4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081e0b20>, '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.ViJ9Eifici/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.XVVeYvCRdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 05:09:31 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 05:09:31 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 05:09:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ViJ9Eifici/Render', 05:09:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:31 INFO - 'HOME': '/Users/cltbld', 05:09:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:31 INFO - 'LOGNAME': 'cltbld', 05:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:31 INFO - 'MOZ_NO_REMOTE': '1', 05:09:31 INFO - 'NO_EM_RESTART': '1', 05:09:31 INFO - 'PAGER': '/bin/cat', 05:09:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:31 INFO - 'PWD': '/builds/slave/test', 05:09:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:31 INFO - 'SHELL': '/bin/bash', 05:09:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVVeYvCRdv/Listeners', 05:09:31 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:09:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:31 INFO - 'USER': 'cltbld', 05:09:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:31 INFO - 'XPC_FLAGS': '0x0', 05:09:31 INFO - 'XPC_SERVICE_NAME': '0', 05:09:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:31 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)) 05:09:31 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)) 05:09:31 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)) 05:09:31 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)) 05:09:31 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)) 05:09:31 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)) 05:09:31 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)) 05:09:31 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)) 05:09:31 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)) 05:09:31 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)) 05:09:31 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)) 05:09:31 INFO - Cleaning up... 05:09:31 INFO - Return code: 0 05:09:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:31 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 0x108284a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108319618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97685acaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081e8d30>, '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 0x107f4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081e0b20>, '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.ViJ9Eifici/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.XVVeYvCRdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 05:09:31 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 05:09:31 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 05:09:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ViJ9Eifici/Render', 05:09:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:31 INFO - 'HOME': '/Users/cltbld', 05:09:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:31 INFO - 'LOGNAME': 'cltbld', 05:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:31 INFO - 'MOZ_NO_REMOTE': '1', 05:09:31 INFO - 'NO_EM_RESTART': '1', 05:09:31 INFO - 'PAGER': '/bin/cat', 05:09:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:31 INFO - 'PWD': '/builds/slave/test', 05:09:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:31 INFO - 'SHELL': '/bin/bash', 05:09:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVVeYvCRdv/Listeners', 05:09:31 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:09:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:31 INFO - 'USER': 'cltbld', 05:09:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:31 INFO - 'XPC_FLAGS': '0x0', 05:09:31 INFO - 'XPC_SERVICE_NAME': '0', 05:09:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:09:31 INFO - Cleaning up... 05:09:31 INFO - Return code: 0 05:09:31 INFO - Running post-action listener: _resource_record_post_action 05:09:31 INFO - Running post-action listener: _start_resource_monitoring 05:09:31 INFO - Starting resource monitoring. 05:09:31 INFO - [mozharness: 2016-08-08 12:09:31.792435Z] Finished create-virtualenv step (success) 05:09:31 INFO - [mozharness: 2016-08-08 12:09:31.793357Z] Running install step. 05:09:31 INFO - Running pre-action listener: _resource_record_pre_action 05:09:31 INFO - Running main action method: install 05:09:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:32 INFO - Reading from file tmpfile_stdout 05:09:32 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:32 INFO - Reading from file tmpfile_stdout 05:09:32 INFO - Output received: 05:09:32 INFO - Usage: mozinstall [options] installer 05:09:32 INFO - Options: 05:09:32 INFO - -h, --help show this help message and exit 05:09:32 INFO - -d DEST, --destination=DEST 05:09:32 INFO - Directory to install application into. [default: 05:09:32 INFO - "/builds/slave/test"] 05:09:32 INFO - --app=APP Application being installed. [default: firefox] 05:09:32 INFO - mkdir: /builds/slave/test/build/application 05:09:32 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'] 05:09:32 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 05:10:06 INFO - Reading from file tmpfile_stdout 05:10:06 INFO - Output received: 05:10:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:10:06 INFO - Running post-action listener: _resource_record_post_action 05:10:06 INFO - [mozharness: 2016-08-08 12:10:06.652441Z] Finished install step (success) 05:10:06 INFO - [mozharness: 2016-08-08 12:10:06.652582Z] Running run-tests step. 05:10:06 INFO - Running pre-action listener: _resource_record_pre_action 05:10:06 INFO - Running main action method: run_tests 05:10:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:10:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:10:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:10:06 INFO - 2016-08-08 05:10:06.666 screenresolution[1639:7480] starting screenresolution argv=screenresolution get 05:10:06 INFO - 2016-08-08 05:10:06.669 screenresolution[1639:7480] Display 0: 1600x1200x32@60 05:10:06 INFO - 2016-08-08 05:10:06.675 screenresolution[1640:7482] starting screenresolution argv=screenresolution list 05:10:06 INFO - Available Modes on Display 0 05:10:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:10:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:10:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:10:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:10:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:10:06 INFO - Intel Iris: 05:10:06 INFO - Chipset Model: Intel Iris 05:10:06 INFO - Type: GPU 05:10:06 INFO - Bus: Built-In 05:10:06 INFO - VRAM (Dynamic, Max): 1536 MB 05:10:06 INFO - Vendor: Intel (0x8086) 05:10:06 INFO - Device ID: 0x0a2e 05:10:06 INFO - Revision ID: 0x0009 05:10:06 INFO - Displays: 05:10:06 INFO - Display: 05:10:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:10:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:10:06 INFO - Display Serial Number: 1600x1200 60 05:10:06 INFO - Main Display: Yes 05:10:06 INFO - Mirror: Off 05:10:06 INFO - Online: Yes 05:10:06 INFO - Rotation: Supported 05:10:06 INFO - Return code: 0 05:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:10:06 INFO - Python 2.7.3 05:10:06 INFO - Return code: 0 05:10:06 INFO - grabbing minidump binary from tooltool 05:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:06 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 0x1081e8d30>, '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 0x107f4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1081e0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:10:06 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 05:10:06 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 05:10:06 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 05:10:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:07 INFO - Return code: 0 05:10:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:10:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:10:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:10:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:10:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:10:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:10:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ViJ9Eifici/Render', 05:10:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:07 INFO - 'HOME': '/Users/cltbld', 05:10:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:07 INFO - 'LOGNAME': 'cltbld', 05:10:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:10:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:07 INFO - 'MOZ_NO_REMOTE': '1', 05:10:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:10:07 INFO - 'NO_EM_RESTART': '1', 05:10:07 INFO - 'PAGER': '/bin/cat', 05:10:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:07 INFO - 'PWD': '/builds/slave/test', 05:10:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:10:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:07 INFO - 'SHELL': '/bin/bash', 05:10:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVVeYvCRdv/Listeners', 05:10:07 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:10:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:07 INFO - 'USER': 'cltbld', 05:10:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:07 INFO - 'XPC_FLAGS': '0x0', 05:10:07 INFO - 'XPC_SERVICE_NAME': '0', 05:10:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:10:07 INFO - mozversion application_buildid: 20160808012421 05:10:07 INFO - mozversion application_changeset: f8fc21bb232095b7b4c995d259558212cb90a44b 05:10:07 INFO - mozversion application_display_name: Nightly 05:10:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:07 INFO - mozversion application_name: Firefox 05:10:07 INFO - mozversion application_remotingname: firefox 05:10:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:10:07 INFO - mozversion application_vendor: Mozilla 05:10:07 INFO - mozversion application_version: 51.0a1 05:10:07 INFO - mozversion platform_buildid: 20160808012421 05:10:07 INFO - mozversion platform_changeset: f8fc21bb232095b7b4c995d259558212cb90a44b 05:10:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:10:07 INFO - mozversion platform_version: 51.0a1 05:10:07 INFO - using testdate: 1470658207 05:10:07 INFO - actual date: 1470658207 05:10:07 INFO - starting webserver on 'localhost:49270' 05:10:07 INFO - SUITE-START | Running 2 tests 05:10:07 INFO - TEST-START | dromaeo_css 05:10:07 INFO - operating with platform_type : mac_ 05:10:07 INFO - Initialising browser for dromaeo_css test... 05:10:07 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpO85yrg/profile http://localhost:49270/getInfo.html) 05:10:10 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 05:10:10 INFO - PROCESS | 1650 | colorDepth:24 05:10:10 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 05:10:10 INFO - PROCESS | 1650 | __metrics 05:10:10 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:10:10 INFO - TEST-INFO | 1650: exit 0 05:10:10 INFO - Browser initialized. 05:10:10 INFO - Running cycle 1/1 for dromaeo_css test... 05:10:10 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpO85yrg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:22 INFO - PROCESS | 1653 | RSS: Main: 254885888 05:10:22 INFO - PROCESS | 1653 | 05:11:12 INFO - PROCESS | 1653 | 1470658272522 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] 05:13:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 05:13:26 INFO - PROCESS | 1653 | RSS: Main: 270200832 05:13:26 INFO - PROCESS | 1653 | 05:16:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 05:16:29 INFO - PROCESS | 1653 | RSS: Main: 280379392 05:16:29 INFO - PROCESS | 1653 | 05:19:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 05:19:31 INFO - PROCESS | 1653 | RSS: Main: 290078720 05:19:31 INFO - PROCESS | 1653 | 05:22:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 05:22:34 INFO - PROCESS | 1653 | RSS: Main: 291229696 05:22:34 INFO - PROCESS | 1653 | 05:25:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 05:25:37 INFO - PROCESS | 1653 | RSS: Main: 295940096 05:25:37 INFO - PROCESS | 1653 | 05:28:40 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 05:28:40 INFO - PROCESS | 1653 | RSS: Main: 296140800 05:28:40 INFO - PROCESS | 1653 | 05:28:40 INFO - PROCESS | 1653 | __start_tp_report 05:28:40 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 05:28:40 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 05:28:40 INFO - PROCESS | 1653 | |i|pagename|runs| 05:28:40 INFO - PROCESS | 1653 | |0;dojo.html;2799.986000069999;3288.7369010479165;3305.173706573357;3326.7005969462757;3348.882789102381;4648.721076735398;5127.256547800576;5515.172724091388;5533.916991245134;5617.297837770278;5458.836234912949;5514.834554963358;5601.495865372116;5670.319561652607;5750.453706897838;5098.949010509885;5140.768665410065;5180.197069454241;5211.218317252405;5213.061648903196;5050.671706339076;5235.528802407783;5251.474852514756;5258.447862974371;5312.946870531284;4794.496577859344;5112.514311140436;5145.25393817898;5176.715280659562;5201.323827902386;5134.973005398898;5162.432132465426;5176.275321454999;5177.559907407875;5218.6868787872845;5119.948800512022;5165.535101840853;5169.922451163236;5173.767180476888;5201.635885488017;4708.411448568929;5294.100002999461;5554.222408862763;5608.242887210256;5704.030314846486;6079.513638908877;6112.63324200545;6121.081837724332;6128.509719222451;6132.448079672851;6002.70941747522;6194.225721784777;6213.285472170713;6233.065040243954;6239.937600623981;4914.140025495524;5645.181448689958;5672.290963629546;5703.173039909273;5789.363170051291;6286.119943207955;6302.464290535264;6309.211348581427;6320.462760665395;6350.825097357004;6017.548683848729;6040.909386359208;6049.637021778707;6073.908891366633;6081.422264884829;5845.941540584625;6016.849578760566;6088.939110608837;6112.108359148532;6128.9693551531955;6021.187139736079;6056;6072.726727297282;6112.138751317739;6126.448619624255;6139.877202456015;6176.104464852571;6191.318954914956;6204.844878878064;6207.751689932352;4830.033993201374;4908.386451693538;4927.90144197114;4944.134776414113;4991.725455100004;3606.2246616977477;3638.7452878298795;4375.715578487452;4440.844570440019;4481.731096134243;4659.930101048487;4718.9292160617615;4730.9763451182525;5692.57305702074;5708.429157084342;5178.974105129526;6097.010520468106;6140.320203811457;6273.96863015682;6287.434130928238;5656.321241451053;5662.886742265132;5665.943340566624;5668.461496157858;5701.0308247598;5339.546138578265;5367.463253674601;5381.165919282517;5383.892322153535;5407.161889907071;6230.283517395557;6246.312905580292;6263.091851681572;6299.748010079546;6310.558260921692;6228.501719862309;6244.875102498016;6252.093446450148;6267.310595834546;6271.404216599416;6282.685865706605;6303.338149494237;6322.0200868865395;6340.65126418033;6349.238091429058;5889.411058894077;6031.09533569968;6040.244969378828;6114.113453549299;6128.693565321627;4959.851204463872;6116.26604807426;6166.075088736726;6200.658963757037;6273.215848018997;5945.791897283574;5964.373740757332;5991.7902873399225;5994.70026498682;5998.160257563857;5183.5593974512585;5347.919781203207;5819.679917604572;5980.5215582754145;5991.041433370639;4694.389729335165;5525.723713814374;5855.2095467113095;5907.054871220584;5948.37542058095;5092.567131793839;5979.073243647242;6007.759689612367;6012.759489620366;6041.879162416815;5045.7981680732355;5624.29696287964;5775.537956963349;5875.265591801025;5882 05:28:40 INFO - PROCESS | 1653 | |1;ext.html;463.84461205496154;467.2803882021687;477.7587318404205;489.3516091179188;501.4609295007866;36791.4481282781;39703.60296397035;39743;39747.40378894315;39845;33230;39835.402468962915;40132.197356052864;40463.79768101163;40482.98792530181;9351.57917893693;9402.388844725105;9565.995570465106;9572.56923438447;9579.904200958006;8661.830652861847;8918.420302680337;9327.20718738908;9358.251339892826;9467.526623668824;9274;9338.066193380642;9456.385334953206;9471.952640236823;9494.762630934247;8796.944366675976;9280.72157835266;9328.300377471716;9427.622895084189;9535.52322383878;7558.962205188994;7976.441649084566;9385.29610279225;9453.43279403238;9487.90512094884;34185.974420767416;34197;34808.30383392318;35009.6499035009;35029.12427189341;3035.3777475617667;3240.63893164869;3297.76915615907;3432.676690680444;3448.1552019755068;29988.8500557498;30192.0942371727;30202.84898575515;30314.54528182079;30898.53652195219;3072.7234548890706;3098.62816462026;3116.1262506876005;3129.7339726123305;3215.8552865121123;417720;418360;422112.6683099756;422869;423675;32083.358332833213;32273.838630806695;32287.838560807515;32316.83841580777;32426.83786581052;31212.7514899406;31973.840130799195;32859.17852053718;33469.83265083659;33570.49644255338;14629.634259143606;14637;14708.779368309484;14737.189454579886;14738;12169.965552927923;12171.878281217074;12224.1443098984;12226.388680566113;12232.877671223352;18379.356722514916;18725.625487490175;18728.81271187298;18734.906325468284;18735.81264187368;7878;8066.919330806734;8082.878756818653;8186.672533098609;8190.034391746057;826.8181000179951;974.4202199691173;983.7688143286322;1085.4193006741355;1107.3334631379882;29742.25644358865;29854.10437686873;30202.848985754932;30673.07980760581;30771.846140769154;934;996.2030375699411;1035.6841163445222;1038.2472707287156;1042.2287507244585;15546.455874044354;15610.360912104292;15703.842961570466;15827.52517424479;16034.358625655077;636447;641401;642751;643457;645654;55668.88662226733;56881;57166.85666286734;57378.42621573731;57513.712431437576;1307.7711400505063;1322.2661422910378;1350.4463170100212;1355.6068740065468;1357.0907491980397;27088;29600;29799.404011920073;29946.550801738427;30486;39327.80336098301;48414.27378589253;48816;48848.2672759916;48925.2661210075;533161;541683;544662;544859;545744;25395.238142855746;25490.872545637154;25758.227253182435;26105.477890441703;26200.475990480463;45948.8512787183;46487.76756116198;46517.302240465746;47206.527934721584;47830;37701;39725.602743973344;39898;40870.59129408668;40937.59062409338;39288.803555982035;39618.00954976033;39621.80189099036;40899.591004089576;40916.59083409128;37791.244175116895;38085.42871856869;38485.230295394496;38781;38896;34173.65826341705;34754.652453475144;35488.822555887054;35501.82249088738;35591.82204089066;24283.785810709745;25427;25743.871280643478;25841.353966150244;26356.077537286103 05:28:40 INFO - PROCESS | 1653 | |2;jquery.html;368.55220906598475;371.6487918916624;380.6041716614721;391.19609203087646;398.85043108834185;19535.609287814234;20853.68719469209;21099.2615258466;21541.67687484689;21677.891610541963;17462.039587822666;19591.92244426556;20646;20743.273985410513;21023.68464473034;5184.948150518503;5483.259759932408;5654.095344744842;6139.2325959255095;6199.969000155015;6029.577929544934;6055.364186760371;6162.168107305523;6176.042713379434;6179.5056395488255;5030.773615187307;5949.077892926603;5990.101484777275;6080.331163572004;6099.9935010723175;4610.354550362952;5985.6408615483215;6064.36324185963;6134.5092392608485;6179.536534759888;4819.397575303087;4940.2342636891335;5710.628809127394;5822.155787410844;5833.766649334021;10061.798764024752;14634.634134146625;22113.557728845495;22283.660215677282;26427.67861606912;2182.9890850545803;2328.6739856420113;2344.449054472215;2531.493701259737;2761.0336382266246;8322.334213262924;9930.106290433823;10047.899521004769;10083.697489075339;10140.087392134743;1494.7683109118104;1780.9020503872282;1788.4366424576217;1822.3803906671794;1895.7440745499318;105572;130207;134957.65042349647;134991;136033.3198334002;11399.772004559862;11595.478203480863;11686.12354073448;11772.293662380112;11821.468033938494;14580.708385832437;14597.051191672508;14669.77995330071;14689.19209443491;14702.926485367505;8333.16668333174;8486.40595158333;8544.14558544153;8558.743237702754;8612.354073444516;8338.416310858303;8394.118617545191;8612.267957223581;8627.654893804303;8640.524771137521;4434.379186913835;4442.73343599385;4456.927528699106;4511.8646440606835;4573.474050484237;1897.1368027547708;1949.9317523886596;1960.4412742368356;1995.2218634732467;1999.3402177281753;859.7678626770737;877.2455688108222;894.8389289927745;908.9954550227206;936.2322895225849;20857.374278771662;21341.359759207247;21385.89307053455;21468.463288417915;21595.67606485904;826.9332560996368;896;920.3971398733706;924.177482040984;975.1662328708993;10113.747156321004;10637.670291213599;11218.943905280421;11477.942610286895;11507.424628768527;486151;489412;604517;608367;632679;110122.85724278279;127859.36070319588;131864.34067829791;133355;133361;418.2617679795103;444.21817601021786;444.7309377826433;449.5616773645735;450.1739308369114;10747.677569672922;10984.340939543654;11285.095044937603;11519.07847372225;11544.82682759776;41547.58452415437;51108.74445627748;51793.7410312946;53275.66810829605;53693;62257.37742622516;69024.61950761057;76117.61941190259;78638;82272;7609.429292803173;7746.457747957589;7907.327877130509;8403.63011234167;8489.95755021221;10131.392116473035;13144.145630533985;13238;13305.201687898758;13344.666383340495;11447.313161210353;11571;11734.589289374831;11866;11919.46362413676;10195.84706229422;10292.279540432099;10411.583536658449;10499.055085042382;11743.295402275891;11102.833457498306;11551.826722599;11722.296662200295;11777.470013849568;11999.64001079969;8214.219649133323;8448.83102337962;12013.939930300292;12537.686557836127;12872.871271287167;11412.174052151617;11437.656870293904;11794.469248883992;11869.525218991144;12036.578719745117 05:28:40 INFO - PROCESS | 1653 | |3;mootools.html;1524.2988225416311;1564.5697433205867;1721.1996421663923;1797.5955410032736;1854.332440321483;7471.589062601554;7789.337906277959;8131;8746.475211487315;8776.56117194141;7496.325330720234;8544.530050847201;8547.658093676246;8561.571921403936;8563.400561960665;2334.673145759595;2359.917402890899;2360.2447216890514;2362.621980483123;2363.869987150706;1960.4118764370703;2319.8028167605776;2362.763723627632;2362.893669784864;2373.635159783123;2330.615448451012;2342.4378149244144;2349.2247558305803;2364.160722943356;2364.420716924356;2321.7794309540736;2333.288347054148;2339.19297842245;2345.9648105278347;2352.741198468167;2319.5592837361014;2329.2313536533075;2333.8132949364012;2336.018872073716;2342.5197834443898;8428.915710842874;8496.70261540843;8505.19200675941;8548.358873084482;8639.00651425088;5081.822136225214;5236.842894713165;5238.161894096965;5238.711870847102;5244.895102097975;3431.4166591679473;3463.3592785334795;3529.5588051493564;3572.356975744365;3580.480830279595;1034.5206354912473;1066.306900514664;1066.9253152279343;1085.8316960871077;1087.4399684162663;9637.18083962864;10674.412907290174;11240.156988225834;11255.718607034807;11360.147988900782;3730.7948062856804;3964.801759911993;4321.459817522809;4435.35687325336;4653.23221668421;7852.489588176751;8961.148690874357;9701.126898579161;9751.853722194173;9753.170980466597;3972.6821854252166;5187.870303242449;5201;5205.869853253624;5219.1388420910125;4335;4399.362092496634;4730.337752714623;4750.691205071659;4777.570018698334;3850.1914597934187;3887.591802860659;3923.862079996826;3976.3439032559304;4003.939940900889;1137.5677242647907;1230.4032544216047;1285.042643230799;1290.5225066725372;1294.372229468707;837.1795640272567;905.4793493740993;925.6251218256617;929.1776777551916;953.8187744328555;5587.552995760329;5669.744861481243;5789.94210057894;5969.76120955157;6075.665838378932;427.7882448188167;435.507876100005;439.91861505621563;860.6256278518864;1022.1158697726413;3963.4253033310583;4067.877963661095;4070.1249231415386;4086.6526345260986;4101.652248616476;9374.437533747998;10125.12685153249;10395.32430392022;10490.370577765358;10542.841857372145;10193.796124077477;10351.120154786777;10453.372797632166;10462.895371046345;10486.895131048592;7186.957891105761;7645.961770191114;7972.441929065026;8085.595720213966;8096.433249672584;4855.907420830426;5700.743466544099;5714.314282285986;5887.676177810262;5922.407759224043;9526.952365238407;9560.091791279818;9686.32195746291;9773.364731292444;9849.359791613522;9634.662786802428;9753.414795112316;9892.208623310262;9900.455474948947;9974.551145198338;6472.967635161794;6637.502187336066;6640.203175618956;6837.076994605664;6893.0694356261265;8224.342052635655;8301.750947471586;8305;8311.792205194919;8321.625526851427;7324;7463.664135113824;7463.813404664927;7558.811029724301;7576.924230757842;7133.643317834191;7220.74727384539;7313.67088481009;7333;7358.558486490828;6810.31896810315;6828.760993365208;6920.9653951729915;6924.376806087476;6935.167779866449;4940.184869496493;5009.7996080157845;5014.774335154853;5049.141645920276;5079.085764562266;4257.19113368459;4740.099381117577;5044.672096313728;5094.821681241138;5095.821646242363 05:28:40 INFO - PROCESS | 1653 | |4;prototype.html;242.76694373401523;304.2697525937749;310.7141429884506;312.32849373846244;314.05469536694545;4598.839040633578;5487.835364939058;5618.15727640854;5665.461781130796;5679.403662615423;4927.236278376858;5493.587980901429;5519.530839878616;5616.045272303708;5635.21107045014;3751.6811071058855;4021.8592349267783;4273.850415235467;4279.122779830127;4296;3512.7541072124964;4152.294110001307;4257.233697934371;4283.978580107095;4306.332518459628;3720.920932929447;4023.4568333274924;4174.248635245654;4263.467066616673;4284.207421627009;3904.629060239273;4235.597618226295;4263.616274535291;4269.359596060584;4289.656827453796;3492.350493734054;3605.7740368274913;3698.7424275746375;3698.9827797355674;3734.3651579231596;4435.756033418161;5063.721495317756;5256.842294731164;5425.701586412746;5511.807086751985;4846.710661064948;4856.693070791382;4907.68100073494;4914.680545764514;4936.580390666798;5606.635568688063;5884.764609415618;5892.616979896293;5952.4642782149385;5966.925953328399;3693.488427869048;3859.4982652255026;3998.300297447935;4055.4322394864744;4068.776217308047;5455.318085239345;5954.880902381971;6294.181756371689;6344.841378965562;6383.744650213986;3444.8794292200155;3628.74598778083;4130.6282434581035;4135.58644135584;4143.1713657268065;3318.352921180395;3995.5005624296964;4078.225137223918;4086.7139300248696;4104.384342348671;4379.554746933504;4782.760861956888;4794.448638406628;4798.376211092535;4815.759212039384;5373.086575282211;5773.498890288555;5898.616589921641;5954.910676339859;6048.9697551512845;1331.0815537279245;1335.3657012918786;1371.3349025722516;1385.7852032934911;1397.9580612581435;666.4202144134537;693.9659906738923;813.9593020348959;850.1201256699287;857.0015931439802;4261.446012018479;4391.8682439526865;4676;4724.732128578302;4727.416315534335;4238.724482908663;4557.860534866283;5187.455317191716;5188.250227379495;5221.791128354899;4138.255114079434;4532.818687252539;4625.537446255347;4662.696924699883;4710.29345598163;2184.1434780436502;2302.6085565453914;2416.501768903291;2597.3636459067648;2640.683118025849;4336.544662810423;4585.816567337336;4657.231556793159;4673.719576825401;5441.428649991773;4257.957420425818;4814.7149037356785;4949.752512374367;5247.816326428557;5252.947470525322;4287.756550600353;4395.7142785718825;5221.605956128471;5263.710390954241;5349.465053494697;4792.113459010095;4846.5153484652665;5028.597712182944;5144.122395325604;5167.638265321391;4082.081531655354;4896.559309662148;4987.451380348086;5077.014543583269;5141.588672906084;4347.847825326098;5781.537477001913;5871.853203669943;6454.935450645434;6475.805725828232;3800;3870.664620705852;4028.7784171869657;4044.6359827615656;4064.47161868967;5440.755166017618;5657.971710141423;5714.999875021771;6014.879702405839;6163.506919446523;5543.3902270751;5562.1922875066575;5884;5911.91132133027;5918.644881307136;5675.404082571271;5876.1773351729935;5895.9705201475435;5904.106987576142;5921.904447677193;5797.130430435468;5800.39095894925;5802.82591522255;5810.448007439287;5841.620294680833;5347.545503586398;5594.944050559442;5689.687067211343;5824.893270278633;6049.848753781191;5041.6470847040355;5160.890408562177;5806.274215723035;5818.33089194748;5826.41735826414 05:28:40 INFO - PROCESS | 1653 | |5;yui.html;594.9196858424112;700.7162099349762;719.0508528742063;770.560780355197;807.7940125268055;13571.710687484685;15121.243937803107;15303.617409564753;15661.530154095395;15771.763423548657;13409.530666426677;14137;14252.572422827332;14267.1439713617;14286.428542858273;664.7042066280507;816.5998660656295;830.1283652165232;838.5974732128582;841.3857883744839;805.7059173401695;841.9957900210491;846.1707526623912;846.4709556527171;849.6304107713164;889.7820034091657;904.2449554621899;904.3533873280603;905.2441211588299;906.4561263242068;865.2342676731107;875.4703404440286;889.8487257166232;901.8106197698492;902.5938327752538;651.0657206908102;670.2961890015464;672.5023482622872;673.2089794491502;673.5251647588439;14867.479638212611;14885.627859303604;14906.180160091191;14919.552413427615;14920.776188357184;14768;14822.555323340317;14877.851221487756;14895.851041489555;14910.925445372812;12003.879961200364;12297.077719171099;12446.502139914483;12504.187227830162;12532.99736021116;3812.8474861005525;3863.1887303666263;4015.0966032642714;4034.547562877362;4041.6362527372385;114261;116102.41948790202;117025.41487292595;117208;117290;11353.489092990836;11456.3698996556;11476.59831905896;11490.310581365145;11846.526138954345;22820.885895570416;23187.60874347511;23784.524309513712;23841;24110;8207.876881846658;8227.382946279053;8229.05365882931;8271.958640206882;8292.958535207406;4372.519022907478;4428.490723566767;4464.374987501752;4464.843730469418;4564.2012647786505;3435.5018522314626;3562.7886518583805;3572.928541429209;3577.499150118985;3579.6599323064265;642.2389468479867;652.5725649699455;657.2704298228962;666.4701562258017;668.4017804065335;587.9441453061952;592.517098564677;616.7687117331001;644.4972921121532;648.8313038609996;6693.732250709917;8740.8688869667;8801.691940782042;8844.469331839982;9096.454212747256;532.2043544900399;563.152455554388;583.8294220088779;593.5577994394204;617.9649087777954;4066.7763273019677;4388.802503887333;4404.163208990346;4411.29419292918;4613.8385156520035;104074;123497;131442;156914;184508;89063.55468222748;119370;131155;132589.67410325966;154298;108279.12743926542;129824;131039.68960310274;132104;133013.33493332664;7487;7568.0161578994375;8589.63508736989;8776.736697898818;8805.603747831492;53213.7339313301;61793.60135192428;64879.35120648733;67793.66103169453;68058.31941680718;65754.0273791787;77470;78712.2128778705;78718.60640696759;83170.16829831625;12691.111622186358;12726.936365318485;12942.158759680591;13575.932120339336;14023.439062437388;14456;14805.777913331523;15264.694706106038;15721.213939302761;15850.841491585397;11971.461284242056;13772.65568360799;14015.649608759863;14016.29918504091;14151.221682807545;14127.364268608142;14161.504347347793;14248.358823852745;14385.64035899111;14411.711765764836;13260.336983150612;13818.930905345811;14021.228832414316;14243.643908901946;14534.273286335852;10683.554623227225;11467.139964502863;11592.478338474957;11624.82562761576;12072.637820865388;11410.657680269605;11605.709857253298;11755;11903.345316007357;11987.820182697093 05:28:40 INFO - PROCESS | 1653 | __end_tp_report 05:28:40 INFO - PROCESS | 1653 | __start_cc_report 05:28:40 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,417 05:28:40 INFO - PROCESS | 1653 | __end_cc_report 05:28:40 INFO - PROCESS | 1653 | __startTimestamp1470659320848__endTimestamp 05:28:40 INFO - PROCESS | 1653 | 05:28:40 INFO - PROCESS | 1653 | ------- Summary: start ------- 05:28:40 INFO - PROCESS | 1653 | Number of tests: 6 05:28:40 INFO - PROCESS | 1653 | 05:28:40 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5590.67 Median:5750.45 stddev:693.93 (12.1%) stddev-sans-first:660.63 05:28:40 INFO - PROCESS | 1653 | Values: 2800.0 3288.7 3305.2 3326.7 3348.9 4648.7 5127.3 5515.2 5533.9 5617.3 5458.8 5514.8 5601.5 5670.3 5750.5 5098.9 5140.8 5180.2 5211.2 5213.1 5050.7 5235.5 5251.5 5258.4 5312.9 4794.5 5112.5 5145.3 5176.7 5201.3 5135.0 5162.4 5176.3 5177.6 5218.7 5119.9 5165.5 5169.9 5173.8 5201.6 4708.4 5294.1 5554.2 5608.2 5704.0 6079.5 6112.6 6121.1 6128.5 6132.4 6002.7 6194.2 6213.3 6233.1 6239.9 4914.1 5645.2 5672.3 5703.2 5789.4 6286.1 6302.5 6309.2 6320.5 6350.8 6017.5 6040.9 6049.6 6073.9 6081.4 5845.9 6016.8 6088.9 6112.1 6129.0 6021.2 6056.0 6072.7 6112.1 6126.4 6139.9 6176.1 6191.3 6204.8 6207.8 4830.0 4908.4 4927.9 4944.1 4991.7 3606.2 3638.7 4375.7 4440.8 4481.7 4659.9 4718.9 4731.0 5692.6 5708.4 5179.0 6097.0 6140.3 6274.0 6287.4 5656.3 5662.9 5665.9 5668.5 5701.0 5339.5 5367.5 5381.2 5383.9 5407.2 6230.3 6246.3 6263.1 6299.7 6310.6 6228.5 6244.9 6252.1 6267.3 6271.4 6282.7 6303.3 6322.0 6340.7 6349.2 5889.4 6031.1 6040.2 6114.1 6128.7 4959.9 6116.3 6166.1 6200.7 6273.2 5945.8 5964.4 5991.8 5994.7 5998.2 5183.6 5347.9 5819.7 5980.5 5991.0 4694.4 5525.7 5855.2 5907.1 5948.4 5092.6 5979.1 6007.8 6012.8 6041.9 5045.8 5624.3 5775.5 5875.3 5882.0 05:28:40 INFO - PROCESS | 1653 | 05:28:40 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:65373.01 Median:38633.12 stddev:145188.66 (375.8%) stddev-sans-first:145514.16 05:28:40 INFO - PROCESS | 1653 | Values: 463.8 467.3 477.8 489.4 501.5 36791.4 39703.6 39743.0 39747.4 39845.0 33230.0 39835.4 40132.2 40463.8 40483.0 9351.6 9402.4 9566.0 9572.6 9579.9 8661.8 8918.4 9327.2 9358.3 9467.5 9274.0 9338.1 9456.4 9472.0 9494.8 8796.9 9280.7 9328.3 9427.6 9535.5 7559.0 7976.4 9385.3 9453.4 9487.9 34186.0 34197.0 34808.3 35009.6 35029.1 3035.4 3240.6 3297.8 3432.7 3448.2 29988.9 30192.1 30202.8 30314.5 30898.5 3072.7 3098.6 3116.1 3129.7 3215.9 417720.0 418360.0 422112.7 422869.0 423675.0 32083.4 32273.8 32287.8 32316.8 32426.8 31212.8 31973.8 32859.2 33469.8 33570.5 14629.6 14637.0 14708.8 14737.2 14738.0 12170.0 12171.9 12224.1 12226.4 12232.9 18379.4 18725.6 18728.8 18734.9 18735.8 7878.0 8066.9 8082.9 8186.7 8190.0 826.8 974.4 983.8 1085.4 1107.3 29742.3 29854.1 30202.8 30673.1 30771.8 934.0 996.2 1035.7 1038.2 1042.2 15546.5 15610.4 15703.8 15827.5 16034.4 636447.0 641401.0 642751.0 643457.0 645654.0 55668.9 56881.0 57166.9 57378.4 57513.7 1307.8 1322.3 1350.4 1355.6 1357.1 27088.0 29600.0 29799.4 29946.6 30486.0 39327.8 48414.3 48816.0 48848.3 48925.3 533161.0 541683.0 544662.0 544859.0 545744.0 25395.2 25490.9 25758.2 26105.5 26200.5 45948.9 46487.8 46517.3 47206.5 47830.0 37701.0 39725.6 39898.0 40870.6 40937.6 39288.8 39618.0 39621.8 40899.6 40916.6 37791.2 38085.4 38485.2 38781.0 38896.0 34173.7 34754.7 35488.8 35501.8 35591.8 24283.8 25427.0 25743.9 25841.4 26356.1 05:28:40 INFO - PROCESS | 1653 | 05:28:40 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:33879.69 Median:12306.17 stddev:95358.80 (774.9%) stddev-sans-first:95593.11 05:28:40 INFO - PROCESS | 1653 | Values: 368.6 371.6 380.6 391.2 398.9 19535.6 20853.7 21099.3 21541.7 21677.9 17462.0 19591.9 20646.0 20743.3 21023.7 5184.9 5483.3 5654.1 6139.2 6200.0 6029.6 6055.4 6162.2 6176.0 6179.5 5030.8 5949.1 5990.1 6080.3 6100.0 4610.4 5985.6 6064.4 6134.5 6179.5 4819.4 4940.2 5710.6 5822.2 5833.8 10061.8 14634.6 22113.6 22283.7 26427.7 2183.0 2328.7 2344.4 2531.5 2761.0 8322.3 9930.1 10047.9 10083.7 10140.1 1494.8 1780.9 1788.4 1822.4 1895.7 105572.0 130207.0 134957.7 134991.0 136033.3 11399.8 11595.5 11686.1 11772.3 11821.5 14580.7 14597.1 14669.8 14689.2 14702.9 8333.2 8486.4 8544.1 8558.7 8612.4 8338.4 8394.1 8612.3 8627.7 8640.5 4434.4 4442.7 4456.9 4511.9 4573.5 1897.1 1949.9 1960.4 1995.2 1999.3 859.8 877.2 894.8 909.0 936.2 20857.4 21341.4 21385.9 21468.5 21595.7 826.9 896.0 920.4 924.2 975.2 10113.7 10637.7 11218.9 11477.9 11507.4 486151.0 489412.0 604517.0 608367.0 632679.0 110122.9 127859.4 131864.3 133355.0 133361.0 418.3 444.2 444.7 449.6 450.2 10747.7 10984.3 11285.1 11519.1 11544.8 41547.6 51108.7 51793.7 53275.7 53693.0 62257.4 69024.6 76117.6 78638.0 82272.0 7609.4 7746.5 7907.3 8403.6 8490.0 10131.4 13144.1 13238.0 13305.2 13344.7 11447.3 11571.0 11734.6 11866.0 11919.5 10195.8 10292.3 10411.6 10499.1 11743.3 11102.8 11551.8 11722.3 11777.5 11999.6 8214.2 8448.8 12013.9 12537.7 12872.9 11412.2 11437.7 11794.5 11869.5 12036.6 05:28:40 INFO - PROCESS | 1653 | 05:28:40 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5516.32 Median:5064.11 stddev:3054.44 (60.3%) stddev-sans-first:3048.28 05:28:40 INFO - PROCESS | 1653 | Values: 1524.3 1564.6 1721.2 1797.6 1854.3 7471.6 7789.3 8131.0 8746.5 8776.6 7496.3 8544.5 8547.7 8561.6 8563.4 2334.7 2359.9 2360.2 2362.6 2363.9 1960.4 2319.8 2362.8 2362.9 2373.6 2330.6 2342.4 2349.2 2364.2 2364.4 2321.8 2333.3 2339.2 2346.0 2352.7 2319.6 2329.2 2333.8 2336.0 2342.5 8428.9 8496.7 8505.2 8548.4 8639.0 5081.8 5236.8 5238.2 5238.7 5244.9 3431.4 3463.4 3529.6 3572.4 3580.5 1034.5 1066.3 1066.9 1085.8 1087.4 9637.2 10674.4 11240.2 11255.7 11360.1 3730.8 3964.8 4321.5 4435.4 4653.2 7852.5 8961.1 9701.1 9751.9 9753.2 3972.7 5187.9 5201.0 5205.9 5219.1 4335.0 4399.4 4730.3 4750.7 4777.6 3850.2 3887.6 3923.9 3976.3 4003.9 1137.6 1230.4 1285.0 1290.5 1294.4 837.2 905.5 925.6 929.2 953.8 5587.6 5669.7 5789.9 5969.8 6075.7 427.8 435.5 439.9 860.6 1022.1 3963.4 4067.9 4070.1 4086.7 4101.7 9374.4 10125.1 10395.3 10490.4 10542.8 10193.8 10351.1 10453.4 10462.9 10486.9 7187.0 7646.0 7972.4 8085.6 8096.4 4855.9 5700.7 5714.3 5887.7 5922.4 9527.0 9560.1 9686.3 9773.4 9849.4 9634.7 9753.4 9892.2 9900.5 9974.6 6473.0 6637.5 6640.2 6837.1 6893.1 8224.3 8301.8 8305.0 8311.8 8321.6 7324.0 7463.7 7463.8 7558.8 7576.9 7133.6 7220.7 7313.7 7333.0 7358.6 6810.3 6828.8 6921.0 6924.4 6935.2 4940.2 5009.8 5014.8 5049.1 5079.1 4257.2 4740.1 5044.7 5094.8 5095.8 05:28:40 INFO - PROCESS | 1653 | 05:28:40 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4518.90 Median:4846.61 stddev:1412.09 (29.1%) stddev-sans-first:1379.10 05:28:40 INFO - PROCESS | 1653 | Values: 242.8 304.3 310.7 312.3 314.1 4598.8 5487.8 5618.2 5665.5 5679.4 4927.2 5493.6 5519.5 5616.0 5635.2 3751.7 4021.9 4273.9 4279.1 4296.0 3512.8 4152.3 4257.2 4284.0 4306.3 3720.9 4023.5 4174.2 4263.5 4284.2 3904.6 4235.6 4263.6 4269.4 4289.7 3492.4 3605.8 3698.7 3699.0 3734.4 4435.8 5063.7 5256.8 5425.7 5511.8 4846.7 4856.7 4907.7 4914.7 4936.6 5606.6 5884.8 5892.6 5952.5 5966.9 3693.5 3859.5 3998.3 4055.4 4068.8 5455.3 5954.9 6294.2 6344.8 6383.7 3444.9 3628.7 4130.6 4135.6 4143.2 3318.4 3995.5 4078.2 4086.7 4104.4 4379.6 4782.8 4794.4 4798.4 4815.8 5373.1 5773.5 5898.6 5954.9 6049.0 1331.1 1335.4 1371.3 1385.8 1398.0 666.4 694.0 814.0 850.1 857.0 4261.4 4391.9 4676.0 4724.7 4727.4 4238.7 4557.9 5187.5 5188.3 5221.8 4138.3 4532.8 4625.5 4662.7 4710.3 2184.1 2302.6 2416.5 2597.4 2640.7 4336.5 4585.8 4657.2 4673.7 5441.4 4258.0 4814.7 4949.8 5247.8 5252.9 4287.8 4395.7 5221.6 5263.7 5349.5 4792.1 4846.5 5028.6 5144.1 5167.6 4082.1 4896.6 4987.5 5077.0 5141.6 4347.8 5781.5 5871.9 6454.9 6475.8 3800.0 3870.7 4028.8 4044.6 4064.5 5440.8 5658.0 5715.0 6014.9 6163.5 5543.4 5562.2 5884.0 5911.9 5918.6 5675.4 5876.2 5896.0 5904.1 5921.9 5797.1 5800.4 5802.8 5810.4 5841.6 5347.5 5594.9 5689.7 5824.9 6049.8 5041.6 5160.9 5806.3 5818.3 5826.4 05:28:40 INFO - PROCESS | 1653 | 05:28:40 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:24895.94 Median:3567.86 stddev:39959.72 (1120.0%) stddev-sans-first:40030.16 05:28:40 INFO - PROCESS | 1653 | Values: 594.9 700.7 719.1 770.6 807.8 13571.7 15121.2 15303.6 15661.5 15771.8 13409.5 14137.0 14252.6 14267.1 14286.4 664.7 816.6 830.1 838.6 841.4 805.7 842.0 846.2 846.5 849.6 889.8 904.2 904.4 905.2 906.5 865.2 875.5 889.8 901.8 902.6 651.1 670.3 672.5 673.2 673.5 14867.5 14885.6 14906.2 14919.6 14920.8 14768.0 14822.6 14877.9 14895.9 14910.9 12003.9 12297.1 12446.5 12504.2 12533.0 3812.8 3863.2 4015.1 4034.5 4041.6 114261.0 116102.4 117025.4 117208.0 117290.0 11353.5 11456.4 11476.6 11490.3 11846.5 22820.9 23187.6 23784.5 23841.0 24110.0 8207.9 8227.4 8229.1 8272.0 8293.0 4372.5 4428.5 4464.4 4464.8 4564.2 3435.5 3562.8 3572.9 3577.5 3579.7 642.2 652.6 657.3 666.5 668.4 587.9 592.5 616.8 644.5 648.8 6693.7 8740.9 8801.7 8844.5 9096.5 532.2 563.2 583.8 593.6 618.0 4066.8 4388.8 4404.2 4411.3 4613.8 104074.0 123497.0 131442.0 156914.0 184508.0 89063.6 119370.0 131155.0 132589.7 154298.0 108279.1 129824.0 131039.7 132104.0 133013.3 7487.0 7568.0 8589.6 8776.7 8805.6 53213.7 61793.6 64879.4 67793.7 68058.3 65754.0 77470.0 78712.2 78718.6 83170.2 12691.1 12726.9 12942.2 13575.9 14023.4 14456.0 14805.8 15264.7 15721.2 15850.8 11971.5 13772.7 14015.6 14016.3 14151.2 14127.4 14161.5 14248.4 14385.6 14411.7 13260.3 13818.9 14021.2 14243.6 14534.3 10683.6 11467.1 11592.5 11624.8 12072.6 11410.7 11605.7 11755.0 11903.3 11987.8 05:28:40 INFO - PROCESS | 1653 | -------- Summary: end -------- 05:28:40 INFO - PROCESS | 1653 | 05:28:41 INFO - TEST-INFO | 1653: exit 0 05:28:41 INFO - TEST-OK | dromaeo_css | took 1114208ms 05:28:41 INFO - TEST-START | kraken 05:28:41 INFO - operating with platform_type : mac_ 05:28:41 INFO - Initialising browser for kraken test... 05:28:41 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpVj4vg7/profile http://localhost:49270/getInfo.html) 05:28:44 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 05:28:44 INFO - PROCESS | 1662 | colorDepth:24 05:28:44 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 05:28:44 INFO - PROCESS | 1662 | __metrics 05:28:44 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:28:44 INFO - TEST-INFO | 1662: exit 0 05:28:45 INFO - Browser initialized. 05:28:45 INFO - Running cycle 1/1 for kraken test... 05:28:45 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpVj4vg7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:56 INFO - PROCESS | 1664 | RSS: Main: 255123456 05:28:56 INFO - PROCESS | 1664 | 05:28:59 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 05:29:00 INFO - PROCESS | 1664 | RSS: Main: 268025856 05:29:00 INFO - PROCESS | 1664 | 05:29:03 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 05:29:03 INFO - PROCESS | 1664 | RSS: Main: 276795392 05:29:03 INFO - PROCESS | 1664 | 05:29:07 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 05:29:07 INFO - PROCESS | 1664 | RSS: Main: 279392256 05:29:07 INFO - PROCESS | 1664 | 05:29:09 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 05:29:10 INFO - PROCESS | 1664 | RSS: Main: 281817088 05:29:10 INFO - PROCESS | 1664 | 05:29:12 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:29:13 INFO - PROCESS | 1664 | RSS: Main: 282193920 05:29:13 INFO - PROCESS | 1664 | 05:29:16 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 05:29:16 INFO - PROCESS | 1664 | RSS: Main: 283058176 05:29:16 INFO - PROCESS | 1664 | 05:29:19 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 05:29:20 INFO - PROCESS | 1664 | RSS: Main: 282296320 05:29:20 INFO - PROCESS | 1664 | 05:29:23 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 05:29:24 INFO - PROCESS | 1664 | RSS: Main: 283697152 05:29:24 INFO - PROCESS | 1664 | 05:29:25 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:29:26 INFO - PROCESS | 1664 | RSS: Main: 283127808 05:29:26 INFO - PROCESS | 1664 | 05:29:28 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:28 INFO - PROCESS | 1664 | RSS: Main: 282918912 05:29:28 INFO - PROCESS | 1664 | 05:29:30 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:31 INFO - PROCESS | 1664 | RSS: Main: 283140096 05:29:31 INFO - PROCESS | 1664 | 05:29:34 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:35 INFO - PROCESS | 1664 | RSS: Main: 283168768 05:29:35 INFO - PROCESS | 1664 | 05:29:38 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:38 INFO - PROCESS | 1664 | RSS: Main: 283480064 05:29:38 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 05:29:40 INFO - PROCESS | 1664 | RSS: Main: 284704768 05:29:40 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | __start_tp_report 05:29:40 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 05:29:40 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 05:29:40 INFO - PROCESS | 1664 | |i|pagename|runs| 05:29:40 INFO - PROCESS | 1664 | |0;ai-astar;106;117;107;118;118;117;114;137;170;120 05:29:40 INFO - PROCESS | 1664 | |1;audio-beat-detection;143;107;132;159;110;132;130;110;156;116 05:29:40 INFO - PROCESS | 1664 | |2;audio-dft;197;202;205;248;198;195;198;197;199;212 05:29:40 INFO - PROCESS | 1664 | |3;audio-fft;57;71;67;133;53;59;66;87;160;79 05:29:40 INFO - PROCESS | 1664 | |4;audio-oscillator;70;72;125;78;88;64;100;91;96;145 05:29:40 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;90;87;88;86;77;128;134;86;88;86 05:29:40 INFO - PROCESS | 1664 | |6;imaging-darkroom;95;95;100;95;97;115;152;115;94;90 05:29:40 INFO - PROCESS | 1664 | |7;imaging-desaturate;90;95;91;88;95;92;141;122;94;92 05:29:40 INFO - PROCESS | 1664 | |8;json-parse-financial;55;57;56;56;56;57;56;56;55;55 05:29:40 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;66;71;73;75;75;68;69;68;72;99 05:29:40 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;85;85;84;75;102;105;79;85;90;84 05:29:40 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;139;153;148;132;136;138;139;156;154;136 05:29:40 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;169;174;171;170;180;236;173;167;179;169 05:29:40 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;72;69;68;69;69;69;67;69;69;67 05:29:40 INFO - PROCESS | 1664 | __end_tp_report 05:29:40 INFO - PROCESS | 1664 | __start_cc_report 05:29:40 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1054 05:29:40 INFO - PROCESS | 1664 | __end_cc_report 05:29:40 INFO - PROCESS | 1664 | __startTimestamp1470659380684__endTimestamp 05:29:40 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | ------- Summary: start ------- 05:29:40 INFO - PROCESS | 1664 | Number of tests: 14 05:29:40 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:122.40 Median:118.00 stddev:18.73 (15.9%) stddev-sans-first:18.91 05:29:40 INFO - PROCESS | 1664 | Values: 106.0 117.0 107.0 118.0 118.0 117.0 114.0 137.0 170.0 120.0 05:29:40 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:132.00 stddev:18.90 (14.3%) stddev-sans-first:19.41 05:29:40 INFO - PROCESS | 1664 | Values: 143.0 107.0 132.0 159.0 110.0 132.0 130.0 110.0 156.0 116.0 05:29:40 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:205.10 Median:200.50 stddev:15.88 (7.9%) stddev-sans-first:16.57 05:29:40 INFO - PROCESS | 1664 | Values: 197.0 202.0 205.0 248.0 198.0 195.0 198.0 197.0 199.0 212.0 05:29:40 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:83.20 Median:66.50 stddev:35.44 (53.3%) stddev-sans-first:36.30 05:29:40 INFO - PROCESS | 1664 | Values: 57.0 71.0 67.0 133.0 53.0 59.0 66.0 87.0 160.0 79.0 05:29:40 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:75.00 stddev:25.50 (34.0%) stddev-sans-first:25.66 05:29:40 INFO - PROCESS | 1664 | Values: 70.0 72.0 125.0 78.0 88.0 64.0 100.0 91.0 96.0 145.0 05:29:40 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:95.00 Median:86.50 stddev:19.33 (22.4%) stddev-sans-first:20.42 05:29:40 INFO - PROCESS | 1664 | Values: 90.0 87.0 88.0 86.0 77.0 128.0 134.0 86.0 88.0 86.0 05:29:40 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:104.80 Median:94.50 stddev:18.69 (19.8%) stddev-sans-first:19.48 05:29:40 INFO - PROCESS | 1664 | Values: 95.0 95.0 100.0 95.0 97.0 115.0 152.0 115.0 94.0 90.0 05:29:40 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:100.00 Median:92.00 stddev:17.33 (18.8%) stddev-sans-first:18.00 05:29:40 INFO - PROCESS | 1664 | Values: 90.0 95.0 91.0 88.0 95.0 92.0 141.0 122.0 94.0 92.0 05:29:40 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:0.74 (1.3%) stddev-sans-first:0.71 05:29:40 INFO - PROCESS | 1664 | Values: 55.0 57.0 56.0 56.0 56.0 57.0 56.0 56.0 55.0 55.0 05:29:40 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:73.60 Median:72.50 stddev:9.43 (13.0%) stddev-sans-first:9.59 05:29:40 INFO - PROCESS | 1664 | Values: 66.0 71.0 73.0 75.0 75.0 68.0 69.0 68.0 72.0 99.0 05:29:40 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:84.50 stddev:9.40 (11.1%) stddev-sans-first:9.92 05:29:40 INFO - PROCESS | 1664 | Values: 85.0 85.0 84.0 75.0 102.0 105.0 79.0 85.0 90.0 84.0 05:29:40 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:143.50 stddev:8.76 (6.1%) stddev-sans-first:9.17 05:29:40 INFO - PROCESS | 1664 | Values: 139.0 153.0 148.0 132.0 136.0 138.0 139.0 156.0 154.0 136.0 05:29:40 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:173.50 stddev:20.55 (11.8%) stddev-sans-first:21.49 05:29:40 INFO - PROCESS | 1664 | Values: 169.0 174.0 171.0 170.0 180.0 236.0 173.0 167.0 179.0 169.0 05:29:40 INFO - PROCESS | 1664 | 05:29:40 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.40 (2.0%) stddev-sans-first:0.88 05:29:40 INFO - PROCESS | 1664 | Values: 72.0 69.0 68.0 69.0 69.0 69.0 67.0 69.0 69.0 67.0 05:29:40 INFO - PROCESS | 1664 | -------- Summary: end -------- 05:29:40 INFO - PROCESS | 1664 | 05:29:41 INFO - TEST-INFO | 1664: exit 0 05:29:41 INFO - TEST-OK | kraken | took 60120ms 05:29:41 INFO - SUITE-END | took 1174s 05:29:41 INFO - Completed test suite (00:19:34) 05:29:41 INFO - javascript benchmark 05:29:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7163.135986027373, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2799.986000069999, 3288.7369010479165, 3305.173706573357, 3326.7005969462757, 3348.882789102381, 4648.721076735398, 5127.256547800576, 5515.172724091388, 5533.916991245134, 5617.297837770278, 5458.836234912949, 5514.834554963358, 5601.495865372116, 5670.319561652607, 5750.453706897838, 5098.949010509885, 5140.768665410065, 5180.197069454241, 5211.218317252405, 5213.061648903196, 5050.671706339076, 5235.528802407783, 5251.474852514756, 5258.447862974371, 5312.946870531284, 4794.496577859344, 5112.514311140436, 5145.25393817898, 5176.715280659562, 5201.323827902386, 5134.973005398898, 5162.432132465426, 5176.275321454999, 5177.559907407875, 5218.6868787872845, 5119.948800512022, 5165.535101840853, 5169.922451163236, 5173.767180476888, 5201.635885488017, 4708.411448568929, 5294.100002999461, 5554.222408862763, 5608.242887210256, 5704.030314846486, 6079.513638908877, 6112.63324200545, 6121.081837724332, 6128.509719222451, 6132.448079672851, 6002.70941747522, 6194.225721784777, 6213.285472170713, 6233.065040243954, 6239.937600623981, 4914.140025495524, 5645.181448689958, 5672.290963629546, 5703.173039909273, 5789.363170051291, 6286.119943207955, 6302.464290535264, 6309.211348581427, 6320.462760665395, 6350.825097357004, 6017.548683848729, 6040.909386359208, 6049.637021778707, 6073.908891366633, 6081.422264884829, 5845.941540584625, 6016.849578760566, 6088.939110608837, 6112.108359148532, 6128.9693551531955, 6021.187139736079, 6056.0, 6072.726727297282, 6112.138751317739, 6126.448619624255, 6139.877202456015, 6176.104464852571, 6191.318954914956, 6204.844878878064, 6207.751689932352, 4830.033993201374, 4908.386451693538, 4927.90144197114, 4944.134776414113, 4991.725455100004, 3606.2246616977477, 3638.7452878298795, 4375.715578487452, 4440.844570440019, 4481.731096134243, 4659.930101048487, 4718.9292160617615, 4730.9763451182525, 5692.57305702074, 5708.429157084342, 5178.974105129526, 6097.010520468106, 6140.320203811457, 6273.96863015682, 6287.434130928238, 5656.321241451053, 5662.886742265132, 5665.943340566624, 5668.461496157858, 5701.0308247598, 5339.546138578265, 5367.463253674601, 5381.165919282517, 5383.892322153535, 5407.161889907071, 6230.283517395557, 6246.312905580292, 6263.091851681572, 6299.748010079546, 6310.558260921692, 6228.501719862309, 6244.875102498016, 6252.093446450148, 6267.310595834546, 6271.404216599416, 6282.685865706605, 6303.338149494237, 6322.0200868865395, 6340.65126418033, 6349.238091429058, 5889.411058894077, 6031.09533569968, 6040.244969378828, 6114.113453549299, 6128.693565321627, 4959.851204463872, 6116.26604807426, 6166.075088736726, 6200.658963757037, 6273.215848018997, 5945.791897283574, 5964.373740757332, 5991.7902873399225, 5994.70026498682, 5998.160257563857, 5183.5593974512585, 5347.919781203207, 5819.679917604572, 5980.5215582754145, 5991.041433370639, 4694.389729335165, 5525.723713814374, 5855.2095467113095, 5907.054871220584, 5948.37542058095, 5092.567131793839, 5979.073243647242, 6007.759689612367, 6012.759489620366, 6041.879162416815, 5045.7981680732355, 5624.29696287964, 5775.537956963349, 5875.265591801025, 5882.0], "value": 5545.78422866138, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.84461205496154, 467.2803882021687, 477.7587318404205, 489.3516091179188, 501.4609295007866, 36791.4481282781, 39703.60296397035, 39743.0, 39747.40378894315, 39845.0, 33230.0, 39835.402468962915, 40132.197356052864, 40463.79768101163, 40482.98792530181, 9351.57917893693, 9402.388844725105, 9565.995570465106, 9572.56923438447, 9579.904200958006, 8661.830652861847, 8918.420302680337, 9327.20718738908, 9358.251339892826, 9467.526623668824, 9274.0, 9338.066193380642, 9456.385334953206, 9471.952640236823, 9494.762630934247, 8796.944366675976, 9280.72157835266, 9328.300377471716, 9427.622895084189, 9535.52322383878, 7558.962205188994, 7976.441649084566, 9385.29610279225, 9453.43279403238, 9487.90512094884, 34185.974420767416, 34197.0, 34808.30383392318, 35009.6499035009, 35029.12427189341, 3035.3777475617667, 3240.63893164869, 3297.76915615907, 3432.676690680444, 3448.1552019755068, 29988.8500557498, 30192.0942371727, 30202.84898575515, 30314.54528182079, 30898.53652195219, 3072.7234548890706, 3098.62816462026, 3116.1262506876005, 3129.7339726123305, 3215.8552865121123, 417720.0, 418360.0, 422112.6683099756, 422869.0, 423675.0, 32083.358332833213, 32273.838630806695, 32287.838560807515, 32316.83841580777, 32426.83786581052, 31212.7514899406, 31973.840130799195, 32859.17852053718, 33469.83265083659, 33570.49644255338, 14629.634259143606, 14637.0, 14708.779368309484, 14737.189454579886, 14738.0, 12169.965552927923, 12171.878281217074, 12224.1443098984, 12226.388680566113, 12232.877671223352, 18379.356722514916, 18725.625487490175, 18728.81271187298, 18734.906325468284, 18735.81264187368, 7878.0, 8066.919330806734, 8082.878756818653, 8186.672533098609, 8190.034391746057, 826.8181000179951, 974.4202199691173, 983.7688143286322, 1085.4193006741355, 1107.3334631379882, 29742.25644358865, 29854.10437686873, 30202.848985754932, 30673.07980760581, 30771.846140769154, 934.0, 996.2030375699411, 1035.6841163445222, 1038.2472707287156, 1042.2287507244585, 15546.455874044354, 15610.360912104292, 15703.842961570466, 15827.52517424479, 16034.358625655077, 636447.0, 641401.0, 642751.0, 643457.0, 645654.0, 55668.88662226733, 56881.0, 57166.85666286734, 57378.42621573731, 57513.712431437576, 1307.7711400505063, 1322.2661422910378, 1350.4463170100212, 1355.6068740065468, 1357.0907491980397, 27088.0, 29600.0, 29799.404011920073, 29946.550801738427, 30486.0, 39327.80336098301, 48414.27378589253, 48816.0, 48848.2672759916, 48925.2661210075, 533161.0, 541683.0, 544662.0, 544859.0, 545744.0, 25395.238142855746, 25490.872545637154, 25758.227253182435, 26105.477890441703, 26200.475990480463, 45948.8512787183, 46487.76756116198, 46517.302240465746, 47206.527934721584, 47830.0, 37701.0, 39725.602743973344, 39898.0, 40870.59129408668, 40937.59062409338, 39288.803555982035, 39618.00954976033, 39621.80189099036, 40899.591004089576, 40916.59083409128, 37791.244175116895, 38085.42871856869, 38485.230295394496, 38781.0, 38896.0, 34173.65826341705, 34754.652453475144, 35488.822555887054, 35501.82249088738, 35591.82204089066, 24283.785810709745, 25427.0, 25743.871280643478, 25841.353966150244, 26356.077537286103], "value": 18793.2583342443, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.55220906598475, 371.6487918916624, 380.6041716614721, 391.19609203087646, 398.85043108834185, 19535.609287814234, 20853.68719469209, 21099.2615258466, 21541.67687484689, 21677.891610541963, 17462.039587822666, 19591.92244426556, 20646.0, 20743.273985410513, 21023.68464473034, 5184.948150518503, 5483.259759932408, 5654.095344744842, 6139.2325959255095, 6199.969000155015, 6029.577929544934, 6055.364186760371, 6162.168107305523, 6176.042713379434, 6179.5056395488255, 5030.773615187307, 5949.077892926603, 5990.101484777275, 6080.331163572004, 6099.9935010723175, 4610.354550362952, 5985.6408615483215, 6064.36324185963, 6134.5092392608485, 6179.536534759888, 4819.397575303087, 4940.2342636891335, 5710.628809127394, 5822.155787410844, 5833.766649334021, 10061.798764024752, 14634.634134146625, 22113.557728845495, 22283.660215677282, 26427.67861606912, 2182.9890850545803, 2328.6739856420113, 2344.449054472215, 2531.493701259737, 2761.0336382266246, 8322.334213262924, 9930.106290433823, 10047.899521004769, 10083.697489075339, 10140.087392134743, 1494.7683109118104, 1780.9020503872282, 1788.4366424576217, 1822.3803906671794, 1895.7440745499318, 105572.0, 130207.0, 134957.65042349647, 134991.0, 136033.3198334002, 11399.772004559862, 11595.478203480863, 11686.12354073448, 11772.293662380112, 11821.468033938494, 14580.708385832437, 14597.051191672508, 14669.77995330071, 14689.19209443491, 14702.926485367505, 8333.16668333174, 8486.40595158333, 8544.14558544153, 8558.743237702754, 8612.354073444516, 8338.416310858303, 8394.118617545191, 8612.267957223581, 8627.654893804303, 8640.524771137521, 4434.379186913835, 4442.73343599385, 4456.927528699106, 4511.8646440606835, 4573.474050484237, 1897.1368027547708, 1949.9317523886596, 1960.4412742368356, 1995.2218634732467, 1999.3402177281753, 859.7678626770737, 877.2455688108222, 894.8389289927745, 908.9954550227206, 936.2322895225849, 20857.374278771662, 21341.359759207247, 21385.89307053455, 21468.463288417915, 21595.67606485904, 826.9332560996368, 896.0, 920.3971398733706, 924.177482040984, 975.1662328708993, 10113.747156321004, 10637.670291213599, 11218.943905280421, 11477.942610286895, 11507.424628768527, 486151.0, 489412.0, 604517.0, 608367.0, 632679.0, 110122.85724278279, 127859.36070319588, 131864.34067829791, 133355.0, 133361.0, 418.2617679795103, 444.21817601021786, 444.7309377826433, 449.5616773645735, 450.1739308369114, 10747.677569672922, 10984.340939543654, 11285.095044937603, 11519.07847372225, 11544.82682759776, 41547.58452415437, 51108.74445627748, 51793.7410312946, 53275.66810829605, 53693.0, 62257.37742622516, 69024.61950761057, 76117.61941190259, 78638.0, 82272.0, 7609.429292803173, 7746.457747957589, 7907.327877130509, 8403.63011234167, 8489.95755021221, 10131.392116473035, 13144.145630533985, 13238.0, 13305.201687898758, 13344.666383340495, 11447.313161210353, 11571.0, 11734.589289374831, 11866.0, 11919.46362413676, 10195.84706229422, 10292.279540432099, 10411.583536658449, 10499.055085042382, 11743.295402275891, 11102.833457498306, 11551.826722599, 11722.296662200295, 11777.470013849568, 11999.64001079969, 8214.219649133323, 8448.83102337962, 12013.939930300292, 12537.686557836127, 12872.871271287167, 11412.174052151617, 11437.656870293904, 11794.469248883992, 11869.525218991144, 12036.578719745117], "value": 9217.660030422594, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.2988225416311, 1564.5697433205867, 1721.1996421663923, 1797.5955410032736, 1854.332440321483, 7471.589062601554, 7789.337906277959, 8131.0, 8746.475211487315, 8776.56117194141, 7496.325330720234, 8544.530050847201, 8547.658093676246, 8561.571921403936, 8563.400561960665, 2334.673145759595, 2359.917402890899, 2360.2447216890514, 2362.621980483123, 2363.869987150706, 1960.4118764370703, 2319.8028167605776, 2362.763723627632, 2362.893669784864, 2373.635159783123, 2330.615448451012, 2342.4378149244144, 2349.2247558305803, 2364.160722943356, 2364.420716924356, 2321.7794309540736, 2333.288347054148, 2339.19297842245, 2345.9648105278347, 2352.741198468167, 2319.5592837361014, 2329.2313536533075, 2333.8132949364012, 2336.018872073716, 2342.5197834443898, 8428.915710842874, 8496.70261540843, 8505.19200675941, 8548.358873084482, 8639.00651425088, 5081.822136225214, 5236.842894713165, 5238.161894096965, 5238.711870847102, 5244.895102097975, 3431.4166591679473, 3463.3592785334795, 3529.5588051493564, 3572.356975744365, 3580.480830279595, 1034.5206354912473, 1066.306900514664, 1066.9253152279343, 1085.8316960871077, 1087.4399684162663, 9637.18083962864, 10674.412907290174, 11240.156988225834, 11255.718607034807, 11360.147988900782, 3730.7948062856804, 3964.801759911993, 4321.459817522809, 4435.35687325336, 4653.23221668421, 7852.489588176751, 8961.148690874357, 9701.126898579161, 9751.853722194173, 9753.170980466597, 3972.6821854252166, 5187.870303242449, 5201.0, 5205.869853253624, 5219.1388420910125, 4335.0, 4399.362092496634, 4730.337752714623, 4750.691205071659, 4777.570018698334, 3850.1914597934187, 3887.591802860659, 3923.862079996826, 3976.3439032559304, 4003.939940900889, 1137.5677242647907, 1230.4032544216047, 1285.042643230799, 1290.5225066725372, 1294.372229468707, 837.1795640272567, 905.4793493740993, 925.6251218256617, 929.1776777551916, 953.8187744328555, 5587.552995760329, 5669.744861481243, 5789.94210057894, 5969.76120955157, 6075.665838378932, 427.7882448188167, 435.507876100005, 439.91861505621563, 860.6256278518864, 1022.1158697726413, 3963.4253033310583, 4067.877963661095, 4070.1249231415386, 4086.6526345260986, 4101.652248616476, 9374.437533747998, 10125.12685153249, 10395.32430392022, 10490.370577765358, 10542.841857372145, 10193.796124077477, 10351.120154786777, 10453.372797632166, 10462.895371046345, 10486.895131048592, 7186.957891105761, 7645.961770191114, 7972.441929065026, 8085.595720213966, 8096.433249672584, 4855.907420830426, 5700.743466544099, 5714.314282285986, 5887.676177810262, 5922.407759224043, 9526.952365238407, 9560.091791279818, 9686.32195746291, 9773.364731292444, 9849.359791613522, 9634.662786802428, 9753.414795112316, 9892.208623310262, 9900.455474948947, 9974.551145198338, 6472.967635161794, 6637.502187336066, 6640.203175618956, 6837.076994605664, 6893.0694356261265, 8224.342052635655, 8301.750947471586, 8305.0, 8311.792205194919, 8321.625526851427, 7324.0, 7463.664135113824, 7463.813404664927, 7558.811029724301, 7576.924230757842, 7133.643317834191, 7220.74727384539, 7313.67088481009, 7333.0, 7358.558486490828, 6810.31896810315, 6828.760993365208, 6920.9653951729915, 6924.376806087476, 6935.167779866449, 4940.184869496493, 5009.7996080157845, 5014.774335154853, 5049.141645920276, 5079.085764562266, 4257.19113368459, 4740.099381117577, 5044.672096313728, 5094.821681241138, 5095.821646242363], "value": 4432.776990916409, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [242.76694373401523, 304.2697525937749, 310.7141429884506, 312.32849373846244, 314.05469536694545, 4598.839040633578, 5487.835364939058, 5618.15727640854, 5665.461781130796, 5679.403662615423, 4927.236278376858, 5493.587980901429, 5519.530839878616, 5616.045272303708, 5635.21107045014, 3751.6811071058855, 4021.8592349267783, 4273.850415235467, 4279.122779830127, 4296.0, 3512.7541072124964, 4152.294110001307, 4257.233697934371, 4283.978580107095, 4306.332518459628, 3720.920932929447, 4023.4568333274924, 4174.248635245654, 4263.467066616673, 4284.207421627009, 3904.629060239273, 4235.597618226295, 4263.616274535291, 4269.359596060584, 4289.656827453796, 3492.350493734054, 3605.7740368274913, 3698.7424275746375, 3698.9827797355674, 3734.3651579231596, 4435.756033418161, 5063.721495317756, 5256.842294731164, 5425.701586412746, 5511.807086751985, 4846.710661064948, 4856.693070791382, 4907.68100073494, 4914.680545764514, 4936.580390666798, 5606.635568688063, 5884.764609415618, 5892.616979896293, 5952.4642782149385, 5966.925953328399, 3693.488427869048, 3859.4982652255026, 3998.300297447935, 4055.4322394864744, 4068.776217308047, 5455.318085239345, 5954.880902381971, 6294.181756371689, 6344.841378965562, 6383.744650213986, 3444.8794292200155, 3628.74598778083, 4130.6282434581035, 4135.58644135584, 4143.1713657268065, 3318.352921180395, 3995.5005624296964, 4078.225137223918, 4086.7139300248696, 4104.384342348671, 4379.554746933504, 4782.760861956888, 4794.448638406628, 4798.376211092535, 4815.759212039384, 5373.086575282211, 5773.498890288555, 5898.616589921641, 5954.910676339859, 6048.9697551512845, 1331.0815537279245, 1335.3657012918786, 1371.3349025722516, 1385.7852032934911, 1397.9580612581435, 666.4202144134537, 693.9659906738923, 813.9593020348959, 850.1201256699287, 857.0015931439802, 4261.446012018479, 4391.8682439526865, 4676.0, 4724.732128578302, 4727.416315534335, 4238.724482908663, 4557.860534866283, 5187.455317191716, 5188.250227379495, 5221.791128354899, 4138.255114079434, 4532.818687252539, 4625.537446255347, 4662.696924699883, 4710.29345598163, 2184.1434780436502, 2302.6085565453914, 2416.501768903291, 2597.3636459067648, 2640.683118025849, 4336.544662810423, 4585.816567337336, 4657.231556793159, 4673.719576825401, 5441.428649991773, 4257.957420425818, 4814.7149037356785, 4949.752512374367, 5247.816326428557, 5252.947470525322, 4287.756550600353, 4395.7142785718825, 5221.605956128471, 5263.710390954241, 5349.465053494697, 4792.113459010095, 4846.5153484652665, 5028.597712182944, 5144.122395325604, 5167.638265321391, 4082.081531655354, 4896.559309662148, 4987.451380348086, 5077.014543583269, 5141.588672906084, 4347.847825326098, 5781.537477001913, 5871.853203669943, 6454.935450645434, 6475.805725828232, 3800.0, 3870.664620705852, 4028.7784171869657, 4044.6359827615656, 4064.47161868967, 5440.755166017618, 5657.971710141423, 5714.999875021771, 6014.879702405839, 6163.506919446523, 5543.3902270751, 5562.1922875066575, 5884.0, 5911.91132133027, 5918.644881307136, 5675.404082571271, 5876.1773351729935, 5895.9705201475435, 5904.106987576142, 5921.904447677193, 5797.130430435468, 5800.39095894925, 5802.82591522255, 5810.448007439287, 5841.620294680833, 5347.545503586398, 5594.944050559442, 5689.687067211343, 5824.893270278633, 6049.848753781191, 5041.6470847040355, 5160.890408562177, 5806.274215723035, 5818.33089194748, 5826.41735826414], "value": 4059.434000127296, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.9196858424112, 700.7162099349762, 719.0508528742063, 770.560780355197, 807.7940125268055, 13571.710687484685, 15121.243937803107, 15303.617409564753, 15661.530154095395, 15771.763423548657, 13409.530666426677, 14137.0, 14252.572422827332, 14267.1439713617, 14286.428542858273, 664.7042066280507, 816.5998660656295, 830.1283652165232, 838.5974732128582, 841.3857883744839, 805.7059173401695, 841.9957900210491, 846.1707526623912, 846.4709556527171, 849.6304107713164, 889.7820034091657, 904.2449554621899, 904.3533873280603, 905.2441211588299, 906.4561263242068, 865.2342676731107, 875.4703404440286, 889.8487257166232, 901.8106197698492, 902.5938327752538, 651.0657206908102, 670.2961890015464, 672.5023482622872, 673.2089794491502, 673.5251647588439, 14867.479638212611, 14885.627859303604, 14906.180160091191, 14919.552413427615, 14920.776188357184, 14768.0, 14822.555323340317, 14877.851221487756, 14895.851041489555, 14910.925445372812, 12003.879961200364, 12297.077719171099, 12446.502139914483, 12504.187227830162, 12532.99736021116, 3812.8474861005525, 3863.1887303666263, 4015.0966032642714, 4034.547562877362, 4041.6362527372385, 114261.0, 116102.41948790202, 117025.41487292595, 117208.0, 117290.0, 11353.489092990836, 11456.3698996556, 11476.59831905896, 11490.310581365145, 11846.526138954345, 22820.885895570416, 23187.60874347511, 23784.524309513712, 23841.0, 24110.0, 8207.876881846658, 8227.382946279053, 8229.05365882931, 8271.958640206882, 8292.958535207406, 4372.519022907478, 4428.490723566767, 4464.374987501752, 4464.843730469418, 4564.2012647786505, 3435.5018522314626, 3562.7886518583805, 3572.928541429209, 3577.499150118985, 3579.6599323064265, 642.2389468479867, 652.5725649699455, 657.2704298228962, 666.4701562258017, 668.4017804065335, 587.9441453061952, 592.517098564677, 616.7687117331001, 644.4972921121532, 648.8313038609996, 6693.732250709917, 8740.8688869667, 8801.691940782042, 8844.469331839982, 9096.454212747256, 532.2043544900399, 563.152455554388, 583.8294220088779, 593.5577994394204, 617.9649087777954, 4066.7763273019677, 4388.802503887333, 4404.163208990346, 4411.29419292918, 4613.8385156520035, 104074.0, 123497.0, 131442.0, 156914.0, 184508.0, 89063.55468222748, 119370.0, 131155.0, 132589.67410325966, 154298.0, 108279.12743926542, 129824.0, 131039.68960310274, 132104.0, 133013.33493332664, 7487.0, 7568.0161578994375, 8589.63508736989, 8776.736697898818, 8805.603747831492, 53213.7339313301, 61793.60135192428, 64879.35120648733, 67793.66103169453, 68058.31941680718, 65754.0273791787, 77470.0, 78712.2128778705, 78718.60640696759, 83170.16829831625, 12691.111622186358, 12726.936365318485, 12942.158759680591, 13575.932120339336, 14023.439062437388, 14456.0, 14805.777913331523, 15264.694706106038, 15721.213939302761, 15850.841491585397, 11971.461284242056, 13772.65568360799, 14015.649608759863, 14016.29918504091, 14151.221682807545, 14127.364268608142, 14161.504347347793, 14248.358823852745, 14385.64035899111, 14411.711765764836, 13260.336983150612, 13818.930905345811, 14021.228832414316, 14243.643908901946, 14534.273286335852, 10683.554623227225, 11467.139964502863, 11592.478338474957, 11624.82562761576, 12072.637820865388, 11410.657680269605, 11605.709857253298, 11755.0, 11903.345316007357, 11987.820182697093], "value": 7813.520963916474, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 107.0, 118.0, 118.0, 117.0, 114.0, 137.0, 170.0, 120.0], "value": 122.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 132.0, 159.0, 110.0, 132.0, 130.0, 110.0, 156.0, 116.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 202.0, 205.0, 248.0, 198.0, 195.0, 198.0, 197.0, 199.0, 212.0], "value": 205.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 71.0, 67.0, 133.0, 53.0, 59.0, 66.0, 87.0, 160.0, 79.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 125.0, 78.0, 88.0, 64.0, 100.0, 91.0, 96.0, 145.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 88.0, 86.0, 77.0, 128.0, 134.0, 86.0, 88.0, 86.0], "value": 95.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 100.0, 95.0, 97.0, 115.0, 152.0, 115.0, 94.0, 90.0], "value": 104.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 95.0, 91.0, 88.0, 95.0, 92.0, 141.0, 122.0, 94.0, 92.0], "value": 100.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0, 55.0, 55.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 73.0, 75.0, 75.0, 68.0, 69.0, 68.0, 72.0, 99.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 75.0, 102.0, 105.0, 79.0, 85.0, 90.0, 84.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 153.0, 148.0, 132.0, 136.0, 138.0, 139.0, 156.0, 154.0, 136.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 174.0, 171.0, 170.0, 180.0, 236.0, 173.0, 167.0, 179.0, 169.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 68.0, 69.0, 69.0, 69.0, 67.0, 69.0, 69.0, 67.0], "value": 68.8, "unit": "score"}]}]} 05:29:41 INFO - Return code: 0 05:29:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:29:41 ERROR - # TBPL SUCCESS # 05:29:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:29:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:29:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:29:42 INFO - 2016-08-08 05:29:42.013 screenresolution[1669:10389] starting screenresolution argv=screenresolution get 05:29:42 INFO - 2016-08-08 05:29:42.016 screenresolution[1669:10389] Display 0: 1600x1200x32@60 05:29:42 INFO - 2016-08-08 05:29:42.022 screenresolution[1670:10392] starting screenresolution argv=screenresolution list 05:29:42 INFO - Available Modes on Display 0 05:29:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:29:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:29:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:29:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:29:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:29:42 INFO - Intel Iris: 05:29:42 INFO - Chipset Model: Intel Iris 05:29:42 INFO - Type: GPU 05:29:42 INFO - Bus: Built-In 05:29:42 INFO - VRAM (Dynamic, Max): 1536 MB 05:29:42 INFO - Vendor: Intel (0x8086) 05:29:42 INFO - Device ID: 0x0a2e 05:29:42 INFO - Revision ID: 0x0009 05:29:42 INFO - Displays: 05:29:42 INFO - Display: 05:29:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:29:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:29:42 INFO - Display Serial Number: 1600x1200 60 05:29:42 INFO - Main Display: Yes 05:29:42 INFO - Mirror: Off 05:29:42 INFO - Online: Yes 05:29:42 INFO - Rotation: Supported 05:29:42 INFO - Return code: 0 05:29:42 INFO - Running post-action listener: _resource_record_post_action 05:29:42 INFO - [mozharness: 2016-08-08 12:29:42.266985Z] Finished run-tests step (success) 05:29:42 INFO - Running post-run listener: _resource_record_post_run 05:29:42 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 38208512; Write bytes: 708680704; Read time: 399; Write time: 2325 05:29:42 INFO - TinderboxPrint: CPU usage
54.3% 05:29:42 INFO - TinderboxPrint: I/O read bytes / time
38,208,512 / 399 05:29:42 INFO - TinderboxPrint: I/O write bytes / time
708,680,704 / 2,325 05:29:42 INFO - TinderboxPrint: CPU idle
2,210.6 (45.7%) 05:29:42 INFO - TinderboxPrint: CPU system
976.5 (20.2%) 05:29:42 INFO - TinderboxPrint: CPU user
1,654.6 (34.2%) 05:29:42 INFO - TinderboxPrint: Swap in / out
444,723,200 / 0 05:29:42 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393316864; Write bytes: 382150656; Read time: 29253; Write time: 994 05:29:42 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 31939584; Write bytes: 297178112; Read time: 311; Write time: 1274 05:29:42 INFO - Running post-run listener: _upload_blobber_files 05:29:42 INFO - Blob upload gear active. 05:29:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:29:42 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 05:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:29:43 INFO - (blobuploader) - INFO - Open directory for files ... 05:29:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:29:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:29:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:43 INFO - (blobuploader) - INFO - Done attempting. 05:29:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:29:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:29:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:44 INFO - (blobuploader) - INFO - Done attempting. 05:29:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:29:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:29:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:49 INFO - (blobuploader) - INFO - Done attempting. 05:29:49 INFO - (blobuploader) - INFO - Iteration through files over. 05:29:49 INFO - Return code: 0 05:29:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:29:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:29:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb640e873566078f185db62419d1fa7a7bf8f3ca1c6e55466426172c8c2cb35e0436f8e264de9732d24c3575f10a537b3a12dbea82444c8b2e8b3abdb97c4545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0126304590563a55e770be39d35d70f30ca218e3844993910f752f3cd58aab53ada83926c1fc39b7c11e99f9e5f933e2b1eb609696114fe8bc202096d0f55b46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e5083bf6951f8ff47d4ef09f111e11321aaf6148de10e7214872dedacbb0963022c90a34fd7a718614d24327ea480e98d028d42fb8e3a3ce7862ab7fd371456"} 05:29:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:29:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:29:49 INFO - Contents: 05:29:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb640e873566078f185db62419d1fa7a7bf8f3ca1c6e55466426172c8c2cb35e0436f8e264de9732d24c3575f10a537b3a12dbea82444c8b2e8b3abdb97c4545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0126304590563a55e770be39d35d70f30ca218e3844993910f752f3cd58aab53ada83926c1fc39b7c11e99f9e5f933e2b1eb609696114fe8bc202096d0f55b46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e5083bf6951f8ff47d4ef09f111e11321aaf6148de10e7214872dedacbb0963022c90a34fd7a718614d24327ea480e98d028d42fb8e3a3ce7862ab7fd371456"} 05:29:49 INFO - Running post-run listener: copy_logs_to_upload_dir 05:29:49 INFO - Copying logs to upload dir... 05:29:49 INFO - mkdir: /builds/slave/test/build/upload/logs 05:29:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.304405 ========= master_lag: 1.90 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-08 05:29:51.226974) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 05:29:51.230684) ========= 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.ViJ9Eifici/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.XVVeYvCRdv/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb640e873566078f185db62419d1fa7a7bf8f3ca1c6e55466426172c8c2cb35e0436f8e264de9732d24c3575f10a537b3a12dbea82444c8b2e8b3abdb97c4545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0126304590563a55e770be39d35d70f30ca218e3844993910f752f3cd58aab53ada83926c1fc39b7c11e99f9e5f933e2b1eb609696114fe8bc202096d0f55b46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e5083bf6951f8ff47d4ef09f111e11321aaf6148de10e7214872dedacbb0963022c90a34fd7a718614d24327ea480e98d028d42fb8e3a3ce7862ab7fd371456"} build_url:https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb640e873566078f185db62419d1fa7a7bf8f3ca1c6e55466426172c8c2cb35e0436f8e264de9732d24c3575f10a537b3a12dbea82444c8b2e8b3abdb97c4545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0126304590563a55e770be39d35d70f30ca218e3844993910f752f3cd58aab53ada83926c1fc39b7c11e99f9e5f933e2b1eb609696114fe8bc202096d0f55b46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e5083bf6951f8ff47d4ef09f111e11321aaf6148de10e7214872dedacbb0963022c90a34fd7a718614d24327ea480e98d028d42fb8e3a3ce7862ab7fd371456"}' ========= master_lag: 0.47 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 05:29:51.714273) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:29:51.714618) ========= 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.ViJ9Eifici/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.XVVeYvCRdv/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.005192 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:29:51.783286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 05:29:51.783627) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 05:29:51.785504) ========= ========= Total master_lag: 2.50 =========