builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0235 starttime: 1472759483.45 results: success (0) buildid: 20160901094721 builduid: 64accd57cd7e4546aa8878515803ff56 revision: 52851295b34fa7471a1a7b7a7123fa3a68eacc40 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 12:51:23.454147) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 12:51:23.454618) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 12:51:23.454944) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 12:51:23.483811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 12:51:23.484227) ========= 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.sgFXZ9PmRv/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.9qEkaNJJg7/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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-09-01 12:51:23-- 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% 18.6M=0.001s 2016-09-01 12:51:23 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155244 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 12:51:23.663816) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 12:51:23.664355) ========= 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.sgFXZ9PmRv/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.9qEkaNJJg7/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.025553 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 12:51:23.714720) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-01 12:51:23.715357) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 52851295b34fa7471a1a7b7a7123fa3a68eacc40 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 52851295b34fa7471a1a7b7a7123fa3a68eacc40 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sgFXZ9PmRv/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.9qEkaNJJg7/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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-09-01 12:51:23,802 truncating revision to first 12 chars 2016-09-01 12:51:23,802 Setting DEBUG logging. 2016-09-01 12:51:23,802 attempt 1/10 2016-09-01 12:51:23,802 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/52851295b34f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 12:51:25,726 unpacking tar archive at: autoland-52851295b34f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.182726 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-01 12:51:25.921496) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 12:51:25.921811) ========= script_repo_revision: 52851295b34fa7471a1a7b7a7123fa3a68eacc40 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 12:51:25.922210) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 12:51:25.922480) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 12:51:25.941175) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-01 12:51:25.941593) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sgFXZ9PmRv/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.9qEkaNJJg7/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 12:51:26 INFO - MultiFileLogger online at 20160901 12:51:26 in /builds/slave/test 12:51:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 12:51:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:51:26 INFO - {'append_to_log': False, 12:51:26 INFO - 'base_work_dir': '/builds/slave/test', 12:51:26 INFO - 'blob_upload_branch': 'Autoland', 12:51:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:51:26 INFO - 'branch': 'Autoland', 12:51:26 INFO - 'buildbot_json_path': 'buildprops.json', 12:51:26 INFO - 'config_files': ('talos/mac_config.py',), 12:51:26 INFO - 'default_actions': ('clobber', 12:51:26 INFO - 'read-buildbot-config', 12:51:26 INFO - 'download-and-extract', 12:51:26 INFO - 'populate-webroot', 12:51:26 INFO - 'create-virtualenv', 12:51:26 INFO - 'install', 12:51:26 INFO - 'run-tests'), 12:51:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:51:26 INFO - 'download_minidump_stackwalk': True, 12:51:26 INFO - 'download_symbols': 'ondemand', 12:51:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:51:26 INFO - 'tooltool.py': '/tools/tooltool.py', 12:51:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:51:26 INFO - '/tools/misc-python/virtualenv.py')}, 12:51:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:51:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:51:26 INFO - 'installer_path': 'installer.exe', 12:51:26 INFO - 'log_level': 'info', 12:51:26 INFO - 'log_name': 'talos', 12:51:26 INFO - 'log_to_console': True, 12:51:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:51:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:51:26 INFO - 'opt_config_files': (), 12:51:26 INFO - 'pip_index': False, 12:51:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:51:26 INFO - 'cmd': ('bash', 12:51:26 INFO - '-c', 12:51:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:51:26 INFO - 'enabled': True, 12:51:26 INFO - 'halt_on_failure': False, 12:51:26 INFO - 'name': 'check_screen_resolution'},), 12:51:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:51:26 INFO - 'cmd': ('bash', 12:51:26 INFO - '-c', 12:51:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:51:26 INFO - 'enabled': True, 12:51:26 INFO - 'halt_on_failure': False, 12:51:26 INFO - 'name': 'check_screen_resolution'},), 12:51:26 INFO - 'run_cmd_checks_enabled': True, 12:51:26 INFO - 'sps_profile': False, 12:51:26 INFO - 'sps_profile_interval': 0, 12:51:26 INFO - 'suite': 'dromaeojs-e10s', 12:51:26 INFO - 'system_bits': '32', 12:51:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:51:26 INFO - 'title': 't-yosemite-r7-0235', 12:51:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:51:26 INFO - 'use_talos_json': True, 12:51:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:51:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:51:26 INFO - 'work_dir': 'build'} 12:51:26 INFO - [mozharness: 2016-09-01 19:51:26.134429Z] Running clobber step. 12:51:26 INFO - Running pre-action listener: _resource_record_pre_action 12:51:26 INFO - Running main action method: clobber 12:51:26 INFO - rmtree: /builds/slave/test/build 12:51:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:51:28 INFO - Running post-action listener: _resource_record_post_action 12:51:28 INFO - [mozharness: 2016-09-01 19:51:28.020070Z] Finished clobber step (success) 12:51:28 INFO - [mozharness: 2016-09-01 19:51:28.020213Z] Running read-buildbot-config step. 12:51:28 INFO - Running pre-action listener: _resource_record_pre_action 12:51:28 INFO - Running main action method: read_buildbot_config 12:51:28 INFO - Using buildbot properties: 12:51:28 INFO - { 12:51:28 INFO - "project": "", 12:51:28 INFO - "product": "firefox", 12:51:28 INFO - "script_repo_revision": "production", 12:51:28 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 12:51:28 INFO - "repository": "", 12:51:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 12:51:28 INFO - "buildid": "20160901094721", 12:51:28 INFO - "pgo_build": "False", 12:51:28 INFO - "basedir": "/builds/slave/test", 12:51:28 INFO - "buildnumber": 186, 12:51:28 INFO - "slavename": "t-yosemite-r7-0235", 12:51:28 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 12:51:28 INFO - "platform": "yosemite_r7", 12:51:28 INFO - "scheduler": "tests-autoland-macosx64-talos-7-3600", 12:51:28 INFO - "branch": "autoland", 12:51:28 INFO - "repo_path": "integration/autoland", 12:51:28 INFO - "revision": "52851295b34fa7471a1a7b7a7123fa3a68eacc40", 12:51:28 INFO - "stage_platform": "macosx64", 12:51:28 INFO - "builduid": "64accd57cd7e4546aa8878515803ff56", 12:51:28 INFO - "slavebuilddir": "test" 12:51:28 INFO - } 12:51:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 12:51:28 INFO - Running post-action listener: _resource_record_post_action 12:51:28 INFO - [mozharness: 2016-09-01 19:51:28.023520Z] Finished read-buildbot-config step (success) 12:51:28 INFO - [mozharness: 2016-09-01 19:51:28.023604Z] Running download-and-extract step. 12:51:28 INFO - Running pre-action listener: _resource_record_pre_action 12:51:28 INFO - Running main action method: download_and_extract 12:51:28 INFO - mkdir: /builds/slave/test/build/tests 12:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:28 INFO - trying https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 12:51:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/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 12:51:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/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 12:51:29 INFO - Downloaded 1199 bytes. 12:51:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 12:51:29 INFO - Using the following test package requirements: 12:51:29 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 12:51:29 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:51:29 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 12:51:29 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:51:29 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 12:51:29 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:51:29 INFO - u'jsshell-mac.zip'], 12:51:29 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:51:29 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 12:51:29 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 12:51:29 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:51:29 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 12:51:29 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:51:29 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 12:51:29 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:51:29 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 12:51:29 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:51:29 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 12:51:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:29 INFO - trying https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 12:51:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/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 12:51:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/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 12:51:30 INFO - Downloaded 16399258 bytes. 12:51:30 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 12:51:36 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 12:51: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')]} 12:51:36 INFO - trying https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 12:51:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/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 12:51:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/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 12:51:37 INFO - Downloaded 16399258 bytes. 12:51:37 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 12:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:44 INFO - trying https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 12:51:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/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 12:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/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 12:51:46 INFO - Downloaded 14413998 bytes. 12:51:46 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 12:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:46 INFO - trying https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:51:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 12:51:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/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 12:51:49 INFO - Downloaded 111579001 bytes. 12:51:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:51:49 INFO - mkdir: /builds/slave/test/properties 12:51:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:51:49 INFO - Writing to file /builds/slave/test/properties/build_url 12:51:49 INFO - Contents: 12:51:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:51:49 INFO - Running post-action listener: _resource_record_post_action 12:51:49 INFO - Running post-action listener: set_extra_try_arguments 12:51:49 INFO - [mozharness: 2016-09-01 19:51:49.930089Z] Finished download-and-extract step (success) 12:51:49 INFO - [mozharness: 2016-09-01 19:51:49.930187Z] Running populate-webroot step. 12:51:49 INFO - Running pre-action listener: _resource_record_pre_action 12:51:49 INFO - Running main action method: populate_webroot 12:51:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:51:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:51:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:51:49 INFO - '--tppagecycles', 12:51:49 INFO - '7'], 12:51:49 INFO - 'tests': ['tsvgm']}}, 12:51:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:51:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:51:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:51:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:51:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:51:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:51:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:49 INFO - 'talos_options': ['--disable-e10s'], 12:51:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:51:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:51:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:49 INFO - 'talos_options': ['--disable-e10s'], 12:51:49 INFO - 'tests': ['damp', 'tps']}, 12:51:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:49 INFO - 'tests': ['damp', 'tps']}, 12:51:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:51:49 INFO - 'tests': ['dromaeo_dom']}, 12:51:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:51:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:51:49 INFO - 'tests': ['basic_compositor_video']}, 12:51:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:51:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:51:49 INFO - 'tests': ['a11yr', 12:51:49 INFO - 'ts_paint', 12:51:49 INFO - 'tpaint', 12:51:49 INFO - 'sessionrestore', 12:51:49 INFO - 'sessionrestore_no_auto_restore', 12:51:49 INFO - 'tabpaint']}, 12:51:49 INFO - 'other-e10s': {'tests': ['a11yr', 12:51:49 INFO - 'ts_paint', 12:51:49 INFO - 'tpaint', 12:51:49 INFO - 'sessionrestore', 12:51:49 INFO - 'sessionrestore_no_auto_restore', 12:51:49 INFO - 'tabpaint']}, 12:51:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:51:49 INFO - 'ts_paint', 12:51:49 INFO - 'tpaint', 12:51:49 INFO - 'sessionrestore', 12:51:49 INFO - 'sessionrestore_no_auto_restore', 12:51:49 INFO - 'tabpaint']}, 12:51:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:51:49 INFO - 'ts_paint', 12:51:49 INFO - 'tpaint', 12:51:49 INFO - 'sessionrestore', 12:51:49 INFO - 'sessionrestore_no_auto_restore', 12:51:49 INFO - 'tabpaint']}, 12:51:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:51:49 INFO - 'tests': ['a11yr', 12:51:49 INFO - 'ts_paint', 12:51:49 INFO - 'tpaint', 12:51:49 INFO - 'sessionrestore', 12:51:49 INFO - 'sessionrestore_no_auto_restore', 12:51:49 INFO - 'tabpaint']}, 12:51:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:51:49 INFO - 'tests': ['a11yr', 12:51:49 INFO - 'ts_paint', 12:51:49 INFO - 'tpaint', 12:51:49 INFO - 'sessionrestore', 12:51:49 INFO - 'sessionrestore_no_auto_restore', 12:51:49 INFO - 'tabpaint']}, 12:51:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:51:49 INFO - 'tests': ['tsvgx', 12:51:49 INFO - 'tsvgr_opacity', 12:51:49 INFO - 'tart', 12:51:49 INFO - 'tscrollx', 12:51:49 INFO - 'cart']}, 12:51:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:51:49 INFO - 'tsvgr_opacity', 12:51:49 INFO - 'tart', 12:51:49 INFO - 'tscrollx', 12:51:49 INFO - 'cart']}, 12:51:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:49 INFO - 'talos_options': ['--disable-e10s'], 12:51:49 INFO - 'tests': ['tp5o']}, 12:51:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:49 INFO - 'tests': ['tp5o']}, 12:51:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:49 INFO - 'talos_options': ['--disable-e10s', 12:51:49 INFO - '--xperf_path', 12:51:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:51:49 INFO - 'tests': ['tp5n']}, 12:51:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:49 INFO - 'talos_options': ['--xperf_path', 12:51:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:51:49 INFO - 'tests': ['tp5n']}}, 12:51:49 INFO - 'talos.zip': {'path': '', 12:51:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:51:49 INFO - Running post-action listener: _resource_record_post_action 12:51:49 INFO - [mozharness: 2016-09-01 19:51:49.949111Z] Finished populate-webroot step (success) 12:51:49 INFO - [mozharness: 2016-09-01 19:51:49.949243Z] Running create-virtualenv step. 12:51:49 INFO - Running pre-action listener: _resource_record_pre_action 12:51:49 INFO - Running main action method: create_virtualenv 12:51:49 INFO - Creating virtualenv /builds/slave/test/build/venv 12:51:49 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 12:51:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:51:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:51:50 INFO - Using real prefix '/tools/python27' 12:51:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:51:50 INFO - Installing distribute.............................................................................................................................................................................................done. 12:51:53 INFO - Installing pip.................done. 12:51:53 INFO - Return code: 0 12:51:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:53 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 0x100db7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e4c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb84958dc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1bd30>, '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 0x100a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d13b20>, '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.sgFXZ9PmRv/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.9qEkaNJJg7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 12:51:53 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 12:51:53 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 12:51:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sgFXZ9PmRv/Render', 12:51:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:53 INFO - 'HOME': '/Users/cltbld', 12:51:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:53 INFO - 'LOGNAME': 'cltbld', 12:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:53 INFO - 'MOZ_NO_REMOTE': '1', 12:51:53 INFO - 'NO_EM_RESTART': '1', 12:51:53 INFO - 'PAGER': '/bin/cat', 12:51:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:53 INFO - 'PWD': '/builds/slave/test', 12:51:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:53 INFO - 'SHELL': '/bin/bash', 12:51:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9qEkaNJJg7/Listeners', 12:51:53 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 12:51:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:53 INFO - 'USER': 'cltbld', 12:51:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:53 INFO - 'XPC_FLAGS': '0x0', 12:51:53 INFO - 'XPC_SERVICE_NAME': '0', 12:51:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:53 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 12:51:53 INFO - Cleaning up... 12:51:53 INFO - Return code: 0 12:51:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:53 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 0x100db7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e4c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb84958dc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1bd30>, '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 0x100a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d13b20>, '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.sgFXZ9PmRv/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.9qEkaNJJg7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 12:51:53 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 12:51:53 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 12:51:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sgFXZ9PmRv/Render', 12:51:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:53 INFO - 'HOME': '/Users/cltbld', 12:51:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:53 INFO - 'LOGNAME': 'cltbld', 12:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:53 INFO - 'MOZ_NO_REMOTE': '1', 12:51:53 INFO - 'NO_EM_RESTART': '1', 12:51:53 INFO - 'PAGER': '/bin/cat', 12:51:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:53 INFO - 'PWD': '/builds/slave/test', 12:51:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:53 INFO - 'SHELL': '/bin/bash', 12:51:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9qEkaNJJg7/Listeners', 12:51:53 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 12:51:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:53 INFO - 'USER': 'cltbld', 12:51:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:53 INFO - 'XPC_FLAGS': '0x0', 12:51:53 INFO - 'XPC_SERVICE_NAME': '0', 12:51:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:54 INFO - Downloading/unpacking psutil>=3.1.1 12:51:54 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 12:51:54 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 12:51:54 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 12:51:54 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 12:51:54 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 12:51:54 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 12:51:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:51:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:51:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:51:56 INFO - Installing collected packages: psutil 12:51:56 INFO - Running setup.py install for psutil 12:51:56 INFO - building 'psutil._psutil_osx' extension 12:51:56 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 12:51:57 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 12:51:57 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 12:51:57 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 12:51:57 INFO - building 'psutil._psutil_posix' extension 12:51:57 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 12:51:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:51:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:51:57 INFO - ^ 12:51:57 INFO - 1 warning generated. 12:51:57 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 12:51:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:51:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:51:57 INFO - Successfully installed psutil 12:51:57 INFO - Cleaning up... 12:51:57 INFO - Return code: 0 12:51:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:51: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')]} 12:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:57 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 0x100db7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e4c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb84958dc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1bd30>, '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 0x100a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d13b20>, '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.sgFXZ9PmRv/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.9qEkaNJJg7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 12:51:57 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 12:51:57 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 12:51:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sgFXZ9PmRv/Render', 12:51:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:57 INFO - 'HOME': '/Users/cltbld', 12:51:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:57 INFO - 'LOGNAME': 'cltbld', 12:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:57 INFO - 'MOZ_NO_REMOTE': '1', 12:51:57 INFO - 'NO_EM_RESTART': '1', 12:51:57 INFO - 'PAGER': '/bin/cat', 12:51:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:57 INFO - 'PWD': '/builds/slave/test', 12:51:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:57 INFO - 'SHELL': '/bin/bash', 12:51:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9qEkaNJJg7/Listeners', 12:51:57 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 12:51:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:57 INFO - 'USER': 'cltbld', 12:51:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:57 INFO - 'XPC_FLAGS': '0x0', 12:51:57 INFO - 'XPC_SERVICE_NAME': '0', 12:51:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:51:58 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 12:51:58 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 12:51:58 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 12:51:58 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 12:51:58 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 12:51:58 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 12:52:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:52:00 INFO - Installing collected packages: mozsystemmonitor 12:52:00 INFO - Running setup.py install for mozsystemmonitor 12:52:00 INFO - Successfully installed mozsystemmonitor 12:52:00 INFO - Cleaning up... 12:52:00 INFO - Return code: 0 12:52:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:52:00 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')]} 12:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:00 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')]} 12:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:00 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 0x100db7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e4c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb84958dc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1bd30>, '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 0x100a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d13b20>, '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.sgFXZ9PmRv/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.9qEkaNJJg7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 12:52:00 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 12:52:00 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 12:52:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sgFXZ9PmRv/Render', 12:52:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:00 INFO - 'HOME': '/Users/cltbld', 12:52:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:00 INFO - 'LOGNAME': 'cltbld', 12:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:00 INFO - 'MOZ_NO_REMOTE': '1', 12:52:00 INFO - 'NO_EM_RESTART': '1', 12:52:00 INFO - 'PAGER': '/bin/cat', 12:52:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:00 INFO - 'PWD': '/builds/slave/test', 12:52:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:00 INFO - 'SHELL': '/bin/bash', 12:52:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9qEkaNJJg7/Listeners', 12:52:00 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 12:52:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:00 INFO - 'USER': 'cltbld', 12:52:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:00 INFO - 'XPC_FLAGS': '0x0', 12:52:00 INFO - 'XPC_SERVICE_NAME': '0', 12:52:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:01 INFO - Downloading/unpacking jsonschema==2.5.1 12:52:01 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 12:52:01 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 12:52:01 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 12:52:01 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 12:52:01 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 12:52:01 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 12:52:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:52:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:52:03 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 12:52:03 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 12:52:03 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 12:52:03 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 12:52:03 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 12:52:03 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 12:52:03 INFO - Downloading functools32-3.2.3-2.tar.gz 12:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:52:04 INFO - warning: no files found matching '*.txt' 12:52:04 INFO - no previously-included directories found matching 'build' 12:52:04 INFO - no previously-included directories found matching 'dist' 12:52:04 INFO - no previously-included directories found matching '.git*' 12:52:04 INFO - Installing collected packages: jsonschema, functools32 12:52:04 INFO - Running setup.py install for functools32 12:52:04 INFO - warning: no files found matching '*.txt' 12:52:04 INFO - no previously-included directories found matching 'build' 12:52:04 INFO - no previously-included directories found matching 'dist' 12:52:04 INFO - no previously-included directories found matching '.git*' 12:52:04 INFO - Successfully installed jsonschema functools32 12:52:04 INFO - Cleaning up... 12:52:04 INFO - Return code: 0 12:52:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:52: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')]} 12:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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')]} 12:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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', '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 0x100db7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e4c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb84958dc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1bd30>, '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 0x100a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d13b20>, '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.sgFXZ9PmRv/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.9qEkaNJJg7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 12:52: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:52: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 functools32==3.2.3-2 12:52:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sgFXZ9PmRv/Render', 12:52:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:04 INFO - 'HOME': '/Users/cltbld', 12:52:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:04 INFO - 'LOGNAME': 'cltbld', 12:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:04 INFO - 'MOZ_NO_REMOTE': '1', 12:52:04 INFO - 'NO_EM_RESTART': '1', 12:52:04 INFO - 'PAGER': '/bin/cat', 12:52:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:04 INFO - 'PWD': '/builds/slave/test', 12:52:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:04 INFO - 'SHELL': '/bin/bash', 12:52:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9qEkaNJJg7/Listeners', 12:52:04 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 12:52:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:04 INFO - 'USER': 'cltbld', 12:52:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:04 INFO - 'XPC_FLAGS': '0x0', 12:52:04 INFO - 'XPC_SERVICE_NAME': '0', 12:52:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:52:04 INFO - Cleaning up... 12:52:04 INFO - Return code: 0 12:52:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:52: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')]} 12:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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')]} 12:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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', '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 0x100db7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e4c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb84958dc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1bd30>, '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 0x100a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d13b20>, '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.sgFXZ9PmRv/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.9qEkaNJJg7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 12:52: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:52: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 blobuploader==1.2.4 12:52:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sgFXZ9PmRv/Render', 12:52:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:04 INFO - 'HOME': '/Users/cltbld', 12:52:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:04 INFO - 'LOGNAME': 'cltbld', 12:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:04 INFO - 'MOZ_NO_REMOTE': '1', 12:52:04 INFO - 'NO_EM_RESTART': '1', 12:52:04 INFO - 'PAGER': '/bin/cat', 12:52:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:04 INFO - 'PWD': '/builds/slave/test', 12:52:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:04 INFO - 'SHELL': '/bin/bash', 12:52:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9qEkaNJJg7/Listeners', 12:52:04 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 12:52:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:04 INFO - 'USER': 'cltbld', 12:52:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:04 INFO - 'XPC_FLAGS': '0x0', 12:52:04 INFO - 'XPC_SERVICE_NAME': '0', 12:52:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:04 INFO - Downloading/unpacking blobuploader==1.2.4 12:52:04 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 12:52:04 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 12:52:04 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 12:52:04 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 12:52:04 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 12:52:04 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 12:52:08 INFO - Downloading blobuploader-1.2.4.tar.gz 12:52:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:52:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:52:08 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 12:52:08 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 12:52:08 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 12:52:08 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 12:52:08 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 12:52:08 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 12:52:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:52:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:52:08 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 12:52:08 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 12:52:08 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 12:52:08 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 12:52:08 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 12:52:08 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 12:52:09 INFO - Downloading docopt-0.6.1.tar.gz 12:52:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:52:09 INFO - Installing collected packages: blobuploader, requests, docopt 12:52:09 INFO - Running setup.py install for blobuploader 12:52:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:52:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:52:09 INFO - Running setup.py install for requests 12:52:10 INFO - Running setup.py install for docopt 12:52:10 INFO - Successfully installed blobuploader requests docopt 12:52:10 INFO - Cleaning up... 12:52:10 INFO - Return code: 0 12:52:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:10 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 0x100db7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e4c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb84958dc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1bd30>, '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 0x100a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d13b20>, '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.sgFXZ9PmRv/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.9qEkaNJJg7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 12:52:10 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 12:52:10 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 12:52:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sgFXZ9PmRv/Render', 12:52:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:10 INFO - 'HOME': '/Users/cltbld', 12:52:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:10 INFO - 'LOGNAME': 'cltbld', 12:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:10 INFO - 'MOZ_NO_REMOTE': '1', 12:52:10 INFO - 'NO_EM_RESTART': '1', 12:52:10 INFO - 'PAGER': '/bin/cat', 12:52:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:10 INFO - 'PWD': '/builds/slave/test', 12:52:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:10 INFO - 'SHELL': '/bin/bash', 12:52:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9qEkaNJJg7/Listeners', 12:52:10 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 12:52:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:10 INFO - 'USER': 'cltbld', 12:52:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:10 INFO - 'XPC_FLAGS': '0x0', 12:52:10 INFO - 'XPC_SERVICE_NAME': '0', 12:52:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:52:10 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Sr6KTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:52:10 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ayzS6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:52:10 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-kW3fSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:52:10 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-EXzBol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:52:11 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-SxWWZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:52:11 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ZTinTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:52:11 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-4OBTYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:52:11 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-eL2GmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:52:11 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-eB4S9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:52:11 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ECRErc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:52:11 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-8AfilA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:52:11 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-YLzNIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:52:11 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ihGjM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:52:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-__7SxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-CvSlD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:52:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ZA5xiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:52:12 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-HrZE6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:52:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:52:12 INFO - Running setup.py install for manifestparser 12:52:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:52:12 INFO - Running setup.py install for mozcrash 12:52:12 INFO - Running setup.py install for mozdebug 12:52:12 INFO - Running setup.py install for mozdevice 12:52:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:52:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:52:13 INFO - Running setup.py install for mozfile 12:52:13 INFO - Running setup.py install for mozhttpd 12:52:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:52:13 INFO - Running setup.py install for mozinfo 12:52:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:52:13 INFO - Running setup.py install for mozInstall 12:52:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:52:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:52:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:52:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:52:13 INFO - Running setup.py install for mozleak 12:52:13 INFO - Running setup.py install for mozlog 12:52:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:52:13 INFO - Running setup.py install for moznetwork 12:52:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:52:14 INFO - Running setup.py install for mozprocess 12:52:14 INFO - Running setup.py install for mozprofile 12:52:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:52:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:52:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:52:14 INFO - Running setup.py install for mozrunner 12:52:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:52:14 INFO - Running setup.py install for mozscreenshot 12:52:14 INFO - Running setup.py install for moztest 12:52:14 INFO - Running setup.py install for mozversion 12:52:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:52:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:52:14 INFO - Cleaning up... 12:52:15 INFO - Return code: 0 12:52:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52: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')]} 12:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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')]} 12:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:15 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 0x100db7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e4c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb84958dc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1bd30>, '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 0x100a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d13b20>, '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.sgFXZ9PmRv/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.9qEkaNJJg7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 12:52:15 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 12:52:15 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 12:52:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sgFXZ9PmRv/Render', 12:52:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:15 INFO - 'HOME': '/Users/cltbld', 12:52:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:15 INFO - 'LOGNAME': 'cltbld', 12:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:15 INFO - 'MOZ_NO_REMOTE': '1', 12:52:15 INFO - 'NO_EM_RESTART': '1', 12:52:15 INFO - 'PAGER': '/bin/cat', 12:52:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:15 INFO - 'PWD': '/builds/slave/test', 12:52:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:15 INFO - 'SHELL': '/bin/bash', 12:52:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9qEkaNJJg7/Listeners', 12:52:15 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 12:52:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:15 INFO - 'USER': 'cltbld', 12:52:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:15 INFO - 'XPC_FLAGS': '0x0', 12:52:15 INFO - 'XPC_SERVICE_NAME': '0', 12:52:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:52:15 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Myq4K5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:52:15 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)) 12:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:52:15 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-G5_L3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:52:15 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)) 12:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:52:15 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Btnc9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:52:15 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)) 12:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:52:15 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-rdO2cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:52:15 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)) 12:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:52:15 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-82oEWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:52:15 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)) 12:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:52:15 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-6Jpx6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:52:15 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)) 12:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:52:15 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-kCD6F_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:52:16 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)) 12:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:52:16 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-WyBldA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:52:16 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)) 12:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:52:16 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-EfsFFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:52:16 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)) 12:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:52:16 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-_XiALg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:52:16 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)) 12:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:52:16 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-SInsxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:52:16 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)) 12:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:52:16 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-BAXyBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:52:16 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)) 12:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:52:16 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-a7lgSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:52:16 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)) 12:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:52:16 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-wjCuEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:52:16 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)) 12:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:16 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-3gcrap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:16 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)) 12:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:52:16 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Q1dPl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:52:16 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)) 12:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:52:16 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Ab9NdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:52:17 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)) 12:52:17 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)) 12:52:17 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)) 12:52:17 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)) 12:52:17 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)) 12:52:17 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)) 12:52:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:19 INFO - Downloading blessings-1.6.tar.gz 12:52:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:52:19 INFO - Installing collected packages: blessings 12:52:19 INFO - Running setup.py install for blessings 12:52:19 INFO - Successfully installed blessings 12:52:19 INFO - Cleaning up... 12:52:19 INFO - Return code: 0 12:52:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:52:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:52:20 INFO - Reading from file tmpfile_stdout 12:52:20 INFO - Current package versions: 12:52:20 INFO - blessings == 1.6 12:52:20 INFO - blobuploader == 1.2.4 12:52:20 INFO - docopt == 0.6.1 12:52:20 INFO - functools32 == 3.2.3-2 12:52:20 INFO - jsonschema == 2.5.1 12:52:20 INFO - manifestparser == 1.1 12:52:20 INFO - mozInstall == 1.12 12:52:20 INFO - mozcrash == 0.17 12:52:20 INFO - mozdebug == 0.1 12:52:20 INFO - mozdevice == 0.48 12:52:20 INFO - mozfile == 1.2 12:52:20 INFO - mozhttpd == 0.7 12:52:20 INFO - mozinfo == 0.9 12:52:20 INFO - mozleak == 0.1 12:52:20 INFO - mozlog == 3.3 12:52:20 INFO - moznetwork == 0.27 12:52:20 INFO - mozprocess == 0.23 12:52:20 INFO - mozprofile == 0.28 12:52:20 INFO - mozrunner == 6.12 12:52:20 INFO - mozscreenshot == 0.1 12:52:20 INFO - mozsystemmonitor == 0.3 12:52:20 INFO - moztest == 0.7 12:52:20 INFO - mozversion == 1.4 12:52:20 INFO - psutil == 3.1.1 12:52:20 INFO - requests == 1.2.3 12:52:20 INFO - wsgiref == 0.1.2 12:52:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52:20 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')]} 12:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:20 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')]} 12:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:20 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 0x100db7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e4c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb84958dc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1bd30>, '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 0x100a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d13b20>, '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.sgFXZ9PmRv/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.9qEkaNJJg7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 12:52:20 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 12:52:20 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 12:52:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sgFXZ9PmRv/Render', 12:52:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:20 INFO - 'HOME': '/Users/cltbld', 12:52:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:20 INFO - 'LOGNAME': 'cltbld', 12:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:20 INFO - 'MOZ_NO_REMOTE': '1', 12:52:20 INFO - 'NO_EM_RESTART': '1', 12:52:20 INFO - 'PAGER': '/bin/cat', 12:52:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:20 INFO - 'PWD': '/builds/slave/test', 12:52:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:20 INFO - 'SHELL': '/bin/bash', 12:52:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9qEkaNJJg7/Listeners', 12:52:20 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 12:52:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:20 INFO - 'USER': 'cltbld', 12:52:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:20 INFO - 'XPC_FLAGS': '0x0', 12:52:20 INFO - 'XPC_SERVICE_NAME': '0', 12:52:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:20 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)) 12:52:20 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)) 12:52:20 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)) 12:52:20 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)) 12:52:20 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)) 12:52:20 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)) 12:52:20 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)) 12:52:20 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)) 12:52:20 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)) 12:52:20 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)) 12:52:20 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)) 12:52:20 INFO - Cleaning up... 12:52:20 INFO - Return code: 0 12:52:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:52:20 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')]} 12:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:20 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')]} 12:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:20 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 0x100db7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e4c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb84958dc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1bd30>, '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 0x100a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d13b20>, '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.sgFXZ9PmRv/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.9qEkaNJJg7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 12:52:20 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 12:52:20 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 12:52:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sgFXZ9PmRv/Render', 12:52:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:20 INFO - 'HOME': '/Users/cltbld', 12:52:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:20 INFO - 'LOGNAME': 'cltbld', 12:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:20 INFO - 'MOZ_NO_REMOTE': '1', 12:52:20 INFO - 'NO_EM_RESTART': '1', 12:52:20 INFO - 'PAGER': '/bin/cat', 12:52:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:20 INFO - 'PWD': '/builds/slave/test', 12:52:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:20 INFO - 'SHELL': '/bin/bash', 12:52:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9qEkaNJJg7/Listeners', 12:52:20 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 12:52:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:20 INFO - 'USER': 'cltbld', 12:52:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:20 INFO - 'XPC_FLAGS': '0x0', 12:52:20 INFO - 'XPC_SERVICE_NAME': '0', 12:52:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:52:21 INFO - Cleaning up... 12:52:21 INFO - Return code: 0 12:52:21 INFO - Running post-action listener: _resource_record_post_action 12:52:21 INFO - Running post-action listener: _start_resource_monitoring 12:52:21 INFO - Starting resource monitoring. 12:52:21 INFO - [mozharness: 2016-09-01 19:52:21.104409Z] Finished create-virtualenv step (success) 12:52:21 INFO - [mozharness: 2016-09-01 19:52:21.105387Z] Running install step. 12:52:21 INFO - Running pre-action listener: _resource_record_pre_action 12:52:21 INFO - Running main action method: install 12:52:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:52:21 INFO - Reading from file tmpfile_stdout 12:52:21 INFO - Detecting whether we're running mozinstall >=1.0... 12:52:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:52:21 INFO - Reading from file tmpfile_stdout 12:52:21 INFO - Output received: 12:52:21 INFO - Usage: mozinstall [options] installer 12:52:21 INFO - Options: 12:52:21 INFO - -h, --help show this help message and exit 12:52:21 INFO - -d DEST, --destination=DEST 12:52:21 INFO - Directory to install application into. [default: 12:52:21 INFO - "/builds/slave/test"] 12:52:21 INFO - --app=APP Application being installed. [default: firefox] 12:52:21 INFO - mkdir: /builds/slave/test/build/application 12:52:21 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'] 12:52:21 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 12:52:55 INFO - Reading from file tmpfile_stdout 12:52:55 INFO - Output received: 12:52:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:52:55 INFO - Running post-action listener: _resource_record_post_action 12:52:55 INFO - [mozharness: 2016-09-01 19:52:55.295539Z] Finished install step (success) 12:52:55 INFO - [mozharness: 2016-09-01 19:52:55.295668Z] Running run-tests step. 12:52:55 INFO - Running pre-action listener: _resource_record_pre_action 12:52:55 INFO - Running main action method: run_tests 12:52:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:52:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:52:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:52:55 INFO - 2016-09-01 12:52:55.310 screenresolution[1651:7413] starting screenresolution argv=screenresolution get 12:52:55 INFO - 2016-09-01 12:52:55.313 screenresolution[1651:7413] Display 0: 1600x1200x32@60 12:52:55 INFO - 2016-09-01 12:52:55.318 screenresolution[1652:7415] starting screenresolution argv=screenresolution list 12:52:55 INFO - Available Modes on Display 0 12:52:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:52:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:52:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:52:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:52:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:52:55 INFO - Intel Iris: 12:52:55 INFO - Chipset Model: Intel Iris 12:52:55 INFO - Type: GPU 12:52:55 INFO - Bus: Built-In 12:52:55 INFO - VRAM (Dynamic, Max): 1536 MB 12:52:55 INFO - Vendor: Intel (0x8086) 12:52:55 INFO - Device ID: 0x0a2e 12:52:55 INFO - Revision ID: 0x0009 12:52:55 INFO - Displays: 12:52:55 INFO - Display: 12:52:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:52:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:52:55 INFO - Display Serial Number: 1600x1200 60 12:52:55 INFO - Main Display: Yes 12:52:55 INFO - Mirror: Off 12:52:55 INFO - Online: Yes 12:52:55 INFO - Rotation: Supported 12:52:55 INFO - Return code: 0 12:52:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:52:55 INFO - Python 2.7.3 12:52:55 INFO - Return code: 0 12:52:55 INFO - grabbing minidump binary from tooltool 12:52:55 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')]} 12:52:55 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 0x100d1bd30>, '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 0x100a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d13b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:52:55 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 12:52:55 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 12:52:55 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 12:52:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:52:55 INFO - Return code: 0 12:52:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:52:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:52:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:52:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:52:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:52:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 12:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0235 --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 12:52:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sgFXZ9PmRv/Render', 12:52:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:55 INFO - 'HOME': '/Users/cltbld', 12:52:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:55 INFO - 'LOGNAME': 'cltbld', 12:52:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:52:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:55 INFO - 'MOZ_NO_REMOTE': '1', 12:52:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:52:55 INFO - 'NO_EM_RESTART': '1', 12:52:55 INFO - 'PAGER': '/bin/cat', 12:52:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:55 INFO - 'PWD': '/builds/slave/test', 12:52:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:52:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:55 INFO - 'SHELL': '/bin/bash', 12:52:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9qEkaNJJg7/Listeners', 12:52:55 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 12:52:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:55 INFO - 'USER': 'cltbld', 12:52:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:55 INFO - 'XPC_FLAGS': '0x0', 12:52:55 INFO - 'XPC_SERVICE_NAME': '0', 12:52:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 12:52:55 INFO - mozversion application_buildid: 20160901094721 12:52:55 INFO - mozversion application_changeset: 52851295b34fa7471a1a7b7a7123fa3a68eacc40 12:52:55 INFO - mozversion application_display_name: Nightly 12:52:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:52:55 INFO - mozversion application_name: Firefox 12:52:55 INFO - mozversion application_remotingname: firefox 12:52:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:52:55 INFO - mozversion application_vendor: Mozilla 12:52:55 INFO - mozversion application_version: 51.0a1 12:52:55 INFO - mozversion platform_buildid: 20160901094721 12:52:55 INFO - mozversion platform_changeset: 52851295b34fa7471a1a7b7a7123fa3a68eacc40 12:52:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:52:55 INFO - mozversion platform_version: 51.0a1 12:52:55 INFO - using testdate: 1472759575 12:52:55 INFO - actual date: 1472759575 12:52:55 INFO - starting webserver on 'localhost:49267' 12:52:55 INFO - SUITE-START | Running 2 tests 12:52:55 INFO - TEST-START | dromaeo_css 12:52:55 INFO - operating with platform_type : mac_ 12:52:55 INFO - Initialising browser for dromaeo_css test... 12:52:55 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpUV8xJa/profile http://localhost:49267/getInfo.html) 12:52:58 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 12:52:58 INFO - PROCESS | 1662 | colorDepth:24 12:52:58 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 12:52:58 INFO - PROCESS | 1662 | __metrics 12:52:58 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 12:52:59 INFO - TEST-INFO | 1662: exit 0 12:52:59 INFO - Browser initialized. 12:52:59 INFO - Running cycle 1/1 for dromaeo_css test... 12:52:59 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpUV8xJa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:53:11 INFO - PROCESS | 1666 | RSS: Main: 245121024 12:53:11 INFO - PROCESS | 1666 | 12:54:01 INFO - PROCESS | 1666 | 1472759641208 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] 12:56:14 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 12:56:15 INFO - PROCESS | 1666 | RSS: Main: 263319552 12:56:15 INFO - PROCESS | 1666 | 12:59:17 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 12:59:18 INFO - PROCESS | 1666 | RSS: Main: 267538432 12:59:18 INFO - PROCESS | 1666 | 13:02:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 13:02:21 INFO - PROCESS | 1666 | RSS: Main: 278528000 13:02:21 INFO - PROCESS | 1666 | 13:05:22 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 13:05:23 INFO - PROCESS | 1666 | RSS: Main: 274980864 13:05:23 INFO - PROCESS | 1666 | 13:08:26 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 13:08:27 INFO - PROCESS | 1666 | RSS: Main: 281534464 13:08:27 INFO - PROCESS | 1666 | 13:11:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 13:11:30 INFO - PROCESS | 1666 | RSS: Main: 283193344 13:11:30 INFO - PROCESS | 1666 | 13:11:30 INFO - PROCESS | 1666 | __start_tp_report 13:11:30 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 13:11:30 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 13:11:30 INFO - PROCESS | 1666 | |i|pagename|runs| 13:11:30 INFO - PROCESS | 1666 | |0;dojo.html;2713.294543418711;3446.74149438792;3467.774594651349;3471.2883858808937;3506.6493350664937;5783.5951483396175;5857.941420585798;5875.471207591316;5911.793087241947;5959.225300710901;5701.173329867167;5894.997850365437;5906.793262235823;5987.40125987401;6036.517078633709;5265.65773224741;5311.521963023327;5411.485908838654;5439.238506609078;5467.562594992411;5347.946520534803;5487.6981766002855;5489.231507588941;5512;5518.475744804237;4061.390791381287;4242.448481697391;5272.156454967225;5381.784728610851;5445.9727701361435;5232.110541208004;5234.97382513085;5283.28675628789;5324.680519168824;5418.647787893774;4309.504406993205;4838.540338667821;5015.498450154992;5247.16045432729;5259.2899958505495;4872.878178045542;5102.413222479426;5383.865403364908;5793.913091303634;5835.328937172195;5031.974840125776;5607.523360514361;6034.215551978258;6296.401841825065;6338;6339.746410143634;6385.138006369127;6390.233172019341;6397.744090236385;6403.967980160116;5785.739641716175;5987.2815262168815;6031;6052.515798736091;6076.939230607682;6486.318936511692;6491.967540162269;6499.8700025999215;6518.967405162944;6523.64119973406;6305.747770089145;6305.873882522324;6350.110984462179;6353.555251132469;6372.872542549216;6254.874902502015;6263.217097862767;6292.685365731695;6312.400321969406;6364.649944253018;6215.471684906744;6286.937130628727;6330.208723909512;6335.524835637253;6354.983202687547;6012.158297838306;6260.373962603703;6294.590851594632;6296.5592408530965;6321.304656487782;4889.2910527973245;4911.18965370717;4940.530649588283;5062.962092770973;5070.391553013662;4356.215881141362;4397.1205758848355;4416.977915110404;4475.283954567253;4477.417935668343;5513;5850.9414905851245;5869;5893.499052580493;5918.674472904032;6224.564280500412;6272.5922815016875;6286.465650419766;6305.747770089145;6330.715117819709;6070.453659170696;6123.374132580074;6128.811800681408;6129.14485165794;6135.998322733915;5589.413111623302;5598.97200514003;5620.4660557247;5621.80323688669;5626.24045753818;6364.64994425311;6464.22429308486;6590.901136482957;6602.735890564323;6621.735130594819;5563.833085007456;5594.440555944373;6336.619802811846;6382.68086595659;6397.96801015992;6535.836604084936;6544.5418820684;6608.7356505739235;6623.569467984566;6647.634380109141;5751.971240143773;6215.912215362384;6231.3145553988115;6235;6356.618602883842;4969.875753106201;6041.365656606169;6282.1519094921605;6365.681715914278;6419.646919419477;6254.3745625437095;6280.654563998841;6292.339304372975;6315.905261421174;6329.841753956188;6135.692037377249;6142.437386315837;6256.186695729526;6284.748610055546;6312.400321969406;5100.775813804735;6105.490073363178;6115.908261376172;6123.404636889863;6218.502519798315;5279.815206467755;6275.278342990432;6299.527535434952;6305.653189074645;6316.084167795736;6084.8783024340155;6109.266887973472;6222.844428889314;6234.532410069172;6239.438450539473 13:11:30 INFO - PROCESS | 1666 | |1;ext.html;487.4516169309527;519.5687579309172;521.0984995956996;542.7245971965881;572.5448268626442;38272.61727382725;40525.78422647322;40598;40617.7969110154;40710.38934415983;40417.78746637605;40944.59055409445;40970;41173.58826411735;41189;9678.951605241964;9797.706068817912;9880.802383952318;9897.703068907944;9914.702558923207;9749.658761943334;9778.07108324708;9904.95047524765;9905.702828915108;9925.106740393363;9850.90149098507;9857.802843943116;9884.357516761387;9906.20750339971;9956.900430995669;9781.217502599811;9848;9883.357581757235;9888.505574721306;9906.950465247699;9797.657082002166;9872.60509579616;9876.703698888972;9901.504924753734;9919.603215871357;39631.8018409909;39946.60053399458;40119;40148.598514014775;40155.19689606191;3304.454764963778;3356.1441832332844;3381.4927760835826;3542.1498840278405;3847.1728578355787;30327.24181895448;30485.847570762227;30691.693083069105;30735.846320768476;31917.882874099294;3171.444997125494;3225.8870939517237;3240.4329242382487;3248.951265731016;3315.3037862049;532043;533363;537598;539354;542739.999999996;61541.07688384678;61783;61840.07239891405;61909;62324;33742.8312858439;34927.476087858704;34937.65062349395;64753.67623161854;65256.02115968264;16507.587310317096;16670.916390434584;16692.582685432717;16698.415555455744;16747.497575072768;12717.55488557896;12882.9355853222;12887.226766394046;12902;12909.741805164032;18964.52588685266;19034.714479282822;19038.381737552187;19094.61810763805;19151.52121196981;7779.3776497880035;7956.363490920712;7990.9200907991335;8014.839703205903;8037.879431808527;955.7037318431309;961.8701475300885;1017.9287449878437;1026.7176526455285;1049.632628579991;24630.261092167264;28928;29763;30447.695523044928;30511.237219069702;871.9825603487894;1027.9486025698686;1054.2514814481651;1085.5386460754148;1137.9487923043482;14865.777013344808;15562.455314063953;15690.058596484247;15782.053076815428;15860.127692976766;605814;647772;651310;660158;697365;56875.71562142163;56969.14546281809;57129.714351427974;57463;57878.421215787304;1188.8870557297216;1328.7076843094696;1364.201941864001;1381.2886363522794;1385.6397336692532;29745.70254297516;29773.702262977095;29940.850295748383;30238.54642180413;30981;49610.75973100701;49618.751906240235;49701;49788;49789.751051244515;487763;598945;600524;600608;601420.8934329855;26133.60799588046;26366.73633263643;26561.734382656698;26629.20112396631;26638.334041648337;46878.06243875172;46893.2966005517;47228.58314250578;47801.28298075462;48356;38358.80820595879;38787.41818872776;38869.61130388773;39329.60670393259;40174.397384038675;29421.85289073541;29597.852010739807;35121.297574048884;39749;39929.00177495586;32094.19764505906;37562.06094847651;38074.23851523009;38596;38838;30960.845195773876;33734;33925.66074339225;34198;34345.96962091141;21228.044737986518;24319.392015199053;24948.37629059288;25080.122195723063;25484.362890927874 13:11:30 INFO - PROCESS | 1666 | |2;jquery.html;314.8740503798481;374.5374462538765;378.39079082676886;388.4076782906066;404.6014675544588;18071.548211294725;19265.133069011892;20351.694724579123;20389.431849426328;20579.38261852143;19952.70070948937;20315.898420507878;20317.59364812703;20347.491312717153;20916.8954155229;5909.143174239754;5926.081457374103;6116.908246376308;6173.012318029117;6179.351168127349;6070.1501789749245;6142.785002524913;6152.323244443108;6173.444390004921;6183.19618449601;5600.915986260209;5868.501177399926;5946.316173640022;6050.667213303266;6109.5723299369065;5903.822885313426;5911.852203694899;5939;5942.3760505146765;5961.940380596182;5612.326520817487;5818.912716309259;5835.533157347402;5875.089361148986;5890.322612899528;12881.291528965903;12906.612801615967;12992.805107923388;13054.412551435209;13149.21104733719;2130.957380852374;2176.978230217709;2205.7794220577975;2223.944401389962;2912.4757543642136;9804.31369804114;9821.852672209923;9896.960819113961;10298.948505257425;10342.689719308433;1830.8443782278523;1877.239717914247;1913.8038725796378;1938.3118992757509;1938.505681051337;114879;119355;122675;123119;126825;11225.326480411202;11268.028095083328;11590.536378544764;11671.708207294885;11728.589499367652;14067.507637232853;14339.211343376215;14342.139471631526;14348.995570309979;14375.496857609933;8063.637136328879;8365.1216622255;8502.957485212659;8587.742367728979;8620.181082797124;7076.575405475688;8593.44142630727;8603.741887743377;8752.912470875337;8765.912340876637;3550.9644903551152;4401.6478681705385;4498.325251212279;4512.842050528216;4543.931841022388;1891.1584344966634;1901.4580844459263;1920.7995003123049;1952.248384372027;1954.6188493243965;634.4448607468465;817.689278074328;858.356232825381;900.4057322167469;917.6879860847343;16589.585260368345;19192.808071919382;20473.692894606593;21278.78721212768;21412.464688382915;899.6221586933503;945.664289177346;975.2393133355852;980.666573365045;1019.8317277649253;9353.485558294224;10839.187060970458;11291.322520648788;11322.37726925027;11330.206885518099;572539.1373043108;574692;578405;585581.0720946369;585633;96276.55585166228;121498;124519;130135.34932325468;133131;832.1595188859175;938.432248489654;979.4808751361932;989.4557993103764;994.7068810546261;18199.999000055122;18585.535361615526;18626;18666.533336666693;18828.905855470635;38506.422403663404;49821.754456138886;52322.476775231764;56036.719816402285;56255;81350.59324703338;81828.59085704772;82094;83565;84074;7186.993820865187;7816.140224575406;8010.799730006564;8017.797330400486;8107.351411887153;9261.490618016074;12593.874061259638;12817.807732883828;12930.935345323212;13029.934850325688;9075.909240907771;10867.424223487393;11027.889721103007;11313.490892909675;11346.149038822286;10446.843297350393;10676.252662313564;10811.729706757395;10978.560857565928;11116.11071114325;11344.9432752839;11516.884831151916;11533.366989398313;11603.419829008684;11618.70953226176;7996.24035716606;8063.596820159086;8084.989376327959;8165.877511837446;8210.794730131794;8318.584070796556;11353.48909299067;11590.246633968765;11777.175597708077;11831.881681183422 13:11:30 INFO - PROCESS | 1666 | |3;mootools.html;1511.2066165263238;1546.8607825295721;1588.3884704388806;1767.964640707186;1901.591157901051;8068.475549089319;8651.351148663853;8707.259882909944;9159.862602060974;9174.678886238982;8648.091950345217;8828.161324674145;8836.823263534725;8848.469091854493;8876.245519130865;2316.652502124682;2337.8947947342413;2353.9411514712097;2357.669926210332;2359.421941624296;2331.277304035746;2388.3312672451743;2413.794827439661;2414.0223209600053;2417.0331867253153;2309.261036468331;2356.7643235676464;2360.634101714237;2375.7861792438675;2403.134871446278;2348.6829278047417;2363.6572696959015;2374.966889403115;2385.0936644075314;2389.1757343716304;2361.5513052520137;2368.6683864259016;2378.3340664613934;2383.547126046046;2384.940376490584;8929.508877011762;8986.640534378617;8986.955065224698;8991.55042247885;9005.50469724165;4187.72779769314;4838.564529192389;5324.174752913266;5415.350157981028;5431.701256430894;3055.4041961817456;3621.442779604769;3666.9083272918124;3697.2235830475634;3701.167237371597;899.3524662243175;958.9232861371073;1057.3972835483778;1076.6716151573767;1108.661858133269;8643;11053.502592383362;11476.655700329004;11785.410729463492;11799.705007374885;4583.793729282191;4714.882127946828;4789.066132104206;4844.079624871263;4852.393450818648;9887.209023278265;9895.406275623485;10006.849897251546;10050.899491005142;10061.597536098621;5381.461853814587;5385.272988146628;5391.110466773017;5404.594655400861;5408.432114627907;4440.4227450431235;4743.335932969387;4849.248366503198;4905.362302900671;4970.3290055842;3324.634290228073;3385.9661403386144;3842.51968503937;3948.565657777642;4041.515018197835;1248.1637303007008;1293.4502836294537;1300.694336830844;1300.7918733002675;1304.5108084468325;747.2228881962807;857.3098655582191;891.2647066170435;907.4918045894188;943.0428115462811;5733.168690539848;5750.913736293959;5778.162166485836;5804.6807425592;6031.185789918392;895.9462432254086;917.2249449215402;938.4088024544493;940.3605548227134;942.6983365323031;3351.9832400838327;3819.427085937132;3838.865639702597;3859.2474467478573;3951.308521008812;10625.415602141802;10719;10948.945255273673;10984.835227471594;11008.724781880517;10362.637307694195;10787.514561844735;10827.566897324177;10871.402072885909;10958.671239862817;8121.309688676529;8385.748427547062;8393.95803020981;8402.495850249004;8412.495250285003;5384.757685904222;5854.677992710442;5892.734826932884;5997.16039754426;6027.909581356195;10004.049615286536;10234;10245.129164021142;10253.33353332031;10299.948500257451;8597.226249637562;10324.48377581103;10403.739906502398;10516.789664206826;10523.526441310312;6041.818745437644;7357.448191385561;7561.09266887977;7571.432142589218;7713.382929365525;8363.372747043873;8425.115362886809;8479.109693482096;8525.616347264264;8564.871526926976;7404.740834070782;7415;7565.356944659766;7656.042994625672;7673.577953212627;7302;7463.701451941862;7470.551766894004;7558.093028836574;7637.541747495168;6984.825379365353;7118;7118.60847653384;7126.964365178348;7128.786136415708;4800.831970881002;4863.197572400656;4907.312976183266;4979.228219625964;4994.850154495371;4880.414350277847;4940.92588611164;5052.393712754346;5124.666896651705;5146.330976972969 13:11:30 INFO - PROCESS | 1666 | |4;prototype.html;271.0796844712202;303.29332654914055;310.4969948683133;312.67794172002846;323.3500663666031;4063.7358571692857;4511.932321015187;4559.703619264746;5050.46970068143;5403.2705584746045;5145.871353216162;5614.613789139609;5623.775048998045;5627.7467513961865;5660.688662123592;3523.682868541831;3978.4430179774854;4085.142120154771;4241.851535196269;4285.528591854902;3808.219315040424;3841.5966323535904;3899.902502437433;3983.063979964706;4276.059266961263;4139.3997870308785;4157.334826427772;4169.62473377396;4185.330347144458;4188;3812.4853144825647;3986.063275130342;4136.855210067648;4145.176122506087;4196.426340122454;3064.356485138124;3576.6423357664285;3607.1162565171703;3613.1328481164596;3629.1834337273904;4188.832446702128;5298.761555730001;5464.617476776588;5488.670679759227;5520.537057679718;4008.398740188966;4393.406890069831;4755.548222918817;4814.592703648176;4851.587615052725;4849.587785038276;4979.651424400294;5712.914306285409;5988.670623115727;6011.489023433013;3619.3170175868086;3776.169242766587;3938.8971088095377;3946.1515774108416;3989.5412027616617;5348.53967175096;6255.437010669016;6275.901717199472;6302.46429053531;6325.905111423286;3032;3187.6812318768402;3659.408157451517;3666.944995825065;3850.729259344466;3701.4262789267705;3836;3843;4075.2053349596545;4086.7139300248696;4445.866624001285;4562.133194692998;4784.9233922367885;4788.449328327218;4844.432450801081;4738.502457242009;5703.600747947687;5808.941910580925;5962.612430192024;5984.581079324405;1277.2145130744711;1277.7252890628558;1303.5176984515601;1377.8415482219673;1389.4025569005425;782.4718315137374;807.894973653433;870.5038128266954;900.6487469886749;923.819855128257;5531.972340138354;5552.7778888844805;5552.805651802168;5558.72149405639;5634.60557760961;5520.861978450491;5668.744906479218;5727.770889164387;6046.788362407295;6089.442434177656;4692.058670716615;5089.88263259541;5322.042032434199;5453.918191227135;5470.56235501159;2285.622872226064;2633.117321115373;2672.492226476963;2674.8127631066027;2719.442514284567;4689.780657029197;4816.95183048165;5191.818286360035;5279.442564443499;5300.416954135042;4267;5251.36983561975;5625.38120806711;5742.138679198154;6353.682315884187;5376.489233522809;5572.08060669993;5572.247746554325;6116.3883611638485;6369.172007638977;5280.81517146898;5800.796972105956;6161.44546990773;6193.389718673267;6282.403171698681;5981.760729570942;6004.1687285378375;6040.607360521552;6060.90908636362;6087.269527656709;5529.612927095065;6361.491080713439;6376.681165941592;6408.166938297992;6464.0607817655455;3867.5358956925347;3905.5159039564783;3977.164795393;3992.0419099416513;4043.130726893732;4783.282507623745;5878.559108066997;6065.7573697053385;6080.3615620361;6146.78486252979;5148.6910785353;5620.74706638194;5959.91060134107;5967.045272756338;5999;4520.254158063883;4634.933965188093;4964.925526117184;5409.29679141709;5911.054231322968;5499.532539734168;5774.509166720875;5799.449052340021;5803.651780892991;5816.970915145397;5694.487496125369;5849.239598852292;5929.762809487572;5980.37206093354;5998.310194327708;4638.605718513964;5146.989011428356;5190.688558686491;5717.342505611908;5804.622699524517 13:11:30 INFO - PROCESS | 1666 | |5;yui.html;659.5383231737785;690.7893092606755;704.3238491048593;713.7180813578636;821.1542111625026;12151.878481215184;15686.921565392156;16046.197690115478;16211.594710132224;16253.349866005361;14774.482893098744;14892.255387230622;14935.178565178938;14944.178070206135;14945.626359341022;846.238385453091;859.0764927702713;862.8576284913013;864.3128712673408;864.9264812490945;687.4569090418588;854.4232642965973;875.995620021899;882.5234373438335;889.7997950461126;873.4191762477944;906.2206502407923;917.591671706091;918.536139249678;919.429953428875;891.5319457284912;910.3218102513637;911.4440191483224;911.6535716427782;915.4553040940697;669.4945316286221;679.2935347238865;680.8910574308087;682.8566001139767;684.4319215051495;15126.697466050728;15156.621084472867;15169.24153792306;15208.847911520854;15215.087094774239;14559.3448294827;14692.26538673062;14721.852781472262;14798.556043318718;14899.478518251917;11819.704507387298;12034.69913252167;12061.276323420623;12065.517379304818;12319.93840030803;3782.1490164712995;3832.7317087803863;3842.692584593226;3945.6448919597374;3949.3681011038384;97395;126730.3663481686;128396.88856005915;129282.35358823146;129557;9466.857997130048;9482.882392256823;9629.711108666752;9782.75543111428;9906.55420506079;22423.55152896933;22452.32643020712;22578.774212257667;22685.2060177893;22716.545669086856;8000.039995200613;8037.276645101969;8162.428629995962;8193.631286592117;8283.37874659403;4449.955500444954;4463.4420697412825;4511.458624965026;4521.163584736834;4594.839180628729;3156.71589556941;3583.480395342661;3720.1443667956523;3726.1802403471193;3744.625537446288;640.5420124610926;652.1489456259627;677.478341676906;678.7556479667315;679.7858674517511;644.7549931026274;655.8360409897525;659.3604203922188;664.8836453620597;665.8435267712084;9081.091890810998;9228.307876909259;9380.108889655472;9659.227261819038;9681.612735490642;617.4837537036594;635.3487675132933;661.6956200147889;663.2041550139852;705.340506626306;3923.665953575798;4140.834366625301;4614.630829533629;4700.435947686231;4700.858974230779;109741;150962.24518877335;173193;173950;176920;118796.40601796936;122004;148667;150959;154152;128445;128805;129292;129429.35285323701;133856;6997.113566238597;8434.662613495391;8668.436551624125;8992.775180620536;9264.629414823332;36284;36284.81857590801;53410.93178136493;59905.10142347955;60741.78516429558;86318.56840715757;89232;89903;92776.53611731899;94692;10584.417857017937;12937.148082437529;13151.736965260832;13207.339633018502;13257.602271931857;12694.238345699288;14396.064255823338;14837.84363725285;14954;15219.315130818919;10822.51298691545;13195.538156164488;13263.535776247785;13373.866261337262;13440.529581464993;13593.660158496117;13720.313984300945;13752.381142848795;14036.578902632937;14059.789103163665;13423.597292081253;13463.192208467523;13811.240381779098;14121.646958826112;14273.57179284623;9775.364601300893;9929.453880036379;10564.260501764802;11007.065548704266;11435.199536032398;8797.47215167092;10333.328333658288;10531.473426328806;11578.94210528942;11583.8262426062 13:11:30 INFO - PROCESS | 1666 | __end_tp_report 13:11:30 INFO - PROCESS | 1666 | __start_cc_report 13:11:30 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,384 13:11:30 INFO - PROCESS | 1666 | __end_cc_report 13:11:30 INFO - PROCESS | 1666 | __startTimestamp1472760690171__endTimestamp 13:11:30 INFO - PROCESS | 1666 | 13:11:30 INFO - PROCESS | 1666 | ------- Summary: start ------- 13:11:30 INFO - PROCESS | 1666 | Number of tests: 6 13:11:30 INFO - PROCESS | 1666 | 13:11:30 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5808.38 Median:6084.88 stddev:724.68 (11.9%) stddev-sans-first:685.03 13:11:30 INFO - PROCESS | 1666 | Values: 2713.3 3446.7 3467.8 3471.3 3506.6 5783.6 5857.9 5875.5 5911.8 5959.2 5701.2 5895.0 5906.8 5987.4 6036.5 5265.7 5311.5 5411.5 5439.2 5467.6 5347.9 5487.7 5489.2 5512.0 5518.5 4061.4 4242.4 5272.2 5381.8 5446.0 5232.1 5235.0 5283.3 5324.7 5418.6 4309.5 4838.5 5015.5 5247.2 5259.3 4872.9 5102.4 5383.9 5793.9 5835.3 5032.0 5607.5 6034.2 6296.4 6338.0 6339.7 6385.1 6390.2 6397.7 6404.0 5785.7 5987.3 6031.0 6052.5 6076.9 6486.3 6492.0 6499.9 6519.0 6523.6 6305.7 6305.9 6350.1 6353.6 6372.9 6254.9 6263.2 6292.7 6312.4 6364.6 6215.5 6286.9 6330.2 6335.5 6355.0 6012.2 6260.4 6294.6 6296.6 6321.3 4889.3 4911.2 4940.5 5063.0 5070.4 4356.2 4397.1 4417.0 4475.3 4477.4 5513.0 5850.9 5869.0 5893.5 5918.7 6224.6 6272.6 6286.5 6305.7 6330.7 6070.5 6123.4 6128.8 6129.1 6136.0 5589.4 5599.0 5620.5 5621.8 5626.2 6364.6 6464.2 6590.9 6602.7 6621.7 5563.8 5594.4 6336.6 6382.7 6398.0 6535.8 6544.5 6608.7 6623.6 6647.6 5752.0 6215.9 6231.3 6235.0 6356.6 4969.9 6041.4 6282.2 6365.7 6419.6 6254.4 6280.7 6292.3 6315.9 6329.8 6135.7 6142.4 6256.2 6284.7 6312.4 5100.8 6105.5 6115.9 6123.4 6218.5 5279.8 6275.3 6299.5 6305.7 6316.1 6084.9 6109.3 6222.8 6234.5 6239.4 13:11:30 INFO - PROCESS | 1666 | 13:11:30 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:71341.62 Median:39937.80 stddev:158352.39 (396.5%) stddev-sans-first:158707.25 13:11:30 INFO - PROCESS | 1666 | Values: 487.5 519.6 521.1 542.7 572.5 38272.6 40525.8 40598.0 40617.8 40710.4 40417.8 40944.6 40970.0 41173.6 41189.0 9679.0 9797.7 9880.8 9897.7 9914.7 9749.7 9778.1 9905.0 9905.7 9925.1 9850.9 9857.8 9884.4 9906.2 9956.9 9781.2 9848.0 9883.4 9888.5 9907.0 9797.7 9872.6 9876.7 9901.5 9919.6 39631.8 39946.6 40119.0 40148.6 40155.2 3304.5 3356.1 3381.5 3542.1 3847.2 30327.2 30485.8 30691.7 30735.8 31917.9 3171.4 3225.9 3240.4 3249.0 3315.3 532043.0 533363.0 537598.0 539354.0 542740.0 61541.1 61783.0 61840.1 61909.0 62324.0 33742.8 34927.5 34937.7 64753.7 65256.0 16507.6 16670.9 16692.6 16698.4 16747.5 12717.6 12882.9 12887.2 12902.0 12909.7 18964.5 19034.7 19038.4 19094.6 19151.5 7779.4 7956.4 7990.9 8014.8 8037.9 955.7 961.9 1017.9 1026.7 1049.6 24630.3 28928.0 29763.0 30447.7 30511.2 872.0 1027.9 1054.3 1085.5 1137.9 14865.8 15562.5 15690.1 15782.1 15860.1 605814.0 647772.0 651310.0 660158.0 697365.0 56875.7 56969.1 57129.7 57463.0 57878.4 1188.9 1328.7 1364.2 1381.3 1385.6 29745.7 29773.7 29940.9 30238.5 30981.0 49610.8 49618.8 49701.0 49788.0 49789.8 487763.0 598945.0 600524.0 600608.0 601420.9 26133.6 26366.7 26561.7 26629.2 26638.3 46878.1 46893.3 47228.6 47801.3 48356.0 38358.8 38787.4 38869.6 39329.6 40174.4 29421.9 29597.9 35121.3 39749.0 39929.0 32094.2 37562.1 38074.2 38596.0 38838.0 30960.8 33734.0 33925.7 34198.0 34346.0 21228.0 24319.4 24948.4 25080.1 25484.4 13:11:30 INFO - PROCESS | 1666 | 13:11:30 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:34040.08 Median:376.46 stddev:96933.50 (25748.4%) stddev-sans-first:97172.34 13:11:30 INFO - PROCESS | 1666 | Values: 314.9 374.5 378.4 388.4 404.6 18071.5 19265.1 20351.7 20389.4 20579.4 19952.7 20315.9 20317.6 20347.5 20916.9 5909.1 5926.1 6116.9 6173.0 6179.4 6070.2 6142.8 6152.3 6173.4 6183.2 5600.9 5868.5 5946.3 6050.7 6109.6 5903.8 5911.9 5939.0 5942.4 5961.9 5612.3 5818.9 5835.5 5875.1 5890.3 12881.3 12906.6 12992.8 13054.4 13149.2 2131.0 2177.0 2205.8 2223.9 2912.5 9804.3 9821.9 9897.0 10298.9 10342.7 1830.8 1877.2 1913.8 1938.3 1938.5 114879.0 119355.0 122675.0 123119.0 126825.0 11225.3 11268.0 11590.5 11671.7 11728.6 14067.5 14339.2 14342.1 14349.0 14375.5 8063.6 8365.1 8503.0 8587.7 8620.2 7076.6 8593.4 8603.7 8752.9 8765.9 3551.0 4401.6 4498.3 4512.8 4543.9 1891.2 1901.5 1920.8 1952.2 1954.6 634.4 817.7 858.4 900.4 917.7 16589.6 19192.8 20473.7 21278.8 21412.5 899.6 945.7 975.2 980.7 1019.8 9353.5 10839.2 11291.3 11322.4 11330.2 572539.1 574692.0 578405.0 585581.1 585633.0 96276.6 121498.0 124519.0 130135.3 133131.0 832.2 938.4 979.5 989.5 994.7 18200.0 18585.5 18626.0 18666.5 18828.9 38506.4 49821.8 52322.5 56036.7 56255.0 81350.6 81828.6 82094.0 83565.0 84074.0 7187.0 7816.1 8010.8 8017.8 8107.4 9261.5 12593.9 12817.8 12930.9 13029.9 9075.9 10867.4 11027.9 11313.5 11346.1 10446.8 10676.3 10811.7 10978.6 11116.1 11344.9 11516.9 11533.4 11603.4 11618.7 7996.2 8063.6 8085.0 8165.9 8210.8 8318.6 11353.5 11590.2 11777.2 11831.9 13:11:30 INFO - PROCESS | 1666 | 13:11:30 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5715.51 Median:4871.81 stddev:3219.40 (66.1%) stddev-sans-first:3212.93 13:11:30 INFO - PROCESS | 1666 | Values: 1511.2 1546.9 1588.4 1768.0 1901.6 8068.5 8651.4 8707.3 9159.9 9174.7 8648.1 8828.2 8836.8 8848.5 8876.2 2316.7 2337.9 2353.9 2357.7 2359.4 2331.3 2388.3 2413.8 2414.0 2417.0 2309.3 2356.8 2360.6 2375.8 2403.1 2348.7 2363.7 2375.0 2385.1 2389.2 2361.6 2368.7 2378.3 2383.5 2384.9 8929.5 8986.6 8987.0 8991.6 9005.5 4187.7 4838.6 5324.2 5415.4 5431.7 3055.4 3621.4 3666.9 3697.2 3701.2 899.4 958.9 1057.4 1076.7 1108.7 8643.0 11053.5 11476.7 11785.4 11799.7 4583.8 4714.9 4789.1 4844.1 4852.4 9887.2 9895.4 10006.8 10050.9 10061.6 5381.5 5385.3 5391.1 5404.6 5408.4 4440.4 4743.3 4849.2 4905.4 4970.3 3324.6 3386.0 3842.5 3948.6 4041.5 1248.2 1293.5 1300.7 1300.8 1304.5 747.2 857.3 891.3 907.5 943.0 5733.2 5750.9 5778.2 5804.7 6031.2 895.9 917.2 938.4 940.4 942.7 3352.0 3819.4 3838.9 3859.2 3951.3 10625.4 10719.0 10948.9 10984.8 11008.7 10362.6 10787.5 10827.6 10871.4 10958.7 8121.3 8385.7 8394.0 8402.5 8412.5 5384.8 5854.7 5892.7 5997.2 6027.9 10004.0 10234.0 10245.1 10253.3 10299.9 8597.2 10324.5 10403.7 10516.8 10523.5 6041.8 7357.4 7561.1 7571.4 7713.4 8363.4 8425.1 8479.1 8525.6 8564.9 7404.7 7415.0 7565.4 7656.0 7673.6 7302.0 7463.7 7470.6 7558.1 7637.5 6984.8 7118.0 7118.6 7127.0 7128.8 4800.8 4863.2 4907.3 4979.2 4994.9 4880.4 4940.9 5052.4 5124.7 5146.3 13:11:30 INFO - PROCESS | 1666 | 13:11:30 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4627.06 Median:5169.69 stddev:1488.14 (28.8%) stddev-sans-first:1455.96 13:11:30 INFO - PROCESS | 1666 | Values: 271.1 303.3 310.5 312.7 323.4 4063.7 4511.9 4559.7 5050.5 5403.3 5145.9 5614.6 5623.8 5627.7 5660.7 3523.7 3978.4 4085.1 4241.9 4285.5 3808.2 3841.6 3899.9 3983.1 4276.1 4139.4 4157.3 4169.6 4185.3 4188.0 3812.5 3986.1 4136.9 4145.2 4196.4 3064.4 3576.6 3607.1 3613.1 3629.2 4188.8 5298.8 5464.6 5488.7 5520.5 4008.4 4393.4 4755.5 4814.6 4851.6 4849.6 4979.7 5712.9 5988.7 6011.5 3619.3 3776.2 3938.9 3946.2 3989.5 5348.5 6255.4 6275.9 6302.5 6325.9 3032.0 3187.7 3659.4 3666.9 3850.7 3701.4 3836.0 3843.0 4075.2 4086.7 4445.9 4562.1 4784.9 4788.4 4844.4 4738.5 5703.6 5808.9 5962.6 5984.6 1277.2 1277.7 1303.5 1377.8 1389.4 782.5 807.9 870.5 900.6 923.8 5532.0 5552.8 5552.8 5558.7 5634.6 5520.9 5668.7 5727.8 6046.8 6089.4 4692.1 5089.9 5322.0 5453.9 5470.6 2285.6 2633.1 2672.5 2674.8 2719.4 4689.8 4817.0 5191.8 5279.4 5300.4 4267.0 5251.4 5625.4 5742.1 6353.7 5376.5 5572.1 5572.2 6116.4 6369.2 5280.8 5800.8 6161.4 6193.4 6282.4 5981.8 6004.2 6040.6 6060.9 6087.3 5529.6 6361.5 6376.7 6408.2 6464.1 3867.5 3905.5 3977.2 3992.0 4043.1 4783.3 5878.6 6065.8 6080.4 6146.8 5148.7 5620.7 5959.9 5967.0 5999.0 4520.3 4634.9 4964.9 5409.3 5911.1 5499.5 5774.5 5799.4 5803.7 5817.0 5694.5 5849.2 5929.8 5980.4 5998.3 4638.6 5147.0 5190.7 5717.3 5804.6 13:11:30 INFO - PROCESS | 1666 | 13:11:30 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:25841.38 Median:3883.18 stddev:43141.47 (1111.0%) stddev-sans-first:43221.06 13:11:30 INFO - PROCESS | 1666 | Values: 659.5 690.8 704.3 713.7 821.2 12151.9 15686.9 16046.2 16211.6 16253.3 14774.5 14892.3 14935.2 14944.2 14945.6 846.2 859.1 862.9 864.3 864.9 687.5 854.4 876.0 882.5 889.8 873.4 906.2 917.6 918.5 919.4 891.5 910.3 911.4 911.7 915.5 669.5 679.3 680.9 682.9 684.4 15126.7 15156.6 15169.2 15208.8 15215.1 14559.3 14692.3 14721.9 14798.6 14899.5 11819.7 12034.7 12061.3 12065.5 12319.9 3782.1 3832.7 3842.7 3945.6 3949.4 97395.0 126730.4 128396.9 129282.4 129557.0 9466.9 9482.9 9629.7 9782.8 9906.6 22423.6 22452.3 22578.8 22685.2 22716.5 8000.0 8037.3 8162.4 8193.6 8283.4 4450.0 4463.4 4511.5 4521.2 4594.8 3156.7 3583.5 3720.1 3726.2 3744.6 640.5 652.1 677.5 678.8 679.8 644.8 655.8 659.4 664.9 665.8 9081.1 9228.3 9380.1 9659.2 9681.6 617.5 635.3 661.7 663.2 705.3 3923.7 4140.8 4614.6 4700.4 4700.9 109741.0 150962.2 173193.0 173950.0 176920.0 118796.4 122004.0 148667.0 150959.0 154152.0 128445.0 128805.0 129292.0 129429.4 133856.0 6997.1 8434.7 8668.4 8992.8 9264.6 36284.0 36284.8 53410.9 59905.1 60741.8 86318.6 89232.0 89903.0 92776.5 94692.0 10584.4 12937.1 13151.7 13207.3 13257.6 12694.2 14396.1 14837.8 14954.0 15219.3 10822.5 13195.5 13263.5 13373.9 13440.5 13593.7 13720.3 13752.4 14036.6 14059.8 13423.6 13463.2 13811.2 14121.6 14273.6 9775.4 9929.5 10564.3 11007.1 11435.2 8797.5 10333.3 10531.5 11578.9 11583.8 13:11:30 INFO - PROCESS | 1666 | -------- Summary: end -------- 13:11:30 INFO - PROCESS | 1666 | 13:11:30 INFO - TEST-INFO | 1666: exit 0 13:11:30 INFO - TEST-OK | dromaeo_css | took 1114854ms 13:11:30 INFO - TEST-START | kraken 13:11:30 INFO - operating with platform_type : mac_ 13:11:30 INFO - Initialising browser for kraken test... 13:11:30 INFO - TEST-INFO | started process 1789 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpiVvB3x/profile http://localhost:49267/getInfo.html) 13:11:33 INFO - PROCESS | 1789 | __metrics Screen width/height:1600/1200 13:11:33 INFO - PROCESS | 1789 | colorDepth:24 13:11:33 INFO - PROCESS | 1789 | Browser inner width/height: 1024/689 13:11:33 INFO - PROCESS | 1789 | __metrics 13:11:33 ERROR - PROCESS | 1789 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 13:11:34 INFO - TEST-INFO | 1789: exit 0 13:11:34 INFO - Browser initialized. 13:11:34 INFO - Running cycle 1/1 for kraken test... 13:11:34 INFO - TEST-INFO | started process 1791 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpiVvB3x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:11:46 INFO - PROCESS | 1791 | RSS: Main: 245534720 13:11:46 INFO - PROCESS | 1791 | 13:11:49 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 13:11:50 INFO - PROCESS | 1791 | RSS: Main: 257961984 13:11:50 INFO - PROCESS | 1791 | 13:11:53 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 13:11:53 INFO - PROCESS | 1791 | RSS: Main: 266739712 13:11:53 INFO - PROCESS | 1791 | 13:11:56 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 13:11:57 INFO - PROCESS | 1791 | RSS: Main: 265502720 13:11:57 INFO - PROCESS | 1791 | 13:11:59 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 13:12:00 INFO - PROCESS | 1791 | RSS: Main: 267984896 13:12:00 INFO - PROCESS | 1791 | 13:12:02 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:12:02 INFO - PROCESS | 1791 | RSS: Main: 268369920 13:12:02 INFO - PROCESS | 1791 | 13:12:05 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 13:12:06 INFO - PROCESS | 1791 | RSS: Main: 269402112 13:12:06 INFO - PROCESS | 1791 | 13:12:09 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 13:12:10 INFO - PROCESS | 1791 | RSS: Main: 269832192 13:12:10 INFO - PROCESS | 1791 | 13:12:13 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 13:12:13 INFO - PROCESS | 1791 | RSS: Main: 270123008 13:12:13 INFO - PROCESS | 1791 | 13:12:15 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:12:16 INFO - PROCESS | 1791 | RSS: Main: 269475840 13:12:16 INFO - PROCESS | 1791 | 13:12:17 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:12:18 INFO - PROCESS | 1791 | RSS: Main: 269041664 13:12:18 INFO - PROCESS | 1791 | 13:12:20 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:12:21 INFO - PROCESS | 1791 | RSS: Main: 269324288 13:12:21 INFO - PROCESS | 1791 | 13:12:24 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:12:25 INFO - PROCESS | 1791 | RSS: Main: 269746176 13:12:25 INFO - PROCESS | 1791 | 13:12:28 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:12:28 INFO - PROCESS | 1791 | RSS: Main: 269660160 13:12:28 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 13:12:30 INFO - PROCESS | 1791 | RSS: Main: 271421440 13:12:30 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | __start_tp_report 13:12:30 INFO - PROCESS | 1791 | _x_x_mozilla_page_load 13:12:30 INFO - PROCESS | 1791 | _x_x_mozilla_page_load_details 13:12:30 INFO - PROCESS | 1791 | |i|pagename|runs| 13:12:30 INFO - PROCESS | 1791 | |0;ai-astar;116;117;99;164;113;147;171;169;115;115 13:12:30 INFO - PROCESS | 1791 | |1;audio-beat-detection;145;110;133;169;142;145;132;116;201;120 13:12:30 INFO - PROCESS | 1791 | |2;audio-dft;192;205;208;211;194;196;195;194;200;196 13:12:30 INFO - PROCESS | 1791 | |3;audio-fft;68;83;77;140;60;58;61;63;133;61 13:12:30 INFO - PROCESS | 1791 | |4;audio-oscillator;70;72;117;72;69;75;114;71;103;108 13:12:30 INFO - PROCESS | 1791 | |5;imaging-gaussian-blur;109;133;89;86;77;127;108;132;132;112 13:12:30 INFO - PROCESS | 1791 | |6;imaging-darkroom;124;109;100;92;127;155;111;104;153;103 13:12:30 INFO - PROCESS | 1791 | |7;imaging-desaturate;91;94;88;90;95;132;117;75;150;149 13:12:30 INFO - PROCESS | 1791 | |8;json-parse-financial;55;60;59;57;57;60;57;57;57;58 13:12:30 INFO - PROCESS | 1791 | |9;json-stringify-tinderbox;66;71;71;74;76;84;75;71;69;73 13:12:30 INFO - PROCESS | 1791 | |10;stanford-crypto-aes;92;111;117;104;88;88;89;84;84;88 13:12:30 INFO - PROCESS | 1791 | |11;stanford-crypto-ccm;145;156;156;160;159;157;163;139;183;164 13:12:30 INFO - PROCESS | 1791 | |12;stanford-crypto-pbkdf2;175;177;172;173;168;172;173;177;171;174 13:12:30 INFO - PROCESS | 1791 | |13;stanford-crypto-sha256-iterative;78;82;90;83;72;68;69;74;90;94 13:12:30 INFO - PROCESS | 1791 | __end_tp_report 13:12:30 INFO - PROCESS | 1791 | __start_cc_report 13:12:30 INFO - PROCESS | 1791 | _x_x_mozilla_cycle_collect,952 13:12:30 INFO - PROCESS | 1791 | __end_cc_report 13:12:30 INFO - PROCESS | 1791 | __startTimestamp1472760750884__endTimestamp 13:12:30 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | ------- Summary: start ------- 13:12:30 INFO - PROCESS | 1791 | Number of tests: 14 13:12:30 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | [#0] ai-astar Cycles:10 Average:132.60 Median:155.50 stddev:27.17 (17.5%) stddev-sans-first:28.15 13:12:30 INFO - PROCESS | 1791 | Values: 116.0 117.0 99.0 164.0 113.0 147.0 171.0 169.0 115.0 115.0 13:12:30 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:143.50 stddev:27.06 (18.9%) stddev-sans-first:28.66 13:12:30 INFO - PROCESS | 1791 | Values: 145.0 110.0 133.0 169.0 142.0 145.0 132.0 116.0 201.0 120.0 13:12:30 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | [#2] audio-dft Cycles:10 Average:199.10 Median:198.00 stddev:6.62 (3.3%) stddev-sans-first:6.51 13:12:30 INFO - PROCESS | 1791 | Values: 192.0 205.0 208.0 211.0 194.0 196.0 195.0 194.0 200.0 196.0 13:12:30 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | [#3] audio-fft Cycles:10 Average:80.40 Median:62.00 stddev:30.67 (49.5%) stddev-sans-first:32.20 13:12:30 INFO - PROCESS | 1791 | Values: 68.0 83.0 77.0 140.0 60.0 58.0 61.0 63.0 133.0 61.0 13:12:30 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | [#4] audio-oscillator Cycles:10 Average:87.10 Median:70.50 stddev:20.52 (29.1%) stddev-sans-first:20.81 13:12:30 INFO - PROCESS | 1791 | Values: 70.0 72.0 117.0 72.0 69.0 75.0 114.0 71.0 103.0 108.0 13:12:30 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:132.50 stddev:20.81 (15.7%) stddev-sans-first:22.07 13:12:30 INFO - PROCESS | 1791 | Values: 109.0 133.0 89.0 86.0 77.0 127.0 108.0 132.0 132.0 112.0 13:12:30 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | [#6] imaging-darkroom Cycles:10 Average:117.80 Median:125.50 stddev:21.76 (17.3%) stddev-sans-first:22.96 13:12:30 INFO - PROCESS | 1791 | Values: 124.0 109.0 100.0 92.0 127.0 155.0 111.0 104.0 153.0 103.0 13:12:30 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | [#7] imaging-desaturate Cycles:10 Average:108.10 Median:89.00 stddev:27.02 (30.4%) stddev-sans-first:27.94 13:12:30 INFO - PROCESS | 1791 | Values: 91.0 94.0 88.0 90.0 95.0 132.0 117.0 75.0 150.0 149.0 13:12:30 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.50 stddev:1.57 (2.7%) stddev-sans-first:1.32 13:12:30 INFO - PROCESS | 1791 | Values: 55.0 60.0 59.0 57.0 57.0 60.0 57.0 57.0 57.0 58.0 13:12:30 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | [#9] json-stringify-tinderbox Cycles:10 Average:73.00 Median:73.50 stddev:4.85 (6.6%) stddev-sans-first:4.44 13:12:30 INFO - PROCESS | 1791 | Values: 66.0 71.0 71.0 74.0 76.0 84.0 75.0 71.0 69.0 73.0 13:12:30 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | [#10] stanford-crypto-aes Cycles:10 Average:94.50 Median:88.00 stddev:11.80 (13.4%) stddev-sans-first:12.48 13:12:30 INFO - PROCESS | 1791 | Values: 92.0 111.0 117.0 104.0 88.0 88.0 89.0 84.0 84.0 88.0 13:12:30 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | [#11] stanford-crypto-ccm Cycles:10 Average:158.20 Median:159.50 stddev:11.69 (7.3%) stddev-sans-first:11.38 13:12:30 INFO - PROCESS | 1791 | Values: 145.0 156.0 156.0 160.0 159.0 157.0 163.0 139.0 183.0 164.0 13:12:30 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:173.50 stddev:2.74 (1.6%) stddev-sans-first:2.83 13:12:30 INFO - PROCESS | 1791 | Values: 175.0 177.0 172.0 173.0 168.0 172.0 173.0 177.0 171.0 174.0 13:12:30 INFO - PROCESS | 1791 | 13:12:30 INFO - PROCESS | 1791 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.00 Median:82.50 stddev:9.30 (11.3%) stddev-sans-first:9.83 13:12:30 INFO - PROCESS | 1791 | Values: 78.0 82.0 90.0 83.0 72.0 68.0 69.0 74.0 90.0 94.0 13:12:30 INFO - PROCESS | 1791 | -------- Summary: end -------- 13:12:30 INFO - PROCESS | 1791 | 13:12:31 INFO - TEST-INFO | 1791: exit 0 13:12:31 INFO - TEST-OK | kraken | took 60961ms 13:12:31 INFO - SUITE-END | took 1175s 13:12:32 INFO - Completed test suite (00:19:36) 13:12:32 INFO - javascript benchmark 13:12:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7361.489481836092, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2713.294543418711, 3446.74149438792, 3467.774594651349, 3471.2883858808937, 3506.6493350664937, 5783.5951483396175, 5857.941420585798, 5875.471207591316, 5911.793087241947, 5959.225300710901, 5701.173329867167, 5894.997850365437, 5906.793262235823, 5987.40125987401, 6036.517078633709, 5265.65773224741, 5311.521963023327, 5411.485908838654, 5439.238506609078, 5467.562594992411, 5347.946520534803, 5487.6981766002855, 5489.231507588941, 5512.0, 5518.475744804237, 4061.390791381287, 4242.448481697391, 5272.156454967225, 5381.784728610851, 5445.9727701361435, 5232.110541208004, 5234.97382513085, 5283.28675628789, 5324.680519168824, 5418.647787893774, 4309.504406993205, 4838.540338667821, 5015.498450154992, 5247.16045432729, 5259.2899958505495, 4872.878178045542, 5102.413222479426, 5383.865403364908, 5793.913091303634, 5835.328937172195, 5031.974840125776, 5607.523360514361, 6034.215551978258, 6296.401841825065, 6338.0, 6339.746410143634, 6385.138006369127, 6390.233172019341, 6397.744090236385, 6403.967980160116, 5785.739641716175, 5987.2815262168815, 6031.0, 6052.515798736091, 6076.939230607682, 6486.318936511692, 6491.967540162269, 6499.8700025999215, 6518.967405162944, 6523.64119973406, 6305.747770089145, 6305.873882522324, 6350.110984462179, 6353.555251132469, 6372.872542549216, 6254.874902502015, 6263.217097862767, 6292.685365731695, 6312.400321969406, 6364.649944253018, 6215.471684906744, 6286.937130628727, 6330.208723909512, 6335.524835637253, 6354.983202687547, 6012.158297838306, 6260.373962603703, 6294.590851594632, 6296.5592408530965, 6321.304656487782, 4889.2910527973245, 4911.18965370717, 4940.530649588283, 5062.962092770973, 5070.391553013662, 4356.215881141362, 4397.1205758848355, 4416.977915110404, 4475.283954567253, 4477.417935668343, 5513.0, 5850.9414905851245, 5869.0, 5893.499052580493, 5918.674472904032, 6224.564280500412, 6272.5922815016875, 6286.465650419766, 6305.747770089145, 6330.715117819709, 6070.453659170696, 6123.374132580074, 6128.811800681408, 6129.14485165794, 6135.998322733915, 5589.413111623302, 5598.97200514003, 5620.4660557247, 5621.80323688669, 5626.24045753818, 6364.64994425311, 6464.22429308486, 6590.901136482957, 6602.735890564323, 6621.735130594819, 5563.833085007456, 5594.440555944373, 6336.619802811846, 6382.68086595659, 6397.96801015992, 6535.836604084936, 6544.5418820684, 6608.7356505739235, 6623.569467984566, 6647.634380109141, 5751.971240143773, 6215.912215362384, 6231.3145553988115, 6235.0, 6356.618602883842, 4969.875753106201, 6041.365656606169, 6282.1519094921605, 6365.681715914278, 6419.646919419477, 6254.3745625437095, 6280.654563998841, 6292.339304372975, 6315.905261421174, 6329.841753956188, 6135.692037377249, 6142.437386315837, 6256.186695729526, 6284.748610055546, 6312.400321969406, 5100.775813804735, 6105.490073363178, 6115.908261376172, 6123.404636889863, 6218.502519798315, 5279.815206467755, 6275.278342990432, 6299.527535434952, 6305.653189074645, 6316.084167795736, 6084.8783024340155, 6109.266887973472, 6222.844428889314, 6234.532410069172, 6239.438450539473], "value": 5760.613442288043, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.4516169309527, 519.5687579309172, 521.0984995956996, 542.7245971965881, 572.5448268626442, 38272.61727382725, 40525.78422647322, 40598.0, 40617.7969110154, 40710.38934415983, 40417.78746637605, 40944.59055409445, 40970.0, 41173.58826411735, 41189.0, 9678.951605241964, 9797.706068817912, 9880.802383952318, 9897.703068907944, 9914.702558923207, 9749.658761943334, 9778.07108324708, 9904.95047524765, 9905.702828915108, 9925.106740393363, 9850.90149098507, 9857.802843943116, 9884.357516761387, 9906.20750339971, 9956.900430995669, 9781.217502599811, 9848.0, 9883.357581757235, 9888.505574721306, 9906.950465247699, 9797.657082002166, 9872.60509579616, 9876.703698888972, 9901.504924753734, 9919.603215871357, 39631.8018409909, 39946.60053399458, 40119.0, 40148.598514014775, 40155.19689606191, 3304.454764963778, 3356.1441832332844, 3381.4927760835826, 3542.1498840278405, 3847.1728578355787, 30327.24181895448, 30485.847570762227, 30691.693083069105, 30735.846320768476, 31917.882874099294, 3171.444997125494, 3225.8870939517237, 3240.4329242382487, 3248.951265731016, 3315.3037862049, 532043.0, 533363.0, 537598.0, 539354.0, 542739.999999996, 61541.07688384678, 61783.0, 61840.07239891405, 61909.0, 62324.0, 33742.8312858439, 34927.476087858704, 34937.65062349395, 64753.67623161854, 65256.02115968264, 16507.587310317096, 16670.916390434584, 16692.582685432717, 16698.415555455744, 16747.497575072768, 12717.55488557896, 12882.9355853222, 12887.226766394046, 12902.0, 12909.741805164032, 18964.52588685266, 19034.714479282822, 19038.381737552187, 19094.61810763805, 19151.52121196981, 7779.3776497880035, 7956.363490920712, 7990.9200907991335, 8014.839703205903, 8037.879431808527, 955.7037318431309, 961.8701475300885, 1017.9287449878437, 1026.7176526455285, 1049.632628579991, 24630.261092167264, 28928.0, 29763.0, 30447.695523044928, 30511.237219069702, 871.9825603487894, 1027.9486025698686, 1054.2514814481651, 1085.5386460754148, 1137.9487923043482, 14865.777013344808, 15562.455314063953, 15690.058596484247, 15782.053076815428, 15860.127692976766, 605814.0, 647772.0, 651310.0, 660158.0, 697365.0, 56875.71562142163, 56969.14546281809, 57129.714351427974, 57463.0, 57878.421215787304, 1188.8870557297216, 1328.7076843094696, 1364.201941864001, 1381.2886363522794, 1385.6397336692532, 29745.70254297516, 29773.702262977095, 29940.850295748383, 30238.54642180413, 30981.0, 49610.75973100701, 49618.751906240235, 49701.0, 49788.0, 49789.751051244515, 487763.0, 598945.0, 600524.0, 600608.0, 601420.8934329855, 26133.60799588046, 26366.73633263643, 26561.734382656698, 26629.20112396631, 26638.334041648337, 46878.06243875172, 46893.2966005517, 47228.58314250578, 47801.28298075462, 48356.0, 38358.80820595879, 38787.41818872776, 38869.61130388773, 39329.60670393259, 40174.397384038675, 29421.85289073541, 29597.852010739807, 35121.297574048884, 39749.0, 39929.00177495586, 32094.19764505906, 37562.06094847651, 38074.23851523009, 38596.0, 38838.0, 30960.845195773876, 33734.0, 33925.66074339225, 34198.0, 34345.96962091141, 21228.044737986518, 24319.392015199053, 24948.37629059288, 25080.122195723063, 25484.362890927874], "value": 19912.348120242023, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.8740503798481, 374.5374462538765, 378.39079082676886, 388.4076782906066, 404.6014675544588, 18071.548211294725, 19265.133069011892, 20351.694724579123, 20389.431849426328, 20579.38261852143, 19952.70070948937, 20315.898420507878, 20317.59364812703, 20347.491312717153, 20916.8954155229, 5909.143174239754, 5926.081457374103, 6116.908246376308, 6173.012318029117, 6179.351168127349, 6070.1501789749245, 6142.785002524913, 6152.323244443108, 6173.444390004921, 6183.19618449601, 5600.915986260209, 5868.501177399926, 5946.316173640022, 6050.667213303266, 6109.5723299369065, 5903.822885313426, 5911.852203694899, 5939.0, 5942.3760505146765, 5961.940380596182, 5612.326520817487, 5818.912716309259, 5835.533157347402, 5875.089361148986, 5890.322612899528, 12881.291528965903, 12906.612801615967, 12992.805107923388, 13054.412551435209, 13149.21104733719, 2130.957380852374, 2176.978230217709, 2205.7794220577975, 2223.944401389962, 2912.4757543642136, 9804.31369804114, 9821.852672209923, 9896.960819113961, 10298.948505257425, 10342.689719308433, 1830.8443782278523, 1877.239717914247, 1913.8038725796378, 1938.3118992757509, 1938.505681051337, 114879.0, 119355.0, 122675.0, 123119.0, 126825.0, 11225.326480411202, 11268.028095083328, 11590.536378544764, 11671.708207294885, 11728.589499367652, 14067.507637232853, 14339.211343376215, 14342.139471631526, 14348.995570309979, 14375.496857609933, 8063.637136328879, 8365.1216622255, 8502.957485212659, 8587.742367728979, 8620.181082797124, 7076.575405475688, 8593.44142630727, 8603.741887743377, 8752.912470875337, 8765.912340876637, 3550.9644903551152, 4401.6478681705385, 4498.325251212279, 4512.842050528216, 4543.931841022388, 1891.1584344966634, 1901.4580844459263, 1920.7995003123049, 1952.248384372027, 1954.6188493243965, 634.4448607468465, 817.689278074328, 858.356232825381, 900.4057322167469, 917.6879860847343, 16589.585260368345, 19192.808071919382, 20473.692894606593, 21278.78721212768, 21412.464688382915, 899.6221586933503, 945.664289177346, 975.2393133355852, 980.666573365045, 1019.8317277649253, 9353.485558294224, 10839.187060970458, 11291.322520648788, 11322.37726925027, 11330.206885518099, 572539.1373043108, 574692.0, 578405.0, 585581.0720946369, 585633.0, 96276.55585166228, 121498.0, 124519.0, 130135.34932325468, 133131.0, 832.1595188859175, 938.432248489654, 979.4808751361932, 989.4557993103764, 994.7068810546261, 18199.999000055122, 18585.535361615526, 18626.0, 18666.533336666693, 18828.905855470635, 38506.422403663404, 49821.754456138886, 52322.476775231764, 56036.719816402285, 56255.0, 81350.59324703338, 81828.59085704772, 82094.0, 83565.0, 84074.0, 7186.993820865187, 7816.140224575406, 8010.799730006564, 8017.797330400486, 8107.351411887153, 9261.490618016074, 12593.874061259638, 12817.807732883828, 12930.935345323212, 13029.934850325688, 9075.909240907771, 10867.424223487393, 11027.889721103007, 11313.490892909675, 11346.149038822286, 10446.843297350393, 10676.252662313564, 10811.729706757395, 10978.560857565928, 11116.11071114325, 11344.9432752839, 11516.884831151916, 11533.366989398313, 11603.419829008684, 11618.70953226176, 7996.24035716606, 8063.596820159086, 8084.989376327959, 8165.877511837446, 8210.794730131794, 8318.584070796556, 11353.48909299067, 11590.246633968765, 11777.175597708077, 11831.881681183422], "value": 9309.373380524177, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1511.2066165263238, 1546.8607825295721, 1588.3884704388806, 1767.964640707186, 1901.591157901051, 8068.475549089319, 8651.351148663853, 8707.259882909944, 9159.862602060974, 9174.678886238982, 8648.091950345217, 8828.161324674145, 8836.823263534725, 8848.469091854493, 8876.245519130865, 2316.652502124682, 2337.8947947342413, 2353.9411514712097, 2357.669926210332, 2359.421941624296, 2331.277304035746, 2388.3312672451743, 2413.794827439661, 2414.0223209600053, 2417.0331867253153, 2309.261036468331, 2356.7643235676464, 2360.634101714237, 2375.7861792438675, 2403.134871446278, 2348.6829278047417, 2363.6572696959015, 2374.966889403115, 2385.0936644075314, 2389.1757343716304, 2361.5513052520137, 2368.6683864259016, 2378.3340664613934, 2383.547126046046, 2384.940376490584, 8929.508877011762, 8986.640534378617, 8986.955065224698, 8991.55042247885, 9005.50469724165, 4187.72779769314, 4838.564529192389, 5324.174752913266, 5415.350157981028, 5431.701256430894, 3055.4041961817456, 3621.442779604769, 3666.9083272918124, 3697.2235830475634, 3701.167237371597, 899.3524662243175, 958.9232861371073, 1057.3972835483778, 1076.6716151573767, 1108.661858133269, 8643.0, 11053.502592383362, 11476.655700329004, 11785.410729463492, 11799.705007374885, 4583.793729282191, 4714.882127946828, 4789.066132104206, 4844.079624871263, 4852.393450818648, 9887.209023278265, 9895.406275623485, 10006.849897251546, 10050.899491005142, 10061.597536098621, 5381.461853814587, 5385.272988146628, 5391.110466773017, 5404.594655400861, 5408.432114627907, 4440.4227450431235, 4743.335932969387, 4849.248366503198, 4905.362302900671, 4970.3290055842, 3324.634290228073, 3385.9661403386144, 3842.51968503937, 3948.565657777642, 4041.515018197835, 1248.1637303007008, 1293.4502836294537, 1300.694336830844, 1300.7918733002675, 1304.5108084468325, 747.2228881962807, 857.3098655582191, 891.2647066170435, 907.4918045894188, 943.0428115462811, 5733.168690539848, 5750.913736293959, 5778.162166485836, 5804.6807425592, 6031.185789918392, 895.9462432254086, 917.2249449215402, 938.4088024544493, 940.3605548227134, 942.6983365323031, 3351.9832400838327, 3819.427085937132, 3838.865639702597, 3859.2474467478573, 3951.308521008812, 10625.415602141802, 10719.0, 10948.945255273673, 10984.835227471594, 11008.724781880517, 10362.637307694195, 10787.514561844735, 10827.566897324177, 10871.402072885909, 10958.671239862817, 8121.309688676529, 8385.748427547062, 8393.95803020981, 8402.495850249004, 8412.495250285003, 5384.757685904222, 5854.677992710442, 5892.734826932884, 5997.16039754426, 6027.909581356195, 10004.049615286536, 10234.0, 10245.129164021142, 10253.33353332031, 10299.948500257451, 8597.226249637562, 10324.48377581103, 10403.739906502398, 10516.789664206826, 10523.526441310312, 6041.818745437644, 7357.448191385561, 7561.09266887977, 7571.432142589218, 7713.382929365525, 8363.372747043873, 8425.115362886809, 8479.109693482096, 8525.616347264264, 8564.871526926976, 7404.740834070782, 7415.0, 7565.356944659766, 7656.042994625672, 7673.577953212627, 7302.0, 7463.701451941862, 7470.551766894004, 7558.093028836574, 7637.541747495168, 6984.825379365353, 7118.0, 7118.60847653384, 7126.964365178348, 7128.786136415708, 4800.831970881002, 4863.197572400656, 4907.312976183266, 4979.228219625964, 4994.850154495371, 4880.414350277847, 4940.92588611164, 5052.393712754346, 5124.666896651705, 5146.330976972969], "value": 4582.840668426344, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.0796844712202, 303.29332654914055, 310.4969948683133, 312.67794172002846, 323.3500663666031, 4063.7358571692857, 4511.932321015187, 4559.703619264746, 5050.46970068143, 5403.2705584746045, 5145.871353216162, 5614.613789139609, 5623.775048998045, 5627.7467513961865, 5660.688662123592, 3523.682868541831, 3978.4430179774854, 4085.142120154771, 4241.851535196269, 4285.528591854902, 3808.219315040424, 3841.5966323535904, 3899.902502437433, 3983.063979964706, 4276.059266961263, 4139.3997870308785, 4157.334826427772, 4169.62473377396, 4185.330347144458, 4188.0, 3812.4853144825647, 3986.063275130342, 4136.855210067648, 4145.176122506087, 4196.426340122454, 3064.356485138124, 3576.6423357664285, 3607.1162565171703, 3613.1328481164596, 3629.1834337273904, 4188.832446702128, 5298.761555730001, 5464.617476776588, 5488.670679759227, 5520.537057679718, 4008.398740188966, 4393.406890069831, 4755.548222918817, 4814.592703648176, 4851.587615052725, 4849.587785038276, 4979.651424400294, 5712.914306285409, 5988.670623115727, 6011.489023433013, 3619.3170175868086, 3776.169242766587, 3938.8971088095377, 3946.1515774108416, 3989.5412027616617, 5348.53967175096, 6255.437010669016, 6275.901717199472, 6302.46429053531, 6325.905111423286, 3032.0, 3187.6812318768402, 3659.408157451517, 3666.944995825065, 3850.729259344466, 3701.4262789267705, 3836.0, 3843.0, 4075.2053349596545, 4086.7139300248696, 4445.866624001285, 4562.133194692998, 4784.9233922367885, 4788.449328327218, 4844.432450801081, 4738.502457242009, 5703.600747947687, 5808.941910580925, 5962.612430192024, 5984.581079324405, 1277.2145130744711, 1277.7252890628558, 1303.5176984515601, 1377.8415482219673, 1389.4025569005425, 782.4718315137374, 807.894973653433, 870.5038128266954, 900.6487469886749, 923.819855128257, 5531.972340138354, 5552.7778888844805, 5552.805651802168, 5558.72149405639, 5634.60557760961, 5520.861978450491, 5668.744906479218, 5727.770889164387, 6046.788362407295, 6089.442434177656, 4692.058670716615, 5089.88263259541, 5322.042032434199, 5453.918191227135, 5470.56235501159, 2285.622872226064, 2633.117321115373, 2672.492226476963, 2674.8127631066027, 2719.442514284567, 4689.780657029197, 4816.95183048165, 5191.818286360035, 5279.442564443499, 5300.416954135042, 4267.0, 5251.36983561975, 5625.38120806711, 5742.138679198154, 6353.682315884187, 5376.489233522809, 5572.08060669993, 5572.247746554325, 6116.3883611638485, 6369.172007638977, 5280.81517146898, 5800.796972105956, 6161.44546990773, 6193.389718673267, 6282.403171698681, 5981.760729570942, 6004.1687285378375, 6040.607360521552, 6060.90908636362, 6087.269527656709, 5529.612927095065, 6361.491080713439, 6376.681165941592, 6408.166938297992, 6464.0607817655455, 3867.5358956925347, 3905.5159039564783, 3977.164795393, 3992.0419099416513, 4043.130726893732, 4783.282507623745, 5878.559108066997, 6065.7573697053385, 6080.3615620361, 6146.78486252979, 5148.6910785353, 5620.74706638194, 5959.91060134107, 5967.045272756338, 5999.0, 4520.254158063883, 4634.933965188093, 4964.925526117184, 5409.29679141709, 5911.054231322968, 5499.532539734168, 5774.509166720875, 5799.449052340021, 5803.651780892991, 5816.970915145397, 5694.487496125369, 5849.239598852292, 5929.762809487572, 5980.37206093354, 5998.310194327708, 4638.605718513964, 5146.989011428356, 5190.688558686491, 5717.342505611908, 5804.622699524517], "value": 4148.929835676651, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.5383231737785, 690.7893092606755, 704.3238491048593, 713.7180813578636, 821.1542111625026, 12151.878481215184, 15686.921565392156, 16046.197690115478, 16211.594710132224, 16253.349866005361, 14774.482893098744, 14892.255387230622, 14935.178565178938, 14944.178070206135, 14945.626359341022, 846.238385453091, 859.0764927702713, 862.8576284913013, 864.3128712673408, 864.9264812490945, 687.4569090418588, 854.4232642965973, 875.995620021899, 882.5234373438335, 889.7997950461126, 873.4191762477944, 906.2206502407923, 917.591671706091, 918.536139249678, 919.429953428875, 891.5319457284912, 910.3218102513637, 911.4440191483224, 911.6535716427782, 915.4553040940697, 669.4945316286221, 679.2935347238865, 680.8910574308087, 682.8566001139767, 684.4319215051495, 15126.697466050728, 15156.621084472867, 15169.24153792306, 15208.847911520854, 15215.087094774239, 14559.3448294827, 14692.26538673062, 14721.852781472262, 14798.556043318718, 14899.478518251917, 11819.704507387298, 12034.69913252167, 12061.276323420623, 12065.517379304818, 12319.93840030803, 3782.1490164712995, 3832.7317087803863, 3842.692584593226, 3945.6448919597374, 3949.3681011038384, 97395.0, 126730.3663481686, 128396.88856005915, 129282.35358823146, 129557.0, 9466.857997130048, 9482.882392256823, 9629.711108666752, 9782.75543111428, 9906.55420506079, 22423.55152896933, 22452.32643020712, 22578.774212257667, 22685.2060177893, 22716.545669086856, 8000.039995200613, 8037.276645101969, 8162.428629995962, 8193.631286592117, 8283.37874659403, 4449.955500444954, 4463.4420697412825, 4511.458624965026, 4521.163584736834, 4594.839180628729, 3156.71589556941, 3583.480395342661, 3720.1443667956523, 3726.1802403471193, 3744.625537446288, 640.5420124610926, 652.1489456259627, 677.478341676906, 678.7556479667315, 679.7858674517511, 644.7549931026274, 655.8360409897525, 659.3604203922188, 664.8836453620597, 665.8435267712084, 9081.091890810998, 9228.307876909259, 9380.108889655472, 9659.227261819038, 9681.612735490642, 617.4837537036594, 635.3487675132933, 661.6956200147889, 663.2041550139852, 705.340506626306, 3923.665953575798, 4140.834366625301, 4614.630829533629, 4700.435947686231, 4700.858974230779, 109741.0, 150962.24518877335, 173193.0, 173950.0, 176920.0, 118796.40601796936, 122004.0, 148667.0, 150959.0, 154152.0, 128445.0, 128805.0, 129292.0, 129429.35285323701, 133856.0, 6997.113566238597, 8434.662613495391, 8668.436551624125, 8992.775180620536, 9264.629414823332, 36284.0, 36284.81857590801, 53410.93178136493, 59905.10142347955, 60741.78516429558, 86318.56840715757, 89232.0, 89903.0, 92776.53611731899, 94692.0, 10584.417857017937, 12937.148082437529, 13151.736965260832, 13207.339633018502, 13257.602271931857, 12694.238345699288, 14396.064255823338, 14837.84363725285, 14954.0, 15219.315130818919, 10822.51298691545, 13195.538156164488, 13263.535776247785, 13373.866261337262, 13440.529581464993, 13593.660158496117, 13720.313984300945, 13752.381142848795, 14036.578902632937, 14059.789103163665, 13423.597292081253, 13463.192208467523, 13811.240381779098, 14121.646958826112, 14273.57179284623, 9775.364601300893, 9929.453880036379, 10564.260501764802, 11007.065548704266, 11435.199536032398, 8797.47215167092, 10333.328333658288, 10531.473426328806, 11578.94210528942, 11583.8262426062], "value": 7837.308551132663, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1613.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 99.0, 164.0, 113.0, 147.0, 171.0, 169.0, 115.0, 115.0], "value": 132.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 133.0, 169.0, 142.0, 145.0, 132.0, 116.0, 201.0, 120.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 205.0, 208.0, 211.0, 194.0, 196.0, 195.0, 194.0, 200.0, 196.0], "value": 199.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 83.0, 77.0, 140.0, 60.0, 58.0, 61.0, 63.0, 133.0, 61.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 117.0, 72.0, 69.0, 75.0, 114.0, 71.0, 103.0, 108.0], "value": 87.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 133.0, 89.0, 86.0, 77.0, 127.0, 108.0, 132.0, 132.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 109.0, 100.0, 92.0, 127.0, 155.0, 111.0, 104.0, 153.0, 103.0], "value": 117.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 88.0, 90.0, 95.0, 132.0, 117.0, 75.0, 150.0, 149.0], "value": 108.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 60.0, 59.0, 57.0, 57.0, 60.0, 57.0, 57.0, 57.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 71.0, 74.0, 76.0, 84.0, 75.0, 71.0, 69.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 111.0, 117.0, 104.0, 88.0, 88.0, 89.0, 84.0, 84.0, 88.0], "value": 94.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 156.0, 156.0, 160.0, 159.0, 157.0, 163.0, 139.0, 183.0, 164.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 177.0, 172.0, 173.0, 168.0, 172.0, 173.0, 177.0, 171.0, 174.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 90.0, 83.0, 72.0, 68.0, 69.0, 74.0, 90.0, 94.0], "value": 80.0, "unit": "score"}]}]} 13:12:32 INFO - Return code: 0 13:12:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:12:32 ERROR - # TBPL SUCCESS # 13:12:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:12:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:12:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:12:32 INFO - 2016-09-01 13:12:32.201 screenresolution[1802:10597] starting screenresolution argv=screenresolution get 13:12:32 INFO - 2016-09-01 13:12:32.204 screenresolution[1802:10597] Display 0: 1600x1200x32@60 13:12:32 INFO - 2016-09-01 13:12:32.209 screenresolution[1803:10600] starting screenresolution argv=screenresolution list 13:12:32 INFO - Available Modes on Display 0 13:12:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:12:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:12:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:12:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:12:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:12:32 INFO - Intel Iris: 13:12:32 INFO - Chipset Model: Intel Iris 13:12:32 INFO - Type: GPU 13:12:32 INFO - Bus: Built-In 13:12:32 INFO - VRAM (Dynamic, Max): 1536 MB 13:12:32 INFO - Vendor: Intel (0x8086) 13:12:32 INFO - Device ID: 0x0a2e 13:12:32 INFO - Revision ID: 0x0009 13:12:32 INFO - Displays: 13:12:32 INFO - Display: 13:12:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:12:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:12:32 INFO - Display Serial Number: 1600x1200 60 13:12:32 INFO - Main Display: Yes 13:12:32 INFO - Mirror: Off 13:12:32 INFO - Online: Yes 13:12:32 INFO - Rotation: Supported 13:12:32 INFO - Return code: 0 13:12:32 INFO - Running post-action listener: _resource_record_post_action 13:12:32 INFO - [mozharness: 2016-09-01 20:12:32.445852Z] Finished run-tests step (success) 13:12:32 INFO - Running post-run listener: _resource_record_post_run 13:12:32 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37180416; Write bytes: 707759616; Read time: 239; Write time: 2052 13:12:32 INFO - TinderboxPrint: CPU usage
54.4% 13:12:32 INFO - TinderboxPrint: I/O read bytes / time
37,180,416 / 239 13:12:32 INFO - TinderboxPrint: I/O write bytes / time
707,759,616 / 2,052 13:12:32 INFO - TinderboxPrint: CPU idle
2,205.5 (45.6%) 13:12:32 INFO - TinderboxPrint: CPU system
981.6 (20.3%) 13:12:32 INFO - TinderboxPrint: CPU user
1,654.5 (34.2%) 13:12:32 INFO - TinderboxPrint: Swap in / out
443,514,880 / 0 13:12:32 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 405166592; Write bytes: 399321088; Read time: 29715; Write time: 823 13:12:32 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 34427904; Write bytes: 297690624; Read time: 214; Write time: 1196 13:12:32 INFO - Running post-run listener: _upload_blobber_files 13:12:32 INFO - Blob upload gear active. 13:12:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:12:32 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 13:12:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:12:33 INFO - (blobuploader) - INFO - Open directory for files ... 13:12:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:12:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:12:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:12:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:12:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:12:34 INFO - (blobuploader) - INFO - Done attempting. 13:12:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:12:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:12:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:12:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:12:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:12:35 INFO - (blobuploader) - INFO - Done attempting. 13:12:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:12:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:12:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:12:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:12:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:12:38 INFO - (blobuploader) - INFO - Done attempting. 13:12:38 INFO - (blobuploader) - INFO - Iteration through files over. 13:12:38 INFO - Return code: 0 13:12:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:12:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:12:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6b28ea124b4202240ff06133fcfe12bce62015e32c6ca23dc6da47e1e9e6dcc186a5f54796c9f199337a2a7ec5d393a10073ab62689c45679056a8a45c100b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/49371183b54cffaf032f99d9a6198b02f420a69ab9625405deed4f1bf094ea776f336c7457c89b2d5e098b23eed6e4116efaf1365b324e377cabfe39bbab8e03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f91f70dd424827639405ecd3200cf703574b09a6dddcb9beaabcc91b4816f61a004b75830e7add8360ccf7ab92fad623be2800f979d82d32d918cb4ab0992080"} 13:12:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:12:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:12:38 INFO - Contents: 13:12:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6b28ea124b4202240ff06133fcfe12bce62015e32c6ca23dc6da47e1e9e6dcc186a5f54796c9f199337a2a7ec5d393a10073ab62689c45679056a8a45c100b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/49371183b54cffaf032f99d9a6198b02f420a69ab9625405deed4f1bf094ea776f336c7457c89b2d5e098b23eed6e4116efaf1365b324e377cabfe39bbab8e03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f91f70dd424827639405ecd3200cf703574b09a6dddcb9beaabcc91b4816f61a004b75830e7add8360ccf7ab92fad623be2800f979d82d32d918cb4ab0992080"} 13:12:38 INFO - Running post-run listener: copy_logs_to_upload_dir 13:12:38 INFO - Copying logs to upload dir... 13:12:38 INFO - mkdir: /builds/slave/test/build/upload/logs 13:12:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.394205 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-01 13:12:38.378006) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 13:12:38.381661) ========= 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.sgFXZ9PmRv/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.9qEkaNJJg7/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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/Autoland/sha512/6b28ea124b4202240ff06133fcfe12bce62015e32c6ca23dc6da47e1e9e6dcc186a5f54796c9f199337a2a7ec5d393a10073ab62689c45679056a8a45c100b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/49371183b54cffaf032f99d9a6198b02f420a69ab9625405deed4f1bf094ea776f336c7457c89b2d5e098b23eed6e4116efaf1365b324e377cabfe39bbab8e03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f91f70dd424827639405ecd3200cf703574b09a6dddcb9beaabcc91b4816f61a004b75830e7add8360ccf7ab92fad623be2800f979d82d32d918cb4ab0992080"} build_url:https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010880 build_url: 'https://queue.taskcluster.net/v1/task/Xoavsxg4TDeLWLqYa-Ew8g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6b28ea124b4202240ff06133fcfe12bce62015e32c6ca23dc6da47e1e9e6dcc186a5f54796c9f199337a2a7ec5d393a10073ab62689c45679056a8a45c100b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/49371183b54cffaf032f99d9a6198b02f420a69ab9625405deed4f1bf094ea776f336c7457c89b2d5e098b23eed6e4116efaf1365b324e377cabfe39bbab8e03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f91f70dd424827639405ecd3200cf703574b09a6dddcb9beaabcc91b4816f61a004b75830e7add8360ccf7ab92fad623be2800f979d82d32d918cb4ab0992080"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 13:12:38.418302) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 13:12:38.419022) ========= 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.sgFXZ9PmRv/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.9qEkaNJJg7/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.005054 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 13:12:38.469449) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 13:12:38.469802) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 13:12:38.470216) ========= ========= Total master_lag: 0.19 =========